-- Logs begin at Thu 2019-02-14 23:12:00 NZDT, end at Wed 2024-07-10 17:58:02 NZST. -- Jul 10 17:57:17 hi-fi ntpd[961]: receive: Unexpected origin timestamp 0xea389be9.003c8b9e does not match aorg 0000000000.00000000 from server@202.68.92.244 xmt 0xea38a13d.103808e5 Jul 10 17:57:17 hi-fi ntpd[961]: receive: Unexpected origin timestamp 0xea389be9.0036e049 does not match aorg 0000000000.00000000 from server@103.239.8.21 xmt 0xea38a13d.114de24e Jul 10 17:57:17 hi-fi ntpd[961]: receive: Unexpected origin timestamp 0xea389be9.002bf08c does not match aorg 0000000000.00000000 from server@220.158.215.21 xmt 0xea38a13d.12f3f7b7 Jul 10 17:57:17 hi-fi ntpd[961]: receive: Unexpected origin timestamp 0xea389be9.003a0d93 does not match aorg 0000000000.00000000 from server@220.158.215.20 xmt 0xea38a13d.12e846f0 Jul 10 17:57:17 hi-fi ntpd[961]: receive: Unexpected origin timestamp 0xea389be9.004124a1 does not match aorg 0000000000.00000000 from server@103.106.65.219 xmt 0xea38a13d.14c7c98c Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "network"... Jul 10 17:57:18 hi-fi volumio[972]: info: Refreshing Cached IP Addresses Jul 10 17:57:18 hi-fi sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 10 17:57:18 hi-fi sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:18 hi-fi sudo[1019]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "services"... Jul 10 17:57:18 hi-fi sudo[1021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 10 17:57:18 hi-fi sudo[1021]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:18 hi-fi sudo[1021]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "alsa_controller"... Jul 10 17:57:18 hi-fi sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 10 17:57:18 hi-fi sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:18 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "wizard"... Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "networkfs"... Jul 10 17:57:18 hi-fi sudo[1032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=home_server,password=12Devilinanewdress,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.20.50/Home_Server/music /mnt/NAS/PlexAmp Jul 10 17:57:18 hi-fi sudo[1032]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:18 hi-fi volumio[972]: info: Starting Udev Watcher for removable devices Jul 10 17:57:18 hi-fi sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.20.50:Home_Server/Music /mnt/NAS/Music Jul 10 17:57:18 hi-fi sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:18 hi-fi volumio[972]: info: Ignoring mount for partition: boot Jul 10 17:57:18 hi-fi volumio[972]: info: Ignoring mount for partition: volumio Jul 10 17:57:18 hi-fi volumio[972]: info: Ignoring mount for partition: volumio_data Jul 10 17:57:18 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "volumio_command_line_client"... Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "upnp"... Jul 10 17:57:18 hi-fi volumio[972]: info: [1720591038740] Starting Upmpd Daemon Jul 10 17:57:18 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "my_music"... Jul 10 17:57:18 hi-fi volumio[972]: info: Loading plugin "mpd"... Jul 10 17:57:18 hi-fi systemd[1]: systemd-hostnamed.service: Succeeded. Jul 10 17:57:19 hi-fi kernel: Key type cifs.spnego registered Jul 10 17:57:19 hi-fi kernel: Key type cifs.idmap registered Jul 10 17:57:19 hi-fi kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jul 10 17:57:19 hi-fi kernel: CIFS: Attempting to mount \\192.168.20.50\Home_Server Jul 10 17:57:19 hi-fi volumio-remote-updater[568]: [2024-07-10 17:57:19] [connect] Successful connection Jul 10 17:57:19 hi-fi sudo[1032]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:19 hi-fi volumio[972]: info: Loading plugin "upnp_browser"... Jul 10 17:57:20 hi-fi volumio[972]: info: Loading plugin "alarm-clock"... Jul 10 17:57:21 hi-fi volumio[972]: info: Loading plugin "airplay_emulation"... Jul 10 17:57:21 hi-fi volumio[972]: info: Starting Shairport Sync Jul 10 17:57:21 hi-fi volumio[972]: info: Loading plugin "last_100"... Jul 10 17:57:21 hi-fi volumio[972]: info: Loading plugin "webradio"... Jul 10 17:57:21 hi-fi volumio[972]: info: Loading plugin "i2s_dacs"... Jul 10 17:57:21 hi-fi volumio[972]: info: Loading plugin "volumiodiscovery"... Jul 10 17:57:21 hi-fi volumio[972]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 10 17:57:21 hi-fi node[972]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 10 17:57:21 hi-fi volumio[972]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 10 17:57:21 hi-fi node[972]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 10 17:57:21 hi-fi volumio[972]: *** WARNING *** For more information see Jul 10 17:57:21 hi-fi node[972]: *** WARNING *** For more information see Jul 10 17:57:21 hi-fi volumio[972]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 10 17:57:21 hi-fi node[972]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 10 17:57:21 hi-fi volumio[972]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 10 17:57:21 hi-fi node[972]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 10 17:57:21 hi-fi volumio[972]: *** WARNING *** For more information see Jul 10 17:57:21 hi-fi node[972]: *** WARNING *** For more information see Jul 10 17:57:21 hi-fi volumio[972]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 10 17:57:21 hi-fi volumio[972]: info: Discovery: Started advertising with name: Hi-Fi Jul 10 17:57:21 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 10 17:57:21 hi-fi volumio[972]: info: Loading plugin "spop"... Jul 10 17:57:22 hi-fi sudo[1024]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:22 hi-fi wpa_supplicant[862]: RRM: Ignoring radio measurement request: Not RRM network Jul 10 17:57:24 hi-fi volumio[972]: info: Loading plugin "now_playing"... Jul 10 17:57:25 hi-fi nmbd[708]: [2024/07/10 17:57:25.741819, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 10 17:57:25 hi-fi nmbd[708]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.20.119 for name WORKGROUP<1d>. Jul 10 17:57:25 hi-fi nmbd[708]: This response was from IP 192.168.20.90, reporting an IP address of 192.168.20.90. Jul 10 17:57:27 hi-fi volumio[972]: info: Loading plugin "outputs"... Jul 10 17:57:27 hi-fi volumio[972]: info: Loading plugin "albumart"... Jul 10 17:57:27 hi-fi volumio[972]: info: Plugin example_plugin is not enabled Jul 10 17:57:27 hi-fi volumio[972]: info: Loading plugin "inputs"... Jul 10 17:57:27 hi-fi volumio[972]: info: Loading plugin "updater_comm"... Jul 10 17:57:27 hi-fi volumio[972]: info: Plugin mpdemulation is not enabled Jul 10 17:57:27 hi-fi volumio[972]: info: Loading plugin "rest_api"... Jul 10 17:57:27 hi-fi volumio[972]: info: Loading plugin "websocket"... Jul 10 17:57:27 hi-fi volumio[972]: info: Starting Socket.io Server version 2.3.0 Jul 10 17:57:27 hi-fi volumio[972]: info: Loading plugin "touch_display"... Jul 10 17:57:28 hi-fi volumio[972]: Forking 3 albumart workers Jul 10 17:57:28 hi-fi wpa_supplicant[862]: RRM: Ignoring radio measurement request: Not RRM network Jul 10 17:57:28 hi-fi volumio[972]: info: Applying required configuration parameters for plugin touch_display Jul 10 17:57:29 hi-fi volumio[972]: info: Loading i18n strings for locale en Jul 10 17:57:29 hi-fi volumio[972]: Updating browse sources language Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::initPlayerControls Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 17:57:29 hi-fi volumio[972]: Express server listening on port 3000 Jul 10 17:57:29 hi-fi volumio[972]: [Metrics] WebUI: 18s 277.45ms Jul 10 17:57:29 hi-fi volumio[972]: Starting albumart workers Jul 10 17:57:29 hi-fi volumio[972]: info: CoreStateMachine::resetVolumioState Jul 10 17:57:29 hi-fi volumio[972]: info: CoreStateMachine::getcurrentVolume Jul 10 17:57:29 hi-fi volumio[972]: info: CoreCommandRouter::volumioRetrievevolume Jul 10 17:57:29 hi-fi volumio[972]: Starting albumart workers Jul 10 17:57:29 hi-fi volumio[972]: Starting albumart workers Jul 10 17:57:30 hi-fi sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 10 17:57:30 hi-fi sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:30 hi-fi sudo[1105]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:30 hi-fi sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 10 17:57:30 hi-fi sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:30 hi-fi sudo[1108]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:30 hi-fi volumio[972]: verbose: New Socket.io Connection to 192.168.20.119 from 192.168.20.100 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 1 Jul 10 17:57:30 hi-fi volumio[972]: verbose: New Socket.io Connection to 192.168.20.119 from 192.168.20.100 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 2 Jul 10 17:57:30 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 17:57:30 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 17:57:30 hi-fi volumio[972]: info: Discovery: Getting this device information Jul 10 17:57:30 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:30 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:30 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 17:57:30 hi-fi volumio[972]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jul 10 17:57:30 hi-fi volumio[972]: info: VolumeController:: Volume=43 Mute =false Jul 10 17:57:30 hi-fi volumio[972]: info: CoreStateMachine::pushState Jul 10 17:57:30 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:30 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 17:57:30 hi-fi volumio[972]: info: CoreCommandRouter::volumioPushState Jul 10 17:57:30 hi-fi volumio[972]: info: CoreStateMachine::updateTrackBlock Jul 10 17:57:30 hi-fi volumio[972]: info: CorePlayQueue::getTrackBlock Jul 10 17:57:30 hi-fi volumio[972]: info: CoreCommandRouter::volumioRetrievevolume Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 17:57:31 hi-fi volumio[972]: info: Reloading queue from file Jul 10 17:57:31 hi-fi volumio[972]: info: CoreStateMachine::setRepeat null single undefined Jul 10 17:57:31 hi-fi volumio[972]: info: CoreStateMachine::pushState Jul 10 17:57:31 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::volumioPushState Jul 10 17:57:31 hi-fi volumio[972]: info: CoreStateMachine::setRandom null Jul 10 17:57:31 hi-fi volumio[972]: info: CoreStateMachine::pushState Jul 10 17:57:31 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::volumioPushState Jul 10 17:57:31 hi-fi volumio[972]: info: Setting Device type: Raspberry PI Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 17:57:31 hi-fi volumio[972]: info: Discovery: Getting this device information Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:31 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:31 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:31 hi-fi sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 10 17:57:31 hi-fi sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:31 hi-fi volumio[972]: info: VolumeController:: Volume=43 Mute =false Jul 10 17:57:31 hi-fi volumio[972]: info: CoreStateMachine::pushState Jul 10 17:57:31 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:31 hi-fi volumio[972]: info: CoreCommandRouter::volumioPushState Jul 10 17:57:31 hi-fi systemd[1]: Started UPnP Renderer front-end to MPD. Jul 10 17:57:31 hi-fi sudo[1143]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:31 hi-fi volumio[972]: verbose: New Socket.io Connection to 192.168.20.119 from 192.168.20.100 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 4 Jul 10 17:57:31 hi-fi volumio[972]: info: Listing playlists Jul 10 17:57:31 hi-fi volumio[972]: info: Listing playlists Jul 10 17:57:31 hi-fi volumio[972]: info: Upmpdcli Daemon Started Jul 10 17:57:31 hi-fi volumio[972]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 10 17:57:32 hi-fi volumio[972]: info: Discovery: adding 95ed6057-235f-4295-b5a1-4b1f339ce404 Jul 10 17:57:32 hi-fi volumio[972]: info: Discovery: Found device Hi-Fi Jul 10 17:57:32 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:32 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:32 hi-fi volumio[972]: verbose: New Socket.io Connection to 192.168.20.119 from 192.168.20.100 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 5 Jul 10 17:57:32 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:32 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:32 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 10 17:57:32 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 10 17:57:32 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:32 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:34 hi-fi volumio-remote-updater[568]: [2024-07-10 17:57:34] [connect] Successful connection Jul 10 17:57:34 hi-fi volumio-remote-updater[568]: [2024-07-10 17:57:34] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1720591054 101 Jul 10 17:57:34 hi-fi volumio[972]: 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: 6 Jul 10 17:57:35 hi-fi volumio[972]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 10 17:57:36 hi-fi kernel: hwmon hwmon1: Voltage normalised Jul 10 17:57:38 hi-fi kernel: hwmon hwmon1: Undervoltage detected! Jul 10 17:57:41 hi-fi volumio[972]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 10 17:57:42 hi-fi kernel: hwmon hwmon1: Voltage normalised Jul 10 17:57:42 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:42 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:44 hi-fi kernel: hwmon hwmon1: Undervoltage detected! Jul 10 17:57:44 hi-fi sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 10 17:57:44 hi-fi sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:44 hi-fi sudo[1149]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:44 hi-fi sudo[1151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 10 17:57:44 hi-fi sudo[1151]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:44 hi-fi sudo[1151]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:44 hi-fi volumio[972]: verbose: New Socket.io Connection to 192.168.20.119 from 192.168.20.100 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 7 Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetVisibleSources Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:44 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 10 17:57:44 hi-fi volumio[972]: info: Received Get System Info Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 17:57:44 hi-fi volumio[972]: info: Discovery: Getting this device information Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:44 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:44 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:44 hi-fi volumio[972]: info: Listing playlists Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 10 17:57:44 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 10 17:57:46 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 10 17:57:46 hi-fi volumio[972]: info: Received Get System Info Jul 10 17:57:46 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 17:57:46 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 17:57:46 hi-fi volumio[972]: info: Discovery: Getting this device information Jul 10 17:57:46 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:46 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:46 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 17:57:46 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 10 17:57:46 hi-fi volumio[972]: info: CoreCommandRouter::volumioPlay Jul 10 17:57:46 hi-fi volumio[972]: info: CoreStateMachine::play index undefined Jul 10 17:57:46 hi-fi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 17:57:46 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:46 hi-fi volumio[972]: info: CoreStateMachine::startPlaybackTimer Jul 10 17:57:46 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:46 hi-fi volumio[972]: verbose: ControllerMpd::clearAddPlayTracks NAS/PlexAmp/Kendrick Lamar/DAMN. (2017)/Kendrick Lamar - DAMN. - 01 - BLOOD.flac Jul 10 17:57:46 hi-fi volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 17:57:47 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 10 17:57:48 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 10 17:57:48 hi-fi volumio[972]: info: Received Get System Info Jul 10 17:57:48 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 17:57:48 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 17:57:48 hi-fi volumio[972]: info: Discovery: Getting this device information Jul 10 17:57:48 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:48 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:48 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 17:57:48 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 10 17:57:51 hi-fi volumio[972]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 10 17:57:52 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetState Jul 10 17:57:52 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:52 hi-fi volumio[972]: info: Listing playlists Jul 10 17:57:52 hi-fi volumio[972]: info: Listing playlists Jul 10 17:57:54 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 10 17:57:55 hi-fi volumio[972]: info: CoreCommandRouter::volumioPlay Jul 10 17:57:55 hi-fi volumio[972]: info: CoreStateMachine::play index undefined Jul 10 17:57:55 hi-fi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 17:57:55 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:55 hi-fi volumio[972]: info: CoreStateMachine::startPlaybackTimer Jul 10 17:57:55 hi-fi volumio[972]: info: CorePlayQueue::getTrack 0 Jul 10 17:57:55 hi-fi volumio[972]: verbose: ControllerMpd::clearAddPlayTracks NAS/PlexAmp/Kendrick Lamar/DAMN. (2017)/Kendrick Lamar - DAMN. - 01 - BLOOD.flac Jul 10 17:57:55 hi-fi volumio[972]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 17:57:57 hi-fi volumio[972]: info: CoreCommandRouter::volumioGetQueue Jul 10 17:57:57 hi-fi volumio[972]: info: CoreStateMachine::getQueue Jul 10 17:57:57 hi-fi volumio[972]: info: CorePlayQueue::getQueue Jul 10 17:57:59 hi-fi volumio[972]: error: Plugin system_controller networkfs failed to complete 'onVolumioStart' in a timely fashion Jul 10 17:57:59 hi-fi volumio[972]: info: Preparing to generate the ALSA configuration file Jul 10 17:57:59 hi-fi volumio[972]: info: Asound.conf file unchanged, so no further update is needed Jul 10 17:57:59 hi-fi volumio[972]: info: Output device has changed, restarting MPD Jul 10 17:57:59 hi-fi sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 10 17:57:59 hi-fi sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:59 hi-fi sudo[1190]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:59 hi-fi volumio[972]: info: Output device has changed, restarting Shairport Sync Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 17:57:59 hi-fi sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 10 17:57:59 hi-fi sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:59 hi-fi volumio[972]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 10 17:57:59 hi-fi volumio[972]: info: ___________ START PLUGINS ___________ Jul 10 17:57:59 hi-fi volumio[972]: info: ControllerMpd::onStart: Initializing MPD Jul 10 17:57:59 hi-fi volumio[972]: info: Creating MPD Configuration file Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 10 17:57:59 hi-fi sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 10 17:57:59 hi-fi sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 10 17:57:59 hi-fi volumio[972]: info: [1720591079271] CoreMusicLibrary::Adding element Media Servers Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 10 17:57:59 hi-fi systemd[1]: Listening on mpd.socket. Jul 10 17:57:59 hi-fi sudo[1200]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:59 hi-fi systemd[1]: Starting Music Player Daemon... Jul 10 17:57:59 hi-fi sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 10 17:57:59 hi-fi sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 17:57:59 hi-fi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 10 17:57:59 hi-fi systemd[1]: mpd.service: Succeeded. Jul 10 17:57:59 hi-fi systemd[1]: Stopped Music Player Daemon. Jul 10 17:57:59 hi-fi systemd[1]: Starting Music Player Daemon... Jul 10 17:57:59 hi-fi volumio[972]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 17:57:59 hi-fi volumio[972]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 10 17:57:59 hi-fi volumio[972]: info: [1720591079529] CoreMusicLibrary::Adding element Last_100 Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 10 17:57:59 hi-fi volumio[972]: info: [1720591079535] CoreMusicLibrary::Adding element Webradio Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 10 17:57:59 hi-fi volumio[972]: info: Initializing BBC Radios Jul 10 17:57:59 hi-fi sudo[1209]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 10 17:57:59 hi-fi sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:57:59 hi-fi sudo[1209]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jul 10 17:57:59 hi-fi sudo[1209]: pam_unix(sudo:session): session closed for user root Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 17:57:59 hi-fi volumio[972]: info: Creating Spotify config file Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:57:59 hi-fi volumio[972]: info: [now-playing] ConfigUpdater: config is up to date. Jul 10 17:57:59 hi-fi volumio[972]: info: Loading i18n strings for locale en Jul 10 17:57:59 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 10 17:57:59 hi-fi volumio[972]: info: Volumio Calling Home Jul 10 17:58:00 hi-fi sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jul 10 17:58:00 hi-fi sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:58:00 hi-fi systemd[1]: Reloading. Jul 10 17:58:00 hi-fi volumio[972]: info: [now-playing] App is listening on port 4004. Jul 10 17:58:00 hi-fi volumio[972]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jul 10 17:58:00 hi-fi volumio[972]: info: MPD Permissions set Jul 10 17:58:00 hi-fi volumio[972]: info: MPD Permissions set Jul 10 17:58:00 hi-fi volumio[972]: info: Spotify config file written Jul 10 17:58:00 hi-fi sudo[1245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jul 10 17:58:00 hi-fi sudo[1245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 17:58:00 hi-fi volumio[972]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 17:58:00 hi-fi volumio[972]: info: Preload queue cleared Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 10 17:58:00 hi-fi volumio[972]: info: CoreStateMachine::ClearQueue Jul 10 17:58:00 hi-fi volumio[972]: info: CoreStateMachine::stop Jul 10 17:58:00 hi-fi volumio[972]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 17:58:00 hi-fi volumio[972]: info: CorePlayQueue::clearPlayQueue Jul 10 17:58:00 hi-fi volumio[972]: info: CorePlayQueue::saveQueue Jul 10 17:58:00 hi-fi volumio[972]: info: CoreCommandRouter::volumioPushQueue Jul 10 17:58:00 hi-fi volumio[972]: info: CoreStateMachine::addQueueItems Jul 10 17:58:00 hi-fi volumio[972]: info: CorePlayQueue::addQueueItems Jul 10 17:58:00 hi-fi volumio[972]: info: Preload queue cleared Jul 10 17:58:00 hi-fi volumio[972]: info: Adding Item to queue: music-library/NAS/PlexAmp/Kendrick Lamar/DAMN. (2017)/Kendrick Lamar - DAMN. - 01 - BLOOD.flac Jul 10 17:58:00 hi-fi volumio[972]: info: Exploding uri music-library/NAS/PlexAmp/Kendrick Lamar/DAMN. (2017)/Kendrick Lamar - DAMN. - 01 - BLOOD.flac in service mpd Jul 10 17:58:00 hi-fi 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. Jul 10 17:58:00 hi-fi volumio[972]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 17:58:01 hi-fi volumio[972]: TypeError: Cannot read property 'then' of undefined Jul 10 17:58:01 hi-fi volumio[972]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Jul 10 17:58:01 hi-fi volumio[972]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Jul 10 17:58:01 hi-fi volumio[972]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1365:16) Jul 10 17:58:01 hi-fi volumio[972]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jul 10 17:58:01 hi-fi volumio[972]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jul 10 17:58:01 hi-fi volumio[972]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Jul 10 17:58:01 hi-fi volumio[972]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Jul 10 17:58:01 hi-fi volumio[972]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Jul 10 17:58:01 hi-fi volumio[972]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:483:17) Jul 10 17:58:01 hi-fi volumio[972]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:139:33) Jul 10 17:58:01 hi-fi volumio[972]: at Socket.emit (events.js:315:20) Jul 10 17:58:01 hi-fi volumio[972]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 10 17:58:01 hi-fi volumio[972]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 10 17:58:01 hi-fi volumio[972]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 17:58:02 hi-fi sudo[1229]: pam_unix(sudo:session): session closed for user root Jul 10 17:58:02 hi-fi systemd[1]: Started go-librespot Daemon. Jul 10 17:58:02 hi-fi go-librespot[1263]: Librespot-go daemon starting... Jul 10 17:58:02 hi-fi sudo[1245]: pam_unix(sudo:session): session closed for user root Jul 10 17:58:02 hi-fi sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-10 17:57 Jul 10 17:58:02 hi-fi sudo[1266]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"