-- Logs begin at Tue 2024-08-20 06:18:10 UTC, end at Tue 2024-08-20 06:20:08 UTC. -- Aug 20 06:19:26 volumio systemd[1]: Time has been changed Aug 20 06:19:27 volumio wpa_supplicant[1014]: wlan0: Trying to associate with SSID 'donong5G' Aug 20 06:19:27 volumio wireless.js[843]: trying... Aug 20 06:19:27 volumio sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 20 06:19:27 volumio sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:27 volumio sudo[1067]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:28 volumio wireless.js[843]: trying... Aug 20 06:19:28 volumio sudo[1076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 20 06:19:28 volumio sudo[1076]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:28 volumio sudo[1076]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:29 volumio wireless.js[843]: trying... Aug 20 06:19:29 volumio sudo[1085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 20 06:19:29 volumio sudo[1085]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:29 volumio sudo[1085]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:30 volumio wpa_supplicant[1014]: wlan0: Associated with 70:5d:cc:7e:dd:c4 Aug 20 06:19:30 volumio wpa_supplicant[1014]: wlan0: WPA: Key negotiation completed with 70:5d:cc:7e:dd:c4 [PTK=CCMP GTK=CCMP] Aug 20 06:19:30 volumio wpa_supplicant[1014]: wlan0: CTRL-EVENT-CONNECTED - Connection to 70:5d:cc:7e:dd:c4 completed [id=0 id_str=] Aug 20 06:19:30 volumio dhcpcd[1036]: wlan0: carrier acquired Aug 20 06:19:30 volumio wpa_supplicant[1014]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Aug 20 06:19:30 volumio dhcpcd[1036]: wlan0: rebinding lease of 192.168.0.12 Aug 20 06:19:30 volumio wireless.js[843]: trying... Aug 20 06:19:30 volumio sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 20 06:19:30 volumio sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:30 volumio sudo[1113]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:30 volumio dhcpcd[1036]: wlan0: leased 192.168.0.12 for 7200 seconds Aug 20 06:19:30 volumio avahi-daemon[734]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.12. Aug 20 06:19:30 volumio dhcpcd[1036]: eth0: adding route to 192.168.0.0/24 Aug 20 06:19:30 volumio avahi-daemon[734]: New relevant interface wlan0.IPv4 for mDNS. Aug 20 06:19:30 volumio dhcpcd[1036]: eth0: adding default route via 192.168.0.1 Aug 20 06:19:30 volumio avahi-daemon[734]: Registering new address record for 192.168.0.12 on wlan0.IPv4. Aug 20 06:19:30 volumio dhcpcd[1036]: wlan0: adding host route to 192.168.0.12 via 127.0.0.1 Aug 20 06:19:30 volumio dhcpcd[1036]: wlan0: adding route to 192.168.0.0/24 Aug 20 06:19:30 volumio dhcpcd[1036]: wlan0: adding default route via 192.168.0.1 Aug 20 06:19:30 volumio dhcpcd[1036]: eth0: removing route to 192.168.0.0/24 Aug 20 06:19:30 volumio dhcpcd[1036]: eth0: removing default route via 192.168.0.1 Aug 20 06:19:31 volumio wireless.js[843]: trying... Aug 20 06:19:31 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 20 06:19:31 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:31 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:31 volumio wireless.js[843]: Connected to: ----donong5G Aug 20 06:19:31 volumio wireless.js[843]: ---- Aug 20 06:19:31 volumio sudo[1152]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 06:19:31 volumio sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:31 volumio sudo[1152]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:31 volumio wireless.js[843]: ... joined AP, wlan0 IPv4 is 192.168.0.12, ipV6 is undefined Aug 20 06:19:31 volumio wireless.js[843]: It's done! AP Aug 20 06:19:31 volumio systemd[1]: Started Wireless Services. Aug 20 06:19:31 volumio systemd[1]: Starting Volumio Backend Module... Aug 20 06:19:31 volumio systemd[1]: Started Volumio Backend Module. Aug 20 06:19:31 volumio systemd[1]: Starting Multi-User System. Aug 20 06:19:31 volumio systemd[1]: Reached target Multi-User System. Aug 20 06:19:31 volumio systemd[1]: Starting Graphical Interface. Aug 20 06:19:31 volumio systemd[1]: Reached target Graphical Interface. Aug 20 06:19:31 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 20 06:19:31 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 20 06:19:31 volumio systemd[1]: Startup finished in 12.374s (kernel) + 19.705s (userspace) = 32.080s. Aug 20 06:19:32 volumio ntpd[821]: Listen normally on 4 wlan0 192.168.0.12 UDP 123 Aug 20 06:19:32 volumio ntpd[821]: peers refreshed Aug 20 06:19:33 volumio volumio-remote-updater[668]: [2024-08-20 06:19:33] [info] asio async_connect error: system:111 (Connection refused) Aug 20 06:19:33 volumio volumio-remote-updater[668]: [2024-08-20 06:19:33] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 20 06:19:33 volumio volumio-remote-updater[668]: [2024-08-20 06:19:33] [error] handle_connect error: Underlying Transport Error Aug 20 06:19:34 volumio volumio[1161]: info: ------------------------------------------- Aug 20 06:19:34 volumio volumio[1161]: info: ----- Volumio2 ---- Aug 20 06:19:34 volumio volumio[1161]: info: ------------------------------------------- Aug 20 06:19:34 volumio volumio[1161]: info: ----- System startup ---- Aug 20 06:19:34 volumio volumio[1161]: info: ------------------------------------------- Aug 20 06:19:35 volumio volumio[1161]: info: MYVOLUMIO Environment detected Aug 20 06:19:35 volumio volumio[1161]: info: Plugin folders cleanup Aug 20 06:19:35 volumio volumio[1161]: info: Scanning into folder /volumio/app/plugins/ Aug 20 06:19:35 volumio volumio[1161]: info: Scanning category audio_interface Aug 20 06:19:35 volumio volumio[1161]: info: Scanning category miscellanea Aug 20 06:19:35 volumio volumio[1161]: info: Scanning category music_service Aug 20 06:19:35 volumio volumio[1161]: info: Scanning category plugins.json Aug 20 06:19:35 volumio volumio[1161]: info: Scanning category system_controller Aug 20 06:19:35 volumio volumio[1161]: info: Scanning category user_interface Aug 20 06:19:35 volumio volumio[1161]: info: Scanning into folder /data/plugins/ Aug 20 06:19:35 volumio volumio[1161]: info: Scanning category miscellanea Aug 20 06:19:35 volumio volumio[1161]: info: Scanning category music_service Aug 20 06:19:35 volumio volumio[1161]: info: Plugin folders cleanup completed Aug 20 06:19:35 volumio volumio[1161]: info: ------------------------------------------- Aug 20 06:19:35 volumio volumio[1161]: info: ----- Core plugins startup ---- Aug 20 06:19:35 volumio volumio[1161]: info: ------------------------------------------- Aug 20 06:19:35 volumio volumio[1161]: info: Loading plugins from folder /volumio/app/plugins/ Aug 20 06:19:35 volumio volumio[1161]: info: Adding plugin upnp to MyMusic Plugins Aug 20 06:19:35 volumio volumio[1161]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 20 06:19:35 volumio volumio[1161]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 20 06:19:35 volumio volumio[1161]: info: Loading plugins from folder /data/plugins/ Aug 20 06:19:35 volumio volumio[1161]: info: Loading plugin "system"... Aug 20 06:19:35 volumio volumio[1161]: info: Loading plugin "appearance"... Aug 20 06:19:38 volumio volumio[1161]: info: Loading plugin "network"... Aug 20 06:19:38 volumio volumio[1161]: info: Refreshing Cached IP Addresses Aug 20 06:19:38 volumio sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 06:19:38 volumio volumio[1161]: info: Loading plugin "services"... Aug 20 06:19:38 volumio volumio[1161]: info: Loading plugin "alsa_controller"... Aug 20 06:19:38 volumio sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:38 volumio sudo[1181]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:38 volumio sudo[1184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 06:19:38 volumio sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:38 volumio sudo[1184]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:38 volumio dbus[748]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Aug 20 06:19:38 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Aug 20 06:19:38 volumio dbus[748]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Aug 20 06:19:38 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Successfully called chroot. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Successfully dropped privileges. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Successfully limited resources. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Running. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Watchdog thread running. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Canary thread running. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio rtkit-daemon[1204]: Supervising 0 threads of 0 processes of 1 users. Aug 20 06:19:38 volumio pulseaudio[1203]: [pulseaudio] server-lookup.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Aug 20 06:19:38 volumio pulseaudio[1203]: [pulseaudio] main.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Aug 20 06:19:38 volumio pulseaudio[1203]: [pulseaudio] bluez4-util.c: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Aug 20 06:19:38 volumio bluetoothd[851]: Endpoint registered: sender=:1.26 path=/MediaEndpoint/A2DPSource Aug 20 06:19:38 volumio bluetoothd[851]: Endpoint registered: sender=:1.26 path=/MediaEndpoint/A2DPSink Aug 20 06:19:38 volumio volumio[1161]: info: Loading plugin "wizard"... Aug 20 06:19:38 volumio volumio[1161]: info: Loading plugin "volumio_command_line_client"... Aug 20 06:19:39 volumio volumio[1161]: info: Loading plugin "upnp"... Aug 20 06:19:39 volumio volumio[1161]: info: [1724134779029] Starting Upmpd Daemon Aug 20 06:19:39 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 20 06:19:39 volumio volumio[1161]: info: Loading plugin "my_music"... Aug 20 06:19:39 volumio volumio[1161]: info: Loading plugin "mpd"... Aug 20 06:19:39 volumio volumio[1161]: info: Loading plugin "upnp_browser"... Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "networkfs"... Aug 20 06:19:40 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "alarm-clock"... Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "airplay_emulation"... Aug 20 06:19:40 volumio volumio[1161]: info: Starting Shairport Sync Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "last_100"... Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "webradio"... Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "i2s_dacs"... Aug 20 06:19:40 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "volumiodiscovery"... Aug 20 06:19:40 volumio volumio[1161]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 20 06:19:40 volumio node[1161]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 20 06:19:40 volumio node[1161]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 20 06:19:40 volumio node[1161]: *** WARNING *** For more information see Aug 20 06:19:40 volumio node[1161]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 20 06:19:40 volumio node[1161]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 20 06:19:40 volumio node[1161]: *** WARNING *** For more information see Aug 20 06:19:40 volumio volumio[1161]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 20 06:19:40 volumio volumio[1161]: *** WARNING *** For more information see Aug 20 06:19:40 volumio volumio[1161]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 20 06:19:40 volumio volumio[1161]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 20 06:19:40 volumio volumio[1161]: *** WARNING *** For more information see Aug 20 06:19:40 volumio volumio[1161]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 20 06:19:40 volumio volumio[1161]: Discovery: StartAdv! undefined Aug 20 06:19:40 volumio volumio[1161]: Discovery: Started advertising... Volumio - undefined Aug 20 06:19:40 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "outputs"... Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "albumart"... Aug 20 06:19:40 volumio volumio[1161]: info: Plugin example_plugin is not enabled Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "inputs"... Aug 20 06:19:40 volumio volumio[1161]: info: Loading plugin "updater_comm"... Aug 20 06:19:41 volumio volumio[1161]: info: Plugin mpdemulation is not enabled Aug 20 06:19:41 volumio volumio[1161]: info: Loading plugin "rest_api"... Aug 20 06:19:41 volumio volumio[1161]: info: Loading plugin "websocket"... Aug 20 06:19:41 volumio volumio[1161]: info: Plugin minidlna is not enabled Aug 20 06:19:41 volumio volumio[1161]: info: Loading plugin "personal_radio"... Aug 20 06:19:41 volumio volumio[1161]: Forking 3 albumart workers Aug 20 06:19:42 volumio volumio[1161]: Starting albumart workers Aug 20 06:19:42 volumio volumio[1161]: Starting albumart workers Aug 20 06:19:42 volumio volumio[1161]: Starting albumart workers Aug 20 06:19:43 volumio volumio[1161]: info: ControllerPersonalRadio::constructor Aug 20 06:19:43 volumio volumio[1161]: info: ___________ START PLUGINS ___________ Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 06:19:43 volumio volumio[1161]: info: [1724134783068] CoreMusicLibrary::Adding element Media Servers Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 06:19:43 volumio volumio[1161]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 06:19:43 volumio volumio[1161]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 06:19:43 volumio volumio[1161]: info: [1724134783189] CoreMusicLibrary::Adding element Last_100 Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 06:19:43 volumio volumio[1161]: info: [1724134783193] CoreMusicLibrary::Adding element Webradio Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 06:19:43 volumio volumio[1161]: info: [1724134783235] CoreMusicLibrary::Adding element 개인 라디오 Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 06:19:43 volumio volumio[1161]: info: ------------------------------------------- Aug 20 06:19:43 volumio volumio[1161]: info: ----- MyVolumio plugins startup ---- Aug 20 06:19:43 volumio volumio[1161]: info: ------------------------------------------- Aug 20 06:19:43 volumio volumio[1161]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 20 06:19:43 volumio volumio[1161]: info: Loading i18n strings for locale ko Aug 20 06:19:43 volumio volumio[1161]: Updating browse sources language Aug 20 06:19:43 volumio volumio[1161]: Cannot find translation for sourceMedia Servers Aug 20 06:19:43 volumio volumio[1161]: Cannot find translation for source개인 라디오 Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 06:19:43 volumio volumio-remote-updater[668]: [2024-08-20 06:19:43] [connect] Successful connection Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::initPlayerControls Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: info: BOOT COMPLETED Aug 20 06:19:43 volumio volumio[1161]: [Metrics] CommandRouter: 9s 157.88ms Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:43 volumio volumio[1161]: aplay: main:722: audio open error: Device or resource busy Aug 20 06:19:43 volumio volumio[1161]: Cannot play startup sound Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::Close All Modals sent Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::Close All Modals sent Aug 20 06:19:43 volumio volumio[1161]: Express server listening on port 3000 Aug 20 06:19:43 volumio volumio[1161]: [Metrics] WebUI: 9s 865.90ms Aug 20 06:19:43 volumio volumio[1161]: Volumio Calling Home Aug 20 06:19:43 volumio volumio[1161]: info: CoreStateMachine::resetVolumioState Aug 20 06:19:43 volumio volumio[1161]: info: CoreStateMachine::getcurrentVolume Aug 20 06:19:43 volumio volumio[1161]: info: CoreCommandRouter::volumioRetrievevolume Aug 20 06:19:43 volumio volumio[1161]: Unable to parse: Aug 20 06:19:43 volumio volumio[1161]: Simple mixer control 'Digital',0 Aug 20 06:19:43 volumio volumio[1161]: Capabilities: volume Aug 20 06:19:43 volumio volumio[1161]: Playback channels: Front Left - Front Right Aug 20 06:19:43 volumio volumio[1161]: Capture channels: Front Left - Front Right Aug 20 06:19:43 volumio volumio[1161]: Limits: 0 - 246 Aug 20 06:19:43 volumio volumio[1161]: Front Left: 0 [0%] Aug 20 06:19:43 volumio volumio[1161]: Front Right: 0 [0%] Aug 20 06:19:43 volumio volumio[1161]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 20 06:19:43 volumio volumio[1161]: info: Setting Device type: Raspberry PI Aug 20 06:19:43 volumio volumio[1161]: info: MPD running with PID744 Aug 20 06:19:43 volumio volumio[1161]: ,establishing connection Aug 20 06:19:44 volumio volumio-remote-updater[668]: [2024-08-20 06:19:44] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1724134783 101 Aug 20 06:19:44 volumio volumio[1161]: info: Volumio called home Aug 20 06:19:44 volumio volumio[1161]: Unable to parse: Aug 20 06:19:44 volumio volumio[1161]: Simple mixer control 'Digital',0 Aug 20 06:19:44 volumio volumio[1161]: Capabilities: volume Aug 20 06:19:44 volumio volumio[1161]: Playback channels: Front Left - Front Right Aug 20 06:19:44 volumio volumio[1161]: Capture channels: Front Left - Front Right Aug 20 06:19:44 volumio volumio[1161]: Limits: 0 - 246 Aug 20 06:19:44 volumio volumio[1161]: Front Left: 0 [0%] Aug 20 06:19:44 volumio volumio[1161]: Front Right: 0 [0%] Aug 20 06:19:44 volumio volumio[1161]: info: VolumeController:: Volume=undefined Mute =false Aug 20 06:19:44 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:44 volumio volumio[1161]: info: CoreStateMachine::updateTrackBlock Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getTrackBlock Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioRetrievevolume Aug 20 06:19:44 volumio volumio[1161]: info: Reloading queue from file Aug 20 06:19:44 volumio volumio[1161]: error: updateQueue error: null Aug 20 06:19:44 volumio volumio[1161]: verbose: ControllerMpd::sendMpdCommand update Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 20 06:19:44 volumio volumio[1161]: info: CoreStateMachine::setRepeat null single undefined Aug 20 06:19:44 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:44 volumio volumio[1161]: info: CoreStateMachine::setRandom null Aug 20 06:19:44 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioGetState Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:44 volumio volumio[1161]: Unable to parse: Aug 20 06:19:44 volumio volumio[1161]: Simple mixer control 'Digital',0 Aug 20 06:19:44 volumio volumio[1161]: Capabilities: volume Aug 20 06:19:44 volumio volumio[1161]: Playback channels: Front Left - Front Right Aug 20 06:19:44 volumio volumio[1161]: Capture channels: Front Left - Front Right Aug 20 06:19:44 volumio volumio[1161]: Limits: 0 - 246 Aug 20 06:19:44 volumio volumio[1161]: Front Left: 0 [0%] Aug 20 06:19:44 volumio volumio[1161]: Front Right: 0 [0%] Aug 20 06:19:44 volumio volumio[1161]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 06:19:44 volumio volumio[1161]: info: Listing playlists Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioGetQueue Aug 20 06:19:44 volumio volumio[1161]: info: CoreStateMachine::getQueue Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getQueue Aug 20 06:19:44 volumio volumio[1161]: info: Starting Shairport Sync Aug 20 06:19:44 volumio volumio[1161]: info: Starting Shairport Sync Aug 20 06:19:44 volumio sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 06:19:44 volumio sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:44 volumio sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 06:19:44 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Aug 20 06:19:44 volumio sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 06:19:44 volumio sudo[1290]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:44 volumio volumio[1161]: Unable to parse: Aug 20 06:19:44 volumio volumio[1161]: Simple mixer control 'Digital',0 Aug 20 06:19:44 volumio volumio[1161]: Capabilities: volume Aug 20 06:19:44 volumio volumio[1161]: Playback channels: Front Left - Front Right Aug 20 06:19:44 volumio volumio[1161]: Capture channels: Front Left - Front Right Aug 20 06:19:44 volumio volumio[1161]: Limits: 0 - 246 Aug 20 06:19:44 volumio volumio[1161]: Front Left: 0 [0%] Aug 20 06:19:44 volumio volumio[1161]: Front Right: 0 [0%] Aug 20 06:19:44 volumio volumio[1161]: info: VolumeController:: Volume=undefined Mute =false Aug 20 06:19:44 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 20 06:19:44 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Aug 20 06:19:44 volumio sudo[1292]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 06:19:44 volumio volumio[1161]: Discovery: adding 504dcf41-470c-405c-864f-e78607d5d8c0 Aug 20 06:19:44 volumio volumio[1161]: info: mDNS: Found device Volumio Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioGetState Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:44 volumio volumio[1161]: Discovery: this is already registered, 504dcf41-470c-405c-864f-e78607d5d8c0 Aug 20 06:19:44 volumio volumio[1161]: info: mDNS: Found device Volumio Aug 20 06:19:44 volumio volumio[1161]: info: CoreCommandRouter::volumioGetState Aug 20 06:19:44 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:45 volumio volumio[1161]: info: Shairport-Sync Started Aug 20 06:19:45 volumio volumio[1161]: Error adding Membership: Error: addMembership EINVAL Aug 20 06:19:45 volumio volumio[1161]: info: Shairport-Sync Started Aug 20 06:19:45 volumio volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Aug 20 06:19:45 volumio volumio[1161]: info: Aug 20 06:19:45 volumio volumio[1161]: ---------------------------- MPD announces state update: update Aug 20 06:19:45 volumio volumio[1161]: info: sendMpdCommand update took 1658 milliseconds Aug 20 06:19:45 volumio volumio[1161]: info: ControllerMpd::getState Aug 20 06:19:45 volumio volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Aug 20 06:19:45 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:45 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 06:19:46 volumio volumio[1161]: info: MPD Database updated - AlbumList cache refreshed Aug 20 06:19:46 volumio volumio[1161]: info: Aug 20 06:19:46 volumio volumio[1161]: ---------------------------- MPD announces state update: database Aug 20 06:19:46 volumio volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Aug 20 06:19:46 volumio volumio[1161]: info: Aug 20 06:19:46 volumio volumio[1161]: ---------------------------- MPD announces state update: update Aug 20 06:19:46 volumio volumio[1161]: info: ControllerMpd::getState Aug 20 06:19:46 volumio volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Aug 20 06:19:46 volumio volumio[1161]: info: ControllerMpd::getState Aug 20 06:19:46 volumio volumio[1161]: verbose: ControllerMpd::sendMpdCommand status Aug 20 06:19:46 volumio pulseaudio[1322]: [pulseaudio] server-lookup.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Aug 20 06:19:46 volumio pulseaudio[1322]: [pulseaudio] main.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Aug 20 06:19:46 volumio pulseaudio[1322]: [pulseaudio] bluez4-util.c: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Aug 20 06:19:46 volumio bluetoothd[851]: Endpoint registered: sender=:1.34 path=/MediaEndpoint/A2DPSource Aug 20 06:19:46 volumio bluetoothd[851]: Endpoint registered: sender=:1.34 path=/MediaEndpoint/A2DPSink Aug 20 06:19:46 volumio volumio[1161]: info: sendMpdCommand status took 534 milliseconds Aug 20 06:19:46 volumio volumio[1161]: info: sendMpdCommand status took 522 milliseconds Aug 20 06:19:46 volumio volumio[1161]: info: sendMpdCommand status took 226 milliseconds Aug 20 06:19:46 volumio volumio[1161]: info: sendMpdCommand status took 224 milliseconds Aug 20 06:19:46 volumio volumio[1161]: info: sendMpdCommand status took 222 milliseconds Aug 20 06:19:46 volumio volumio[1161]: verbose: ControllerMpd::parseState Aug 20 06:19:51 volumio volumio[1161]: info: Command Router : Notfying DB Updatefalse Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::Close All Modals sent Aug 20 06:19:51 volumio volumio[1161]: verbose: ControllerMpd::parseState Aug 20 06:19:51 volumio volumio[1161]: verbose: ControllerMpd::parseState Aug 20 06:19:51 volumio volumio[1161]: info: Command Router : Notfying DB Updatefalse Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::Close All Modals sent Aug 20 06:19:51 volumio volumio[1161]: verbose: ControllerMpd::parseState Aug 20 06:19:51 volumio volumio[1161]: verbose: ControllerMpd::parseState Aug 20 06:19:51 volumio volumio[1161]: info: ControllerMpd::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::servicePushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 06:19:51 volumio volumio[1161]: verbose: CURRENT POSITION 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::syncState stateService stop Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::syncState currentStatus stop Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: No code Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: ControllerMpd::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::servicePushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 06:19:51 volumio volumio[1161]: verbose: CURRENT POSITION 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::syncState stateService stop Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::syncState currentStatus stop Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: No code Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: ControllerMpd::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::servicePushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 06:19:51 volumio volumio[1161]: verbose: CURRENT POSITION 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::syncState stateService stop Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::syncState currentStatus stop Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: No code Aug 20 06:19:51 volumio volumio[1161]: info: CoreStateMachine::pushState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:19:51 volumio volumio[1161]: info: ------------------------------ 5885ms Aug 20 06:19:51 volumio volumio[1161]: info: ------------------------------ 5580ms Aug 20 06:19:51 volumio volumio[1161]: info: ------------------------------ 5580ms Aug 20 06:19:51 volumio sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 06:19:51 volumio sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:51 volumio sudo[1337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 06:19:51 volumio sudo[1335]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:51 volumio sudo[1337]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:51 volumio sudo[1337]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:51 volumio volumio[1161]: info: CoreCommandRouter::volumioGetState Aug 20 06:19:51 volumio volumio[1161]: info: CorePlayQueue::getTrack 0 Aug 20 06:19:52 volumio sudo[1353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 20 06:19:52 volumio sudo[1353]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:52 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Aug 20 06:19:52 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 20 06:19:52 volumio sudo[1353]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:52 volumio volumio[1161]: info: Upmpdcli Daemon Started Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 20 06:19:52 volumio volumio[1161]: info: Adding plugin bluetooth to MyMusic Plugins Aug 20 06:19:52 volumio volumio[1161]: info: Adding plugin cd_controller to MyMusic Plugins Aug 20 06:19:52 volumio volumio[1161]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 20 06:19:52 volumio volumio[1161]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 20 06:19:54 volumio volumio[1161]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 20 06:19:56 volumio volumio[1161]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 20 06:19:56 volumio volumio[1161]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 20 06:19:56 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:56 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:56 volumio volumio[1161]: info: Starting MyVolumio Remote Streaming Endpoints Aug 20 06:19:56 volumio volumio[1161]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 20 06:19:56 volumio volumio[1161]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 20 06:19:56 volumio volumio[1161]: info: Streaming services startup Aug 20 06:19:56 volumio volumio[1161]: info: Starting Streaming Daemon Aug 20 06:19:56 volumio volumio[1161]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 20 06:19:56 volumio sudo[1376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 20 06:19:56 volumio sudo[1376]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:56 volumio sudo[1376]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:56 volumio volumio[1161]: error: Cannot start Volumio Streaming Daemon Aug 20 06:19:56 volumio volumio[1161]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 20 06:19:56 volumio volumio[1161]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service failed to load: No such file or directory. Aug 20 06:19:57 volumio volumio[1161]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 20 06:19:57 volumio volumio[1161]: info: MYVOLUMIO: Adding device Aug 20 06:19:57 volumio volumio[1161]: info: MYVOLUMIO: Evaluating Server Aug 20 06:19:58 volumio volumio[1161]: info: MyVolumio status changed Aug 20 06:19:58 volumio volumio[1161]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Aug 20 06:19:58 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 06:19:58 volumio volumio[1161]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Aug 20 06:19:58 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 06:19:58 volumio volumio[1161]: info: Streaming services startup Aug 20 06:19:58 volumio volumio[1161]: info: Starting Streaming Daemon Aug 20 06:19:58 volumio volumio[1161]: info: Removing browser output: myVolumio user plan is not superstar Aug 20 06:19:58 volumio volumio[1161]: info: Removing audio output: Aug 20 06:19:58 volumio volumio[1161]: info: Stoppping Tunnel 1 Aug 20 06:19:58 volumio sudo[1404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 20 06:19:58 volumio sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:58 volumio sudo[1404]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:58 volumio sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 20 06:19:58 volumio sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 06:19:58 volumio sudo[1407]: pam_unix(sudo:session): session closed for user root Aug 20 06:19:58 volumio volumio[1161]: info: Setting Geolocation for MyVolumio to as1 Aug 20 06:19:58 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:58 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:58 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:58 volumio volumio[1161]: error: Cannot stop Remote SSH: Error: Command failed: /usr/bin/sudo /bin/systemctl stop sshtunnel.service Aug 20 06:19:58 volumio volumio[1161]: Failed to stop sshtunnel.service: Unit sshtunnel.service not loaded. Aug 20 06:19:58 volumio volumio[1161]: error: Cannot start Volumio Streaming Daemon Aug 20 06:19:59 volumio volumio[1161]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 20 06:19:59 volumio volumio[1161]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service failed to load: No such file or directory. Aug 20 06:19:59 volumio volumio[1161]: info: Updating MyVolumio device info Aug 20 06:19:59 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:59 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:19:59 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 06:20:04 volumio bluetoothd[851]: Endpoint unregistered: sender=:1.26 path=/MediaEndpoint/A2DPSource Aug 20 06:20:04 volumio bluetoothd[851]: Endpoint unregistered: sender=:1.26 path=/MediaEndpoint/A2DPSink Aug 20 06:20:05 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Aug 20 06:20:06 volumio bluetoothd[851]: Endpoint unregistered: sender=:1.34 path=/MediaEndpoint/A2DPSource Aug 20 06:20:06 volumio bluetoothd[851]: Endpoint unregistered: sender=:1.34 path=/MediaEndpoint/A2DPSink Aug 20 06:20:06 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Aug 20 06:20:07 volumio volumio[1161]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 20 06:20:07 volumio volumio[1161]: info: CoreStateMachine::ClearQueue Aug 20 06:20:07 volumio volumio[1161]: info: CoreStateMachine::stop Aug 20 06:20:07 volumio volumio[1161]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 06:20:07 volumio volumio[1161]: UNSET VOLATILE Aug 20 06:20:07 volumio volumio[1161]: info: CorePlayQueue::clearPlayQueue Aug 20 06:20:07 volumio volumio[1161]: info: CorePlayQueue::saveQueue Aug 20 06:20:07 volumio volumio[1161]: info: CoreCommandRouter::volumioPushState Aug 20 06:20:07 volumio volumio[1161]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 06:20:07 volumio volumio[1161]: info: CoreCommandRouter::volumioPushQueue Aug 20 06:20:07 volumio volumio[1161]: info: CoreStateMachine::addQueueItems Aug 20 06:20:07 volumio volumio[1161]: info: CorePlayQueue::addQueueItems Aug 20 06:20:07 volumio volumio[1161]: info: Adding Item to queue: webkbs/0 Aug 20 06:20:07 volumio volumio[1161]: info: Exploding uri webkbs/0 in service personal_radio Aug 20 06:20:07 volumio volumio[1161]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 06:20:07 volumio volumio[1161]: ReferenceError: self is not defined Aug 20 06:20:07 volumio volumio[1161]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22) Aug 20 06:20:07 volumio volumio[1161]: at /data/plugins/music_service/personal_radio/index.js:487:12 Aug 20 06:20:07 volumio volumio[1161]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:463:26) Aug 20 06:20:07 volumio volumio[1161]: at Request.self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Aug 20 06:20:07 volumio volumio[1161]: at emitTwo (events.js:126:13) Aug 20 06:20:07 volumio volumio[1161]: at Request.emit (events.js:214:7) Aug 20 06:20:07 volumio volumio[1161]: at Request. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:1044:10) Aug 20 06:20:07 volumio volumio[1161]: at emitOne (events.js:116:13) Aug 20 06:20:07 volumio volumio[1161]: at Request.emit (events.js:211:7) Aug 20 06:20:07 volumio volumio[1161]: at IncomingMessage. (/data/plugins/music_service/personal_radio/node_modules/request/request.js:965:12) Aug 20 06:20:07 volumio volumio[1161]: at emitNone (events.js:111:20) Aug 20 06:20:07 volumio volumio[1161]: at IncomingMessage.emit (events.js:208:7) Aug 20 06:20:07 volumio volumio[1161]: at endReadableNT (_stream_readable.js:1064:12) Aug 20 06:20:07 volumio volumio[1161]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Aug 20 06:20:07 volumio volumio[1161]: at process._tickCallback (internal/process/next_tick.js:180:9) Aug 20 06:20:07 volumio volumio[1161]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 06:20:08 volumio sudo[1449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-20 06:19 Aug 20 06:20:08 volumio sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="14acf028cf46278bd3fd3dd02523424a9bc825bf" VOLUMIO_FE_VERSION="9dfacc3084ddf8378a0a2ba052bab3e7aa2ae345" VOLUMIO_BE_VERSION="40a5d4b5232c61241c1a813b8652ad2b0cbd8a2c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed May 5 14:48:15 UTC 2021" VOLUMIO_VERSION="2.882" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="f911710eb3a296dbaa3280d30d30bab2"