-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Sun 2025-02-23 19:15:38 +07. -- Feb 23 19:14:11 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 14; SM-S908E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 23 19:14:11 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 14; SM-S908E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 23 19:14:11 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 14; SM-S908E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 23 19:14:11 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 14; SM-S908E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Feb 23 19:14:11 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 19:14:12 volumio volumio[985]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 23 19:14:12 volumio volumio[985]: info: Received Get System Info Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:12 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:12 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:12 volumio volumio[985]: info: Listing playlists Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::volumioGetQueue Feb 23 19:14:12 volumio volumio[985]: info: CoreStateMachine::getQueue Feb 23 19:14:12 volumio volumio[985]: info: CorePlayQueue::getQueue Feb 23 19:14:12 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 23 19:14:17 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:17 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:17 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:17 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:17 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:17 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:17 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35:3000 from 192.168.1.33 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 14 Feb 23 19:14:17 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:17 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:17 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 19:14:17 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 19:14:19 volumio sudo[2364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 19:14:19 volumio sudo[2364]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:14:19 volumio sudo[2364]: pam_unix(sudo:session): session closed for user root Feb 23 19:14:19 volumio sudo[2367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 19:14:19 volumio sudo[2367]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:14:19 volumio sudo[2367]: pam_unix(sudo:session): session closed for user root Feb 23 19:14:19 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 14; SM-S908E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Feb 23 19:14:19 volumio sudo[2370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 19:14:19 volumio sudo[2370]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:14:19 volumio sudo[2370]: pam_unix(sudo:session): session closed for user root Feb 23 19:14:19 volumio sudo[2373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 19:14:19 volumio sudo[2373]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:14:19 volumio sudo[2373]: pam_unix(sudo:session): session closed for user root Feb 23 19:14:19 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 14; SM-S908E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:20 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 19:14:20 volumio volumio[985]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 23 19:14:20 volumio volumio[985]: info: Received Get System Info Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:20 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:20 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:20 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:20 volumio volumio[985]: info: Listing playlists Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 19:14:20 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 23 19:14:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 23 19:14:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 19:14:21 volumio volumio[985]: info: Received Get System Info Feb 23 19:14:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:21 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:21 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:21 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:21 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:22 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:22 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 19:14:22 volumio volumio[985]: info: Received Get System Info Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:22 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:22 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:23 volumio volumio[985]: info: CoreCommandRouter::volumioGetQueue Feb 23 19:14:23 volumio volumio[985]: info: CoreStateMachine::getQueue Feb 23 19:14:23 volumio volumio[985]: info: CorePlayQueue::getQueue Feb 23 19:14:25 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Feb 23 19:14:25 volumio volumio[985]: info: browseTIDALUri took 247 milliseconds Feb 23 19:14:26 volumio volumio[985]: info: Preload queue cleared Feb 23 19:14:26 volumio volumio[985]: info: Preload queue cleared Feb 23 19:14:26 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:26 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:26 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:26 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:26 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:26 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:26 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:26 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:26 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:26 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:26 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:26 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:26 volumio go-librespot[1382]: time="2025-02-23T19:14:26+07:00" level=trace msg="received accesspoint ping" Feb 23 19:14:26 volumio go-librespot[1382]: time="2025-02-23T19:14:26+07:00" level=trace msg="received accesspoint pong ack" Feb 23 19:14:27 volumio go-librespot[1382]: time="2025-02-23T19:14:27+07:00" level=trace msg="sent dealer ping" Feb 23 19:14:27 volumio go-librespot[1382]: time="2025-02-23T19:14:27+07:00" level=trace msg="received dealer pong" Feb 23 19:14:27 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Feb 23 19:14:27 volumio volumio[985]: info: browseTIDALUri took 736 milliseconds Feb 23 19:14:28 volumio volumio[985]: info: Preload queue cleared Feb 23 19:14:28 volumio volumio[985]: info: Preload queue cleared Feb 23 19:14:28 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35:3000 from 192.168.1.33 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 16 Feb 23 19:14:29 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 23 19:14:39 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 19:14:39 volumio volumio[985]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 23 19:14:39 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 23 19:14:39 volumio volumio[985]: info: Received Get System Version Feb 23 19:14:39 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 19:14:39 volumio volumio[985]: info: Received Get System Info Feb 23 19:14:39 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:14:39 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:14:39 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:14:39 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:39 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:39 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:14:44 volumio volumio[985]: info: Tunnel connection is inactive, restarting it Feb 23 19:14:44 volumio volumio[985]: info: Starting Tunnel 1 Feb 23 19:14:44 volumio volumio[985]: info: Starting Tunnel Connection Checker Feb 23 19:14:44 volumio sudo[2457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 23 19:14:44 volumio sudo[2457]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:14:44 volumio autossh[1891]: received signal to exit (15) Feb 23 19:14:44 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Feb 23 19:14:44 volumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Feb 23 19:14:44 volumio systemd[1]: sshtunnel.service: Succeeded. Feb 23 19:14:44 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Feb 23 19:14:44 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 19:14:44 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 19:14:44 volumio systemd[1]: Started MyVolumio SSH Tunnel. Feb 23 19:14:44 volumio sudo[2457]: pam_unix(sudo:session): session closed for user root Feb 23 19:14:44 volumio autossh[2460]: port set to 0, monitoring disabled Feb 23 19:14:44 volumio autossh[2460]: starting ssh (count 1) Feb 23 19:14:44 volumio autossh[2460]: ssh child pid is 2463 Feb 23 19:14:44 volumio volumio[985]: info: Remote SSH Started Feb 23 19:14:44 volumio volumio[985]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Feb 23 19:14:44 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:14:44 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:14:44 volumio volumiossh-tunnel[2459]: Warning: Permanently added '[as1.myvolumio.org]:2222,[128.199.166.162]:2222' (RSA) to the list of known hosts. Feb 23 19:14:44 volumio volumiossh-tunnel[2459]: Warning: remote port forwarding failed for listen port 8091 Feb 23 19:14:57 volumio go-librespot[1382]: time="2025-02-23T19:14:57+07:00" level=trace msg="sent dealer ping" Feb 23 19:14:57 volumio go-librespot[1382]: time="2025-02-23T19:14:57+07:00" level=trace msg="received dealer pong" Feb 23 19:15:11 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:15:11 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:15:11 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:15:11 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:11 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:11 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:15:11 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35:3000 from 192.168.1.33 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Feb 23 19:15:11 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:11 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:11 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 19:15:11 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 19:15:15 volumio sudo[2520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 19:15:15 volumio sudo[2520]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:15 volumio sudo[2520]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:15 volumio sudo[2523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 19:15:15 volumio sudo[2523]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:15 volumio sudo[2523]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:15 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 14; SM-S908E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 23 19:15:16 volumio sudo[2526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 19:15:16 volumio sudo[2526]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:16 volumio sudo[2526]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:16 volumio sudo[2529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 19:15:16 volumio sudo[2529]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:16 volumio sudo[2529]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:16 volumio volumio[985]: verbose: New Socket.io Connection to 192.168.1.35 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 14; SM-S908E Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:16 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::volumioGetQueue Feb 23 19:15:16 volumio volumio[985]: info: CoreStateMachine::getQueue Feb 23 19:15:16 volumio volumio[985]: info: CorePlayQueue::getQueue Feb 23 19:15:16 volumio volumio[985]: info: Listing playlists Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 19:15:16 volumio volumio[985]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 23 19:15:16 volumio volumio[985]: info: Received Get System Info Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:15:16 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:16 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:16 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 19:15:16 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 23 19:15:17 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 23 19:15:18 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 19:15:18 volumio volumio[985]: info: Received Get System Info Feb 23 19:15:18 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:15:18 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:15:18 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:15:18 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:18 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:18 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:15:19 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 19:15:19 volumio volumio[985]: info: Received Get System Info Feb 23 19:15:19 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:15:19 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:15:19 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:15:19 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:19 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:19 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 23 19:15:22 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 19:15:26 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 23 19:15:27 volumio go-librespot[1382]: time="2025-02-23T19:15:27+07:00" level=trace msg="sent dealer ping" Feb 23 19:15:27 volumio go-librespot[1382]: time="2025-02-23T19:15:27+07:00" level=trace msg="received dealer pong" Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 19:15:35 volumio volumio[985]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 23 19:15:35 volumio volumio[985]: info: Received Get System Version Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 19:15:35 volumio volumio[985]: info: Received Get System Info Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 19:15:35 volumio volumio[985]: info: Discovery: Getting this device information Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:35 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 19:15:35 volumio volumio[985]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Feb 23 19:15:35 volumio volumio[985]: info: Preparing to save Alsa Options, stopping services first Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::volumioGetState Feb 23 19:15:35 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::volumioPause Feb 23 19:15:35 volumio volumio[985]: info: CoreStateMachine::pause Feb 23 19:15:35 volumio volumio[985]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"Headphones"},"i2s":true,"i2sid":{"value":"audiophonics-es9028q2m-dac","label":"Audiophonics I-Sabre ES9028Q2M"}} Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:35 volumio volumio[985]: info: Enabling I2S DAC: Audiophonics I-Sabre ES9028Q2M Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:35 volumio sudo[2568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Feb 23 19:15:35 volumio sudo[2568]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:35 volumio sudo[2568]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:35 volumio volumio[985]: info: No Overlays Loaded Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:35 volumio sudo[2571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay i-sabre-q2m Feb 23 19:15:35 volumio sudo[2571]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/status Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/i-sabre-codec@48/#sound-dai-cells Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/i-sabre-codec@48/compatible Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/i-sabre-codec@48/reg Feb 23 19:15:35 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/i-sabre-codec@48/status Feb 23 19:15:35 volumio sudo[2571]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:35 volumio volumio[985]: warn: Unable to locate the device Headphones a reboot may be required. Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:35 volumio volumio[985]: info: Found match in i2s Card Database: setting mixer Digital for card Audiophonics I-Sabre ES9028Q2M Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 23 19:15:35 volumio volumio[985]: info: Updating Volume Controller Parameters: Device: 2 Name: Audiophonics I-Sabre ES9028Q2M Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 23 19:15:35 volumio volumio[985]: info: Disabling external Volume Control Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 19:15:35 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Feb 23 19:15:35 volumio volumio[985]: info: Preparing to generate the ALSA configuration file Feb 23 19:15:35 volumio volumio[985]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 23 19:15:35 volumio volumio[985]: info: Reading ALSA contributions from plugins. Feb 23 19:15:35 volumio volumio[985]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Feb 23 19:15:36 volumio volumio[985]: info: I2S Param [object Object] successfully enabled Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 19:15:36 volumio volumio[985]: info: Getting Alsa Cards List without I2S DAC Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:36 volumio volumio[985]: Invalid card number. Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 19:15:36 volumio volumio[985]: info: VolumeController:: Volume=undefined Mute =false Feb 23 19:15:36 volumio volumio[985]: info: CoreStateMachine::pushState Feb 23 19:15:36 volumio volumio[985]: info: CorePlayQueue::getTrack 0 Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::volumioPushState Feb 23 19:15:36 volumio volumio[985]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Feb 23 19:15:36 volumio volumio[985]: info: Asound.conf file written Feb 23 19:15:36 volumio sudo[2601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 23 19:15:36 volumio sudo[2601]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:36 volumio sudo[2601]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:36 volumio volumio[985]: info: Output device has changed, restarting MPD Feb 23 19:15:36 volumio sudo[2607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 19:15:36 volumio sudo[2607]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:36 volumio volumio[985]: info: Output device has changed, restarting Shairport Sync Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:36 volumio sudo[2607]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:36 volumio sudo[2610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 19:15:36 volumio sudo[2610]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:36 volumio systemd[1]: musicservicesshield.service: Succeeded. Feb 23 19:15:36 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Feb 23 19:15:36 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Feb 23 19:15:36 volumio systemd[1]: Stopping Music Player Daemon... Feb 23 19:15:36 volumio volumio[985]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 19:15:36 volumio volumio[985]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:36 volumio vtcs[1921]: [2025-02-23 19:15:36.696] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Feb 23 19:15:36 volumio vtcs[1921]: [2025-02-23 19:15:36.697] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Feb 23 19:15:36 volumio volumio[985]: info: Output device has changed, restarting MPD Feb 23 19:15:36 volumio sudo[2618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 23 19:15:36 volumio sudo[2618]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:36 volumio volumio[985]: info: Output device has changed, restarting Shairport Sync Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:36 volumio sudo[2621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 19:15:36 volumio sudo[2621]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:36 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Feb 23 19:15:36 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 23 19:15:36 volumio systemd[1]: vtcs.service: Succeeded. Feb 23 19:15:36 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Feb 23 19:15:36 volumio sudo[2623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 19:15:36 volumio sudo[2623]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:36 volumio sudo[2621]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:36 volumio sudo[2618]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:36 volumio volumio[985]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 19:15:36 volumio volumio[985]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 23 19:15:36 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:36 volumio sudo[2633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 23 19:15:36 volumio sudo[2633]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:37 volumio sudo[2635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 23 19:15:37 volumio sudo[2635]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:37 volumio sudo[2633]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:37 volumio sudo[2639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 23 19:15:37 volumio sudo[2639]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:37 volumio sudo[2635]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 19:15:37 volumio sudo[2639]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 19:15:37 volumio systemd[1]: mpd.service: Succeeded. Feb 23 19:15:37 volumio systemd[1]: Stopped Music Player Daemon. Feb 23 19:15:37 volumio volumio[985]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Feb 23 19:15:37 volumio volumio[985]: info: MPD Permissions set Feb 23 19:15:37 volumio volumio[985]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Feb 23 19:15:37 volumio volumio[985]: info: MPD Permissions set Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio systemd[1]: Starting Music Player Daemon... Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 19:15:37 volumio volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 19:15:37 volumio volumio[985]: info: Starting Shairport Sync Feb 23 19:15:37 volumio volumio[985]: info: Starting Shairport Sync Feb 23 19:15:37 volumio sudo[2654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 19:15:37 volumio sudo[2654]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:37 volumio volumio[985]: info: Preparing to generate the ALSA configuration file Feb 23 19:15:37 volumio sudo[2657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 19:15:37 volumio sudo[2657]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 19:15:37 volumio sudo[2644]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 19:15:37 volumio sudo[2644]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 19:15:37 volumio systemd[1]: shairport-sync.service: Succeeded. Feb 23 19:15:37 volumio sudo[2644]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 19:15:37 volumio volumio[985]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Feb 23 19:15:37 volumio volumio[985]: info: Reading ALSA contributions from plugins. Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 19:15:37 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 19:15:37 volumio volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 19:15:37 volumio volumio[985]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Feb 23 19:15:37 volumio sudo[2654]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:37 volumio volumio[985]: info: PLUGIN onReboot : networkfs Feb 23 19:15:37 volumio volumio[985]: info: PLUGIN onReboot : audiophonicsonoff Feb 23 19:15:37 volumio volumio[985]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 19:15:37 volumio volumio[985]: TypeError: Cannot read property 'writeSync' of undefined Feb 23 19:15:37 volumio volumio[985]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_hardware/audiophonicsonoff/index.js:40:25) Feb 23 19:15:37 volumio volumio[985]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Feb 23 19:15:37 volumio volumio[985]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Feb 23 19:15:37 volumio volumio[985]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 23 19:15:37 volumio volumio[985]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 23 19:15:37 volumio volumio[985]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Feb 23 19:15:37 volumio volumio[985]: at CoreCommandRouter.reboot (/volumio/app/index.js:1344:22) Feb 23 19:15:37 volumio volumio[985]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Feb 23 19:15:37 volumio volumio[985]: at Socket.emit (events.js:315:20) Feb 23 19:15:37 volumio volumio[985]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Feb 23 19:15:37 volumio volumio[985]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Feb 23 19:15:37 volumio volumio[985]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 19:15:37 volumio sudo[2657]: pam_unix(sudo:session): session closed for user root Feb 23 19:15:38 volumio sudo[2687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 19:14 Feb 23 19:15:38 volumio sudo[2687]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"