-- Logs begin at Thu 2019-02-14 18:11:59 HKT, end at Tue 2024-11-26 02:29:00 HKT. -- Nov 26 02:28:00 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 26 02:28:00 volumio volumio[1134]: info: CURURI: music-library/INTERNAL/FusionDsp/tools Nov 26 02:28:00 volumio volumio[1134]: error: Failed LSINFO: null Nov 26 02:28:00 volumio volumio[1134]: info: Preload queue cleared Nov 26 02:28:00 volumio volumio[1134]: 0+0 records in Nov 26 02:28:00 volumio volumio[1134]: 0+0 records out Nov 26 02:28:00 volumio volumio[1134]: 0 bytes copied, 0.000221589 s, 0.0 kB/s Nov 26 02:28:00 volumio volumio[1134]: info: camilladsp spawned new process with pid 3896, instance 1, run: true Nov 26 02:28:01 volumio volumio[1134]: 0+0 records in Nov 26 02:28:01 volumio volumio[1134]: 0+0 records out Nov 26 02:28:01 volumio volumio[1134]: 0 bytes copied, 0.000211219 s, 0.0 kB/s Nov 26 02:28:01 volumio volumio[1134]: info: camilladsp spawned new process with pid 3915, instance 1, run: true Nov 26 02:28:02 volumio volumio[1134]: 0+0 records in Nov 26 02:28:02 volumio volumio[1134]: 0+0 records out Nov 26 02:28:02 volumio volumio[1134]: 0 bytes copied, 0.000216053 s, 0.0 kB/s Nov 26 02:28:02 volumio volumio[1134]: info: camilladsp spawned new process with pid 3923, instance 1, run: true Nov 26 02:28:04 volumio volumio[1134]: 0+0 records in Nov 26 02:28:04 volumio volumio[1134]: 0+0 records out Nov 26 02:28:04 volumio volumio[1134]: 0 bytes copied, 0.000216275 s, 0.0 kB/s Nov 26 02:28:04 volumio volumio[1134]: info: camilladsp spawned new process with pid 3928, instance 1, run: true Nov 26 02:28:04 volumio sudo[3932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 02:28:04 volumio sudo[3932]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 02:28:04 volumio sudo[3932]: pam_unix(sudo:session): session closed for user root Nov 26 02:28:04 volumio sudo[3935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 02:28:04 volumio sudo[3935]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 02:28:04 volumio sudo[3935]: pam_unix(sudo:session): session closed for user root Nov 26 02:28:04 volumio volumio[1134]: verbose: New Socket.io Connection to 192.168.68.51 from 192.168.68.56 UA: Mozilla/5.0 (Linux; Android 13; 23013PC75G Build/TKQ1.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6848.2 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::volumioGetVisibleSources Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 26 02:28:04 volumio sudo[3938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 02:28:04 volumio sudo[3938]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 02:28:04 volumio sudo[3938]: pam_unix(sudo:session): session closed for user root Nov 26 02:28:04 volumio sudo[3941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 02:28:04 volumio sudo[3941]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 02:28:04 volumio sudo[3941]: pam_unix(sudo:session): session closed for user root Nov 26 02:28:04 volumio volumio[1134]: verbose: New Socket.io Connection to 192.168.68.51 from 192.168.68.56 UA: Mozilla/5.0 (Linux; Android 13; 23013PC75G Build/TKQ1.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6848.2 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 26 02:28:04 volumio volumio[1134]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 26 02:28:04 volumio volumio[1134]: info: Listing playlists Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 26 02:28:04 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 26 02:28:05 volumio volumio[1134]: 0+0 records in Nov 26 02:28:05 volumio volumio[1134]: 0+0 records out Nov 26 02:28:05 volumio volumio[1134]: 0 bytes copied, 0.000219997 s, 0.0 kB/s Nov 26 02:28:05 volumio volumio[1134]: info: camilladsp spawned new process with pid 3946, instance 1, run: true Nov 26 02:28:05 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 26 02:28:05 volumio volumio[1134]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 26 02:28:05 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 26 02:28:05 volumio volumio[1134]: info: Received Get System Version Nov 26 02:28:05 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 02:28:05 volumio volumio[1134]: info: Received Get System Info Nov 26 02:28:05 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:05 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:05 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:05 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:05 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:06 volumio volumio[1134]: 0+0 records in Nov 26 02:28:06 volumio volumio[1134]: 0+0 records out Nov 26 02:28:06 volumio volumio[1134]: 0 bytes copied, 0.000218923 s, 0.0 kB/s Nov 26 02:28:06 volumio volumio[1134]: info: camilladsp spawned new process with pid 3951, instance 1, run: true Nov 26 02:28:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 26 02:28:06 volumio volumio[1134]: info: Received Get System Info Nov 26 02:28:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:06 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:06 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:06 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:07 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 26 02:28:07 volumio volumio[1134]: info: Received Get System Info Nov 26 02:28:07 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:07 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:07 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:07 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:07 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:07 volumio volumio[1134]: 0+0 records in Nov 26 02:28:07 volumio volumio[1134]: 0+0 records out Nov 26 02:28:07 volumio volumio[1134]: 0 bytes copied, 0.000215887 s, 0.0 kB/s Nov 26 02:28:07 volumio volumio[1134]: info: camilladsp spawned new process with pid 3956, instance 1, run: true Nov 26 02:28:08 volumio volumio[1134]: 0+0 records in Nov 26 02:28:08 volumio volumio[1134]: 0+0 records out Nov 26 02:28:08 volumio volumio[1134]: 0 bytes copied, 0.000216016 s, 0.0 kB/s Nov 26 02:28:08 volumio volumio[1134]: info: camilladsp spawned new process with pid 3961, instance 1, run: true Nov 26 02:28:09 volumio volumio[1134]: 0+0 records in Nov 26 02:28:09 volumio volumio[1134]: 0+0 records out Nov 26 02:28:09 volumio volumio[1134]: 0 bytes copied, 0.000216997 s, 0.0 kB/s Nov 26 02:28:09 volumio volumio[1134]: info: camilladsp spawned new process with pid 3966, instance 1, run: true Nov 26 02:28:10 volumio volumio[1134]: 0+0 records in Nov 26 02:28:10 volumio volumio[1134]: 0+0 records out Nov 26 02:28:10 volumio volumio[1134]: 0 bytes copied, 0.000242348 s, 0.0 kB/s Nov 26 02:28:10 volumio volumio[1134]: info: camilladsp spawned new process with pid 3971, instance 1, run: true Nov 26 02:28:11 volumio volumio[1134]: 0+0 records in Nov 26 02:28:11 volumio volumio[1134]: 0+0 records out Nov 26 02:28:11 volumio volumio[1134]: 0 bytes copied, 0.000217905 s, 0.0 kB/s Nov 26 02:28:11 volumio volumio[1134]: info: camilladsp spawned new process with pid 3990, instance 1, run: true Nov 26 02:28:12 volumio volumio[1134]: 0+0 records in Nov 26 02:28:12 volumio volumio[1134]: 0+0 records out Nov 26 02:28:12 volumio volumio[1134]: 0 bytes copied, 0.000231015 s, 0.0 kB/s Nov 26 02:28:12 volumio volumio[1134]: info: camilladsp spawned new process with pid 3999, instance 1, run: true Nov 26 02:28:13 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:13 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:13 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:13 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:13 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:13 volumio volumio[1134]: 0+0 records in Nov 26 02:28:13 volumio volumio[1134]: 0+0 records out Nov 26 02:28:13 volumio volumio[1134]: 0 bytes copied, 0.000222886 s, 0.0 kB/s Nov 26 02:28:13 volumio volumio[1134]: info: camilladsp spawned new process with pid 4004, instance 1, run: true Nov 26 02:28:14 volumio volumio[1134]: 0+0 records in Nov 26 02:28:14 volumio volumio[1134]: 0+0 records out Nov 26 02:28:14 volumio volumio[1134]: 0 bytes copied, 0.00041292 s, 0.0 kB/s Nov 26 02:28:14 volumio volumio[1134]: info: camilladsp spawned new process with pid 4009, instance 1, run: true Nov 26 02:28:14 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:14 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:14 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:14 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:14 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:15 volumio volumio[1134]: 0+0 records in Nov 26 02:28:15 volumio volumio[1134]: 0+0 records out Nov 26 02:28:15 volumio volumio[1134]: 0 bytes copied, 0.000213108 s, 0.0 kB/s Nov 26 02:28:15 volumio volumio[1134]: info: camilladsp spawned new process with pid 4014, instance 1, run: true Nov 26 02:28:16 volumio sudo[4018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 02:28:16 volumio sudo[4018]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 02:28:16 volumio sudo[4018]: pam_unix(sudo:session): session closed for user root Nov 26 02:28:16 volumio sudo[4021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 02:28:16 volumio sudo[4021]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 02:28:16 volumio sudo[4021]: pam_unix(sudo:session): session closed for user root Nov 26 02:28:16 volumio volumio[1134]: verbose: New Socket.io Connection to 192.168.68.51 from 192.168.68.56 UA: Mozilla/5.0 (Linux; Android 13; 23013PC75G Build/TKQ1.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6848.2 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Nov 26 02:28:16 volumio volumio[1134]: info: CoreCommandRouter::volumioGetVisibleSources Nov 26 02:28:16 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 02:28:16 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:16 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 26 02:28:16 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 26 02:28:16 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 26 02:28:16 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 26 02:28:16 volumio volumio[1134]: 0+0 records in Nov 26 02:28:16 volumio volumio[1134]: 0+0 records out Nov 26 02:28:16 volumio volumio[1134]: 0 bytes copied, 0.000222497 s, 0.0 kB/s Nov 26 02:28:16 volumio volumio[1134]: info: camilladsp spawned new process with pid 4025, instance 1, run: true Nov 26 02:28:17 volumio sudo[4029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 26 02:28:17 volumio sudo[4029]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 02:28:17 volumio sudo[4029]: pam_unix(sudo:session): session closed for user root Nov 26 02:28:17 volumio sudo[4032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 26 02:28:17 volumio sudo[4032]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 02:28:17 volumio sudo[4032]: pam_unix(sudo:session): session closed for user root Nov 26 02:28:17 volumio volumio[1134]: verbose: New Socket.io Connection to 192.168.68.51 from 192.168.68.56 UA: Mozilla/5.0 (Linux; Android 13; 23013PC75G Build/TKQ1.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6848.2 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Nov 26 02:28:17 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:17 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 26 02:28:17 volumio volumio[1134]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 26 02:28:17 volumio volumio[1134]: info: Listing playlists Nov 26 02:28:17 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 26 02:28:17 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 26 02:28:17 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 26 02:28:17 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 26 02:28:17 volumio volumio[1134]: 0+0 records in Nov 26 02:28:17 volumio volumio[1134]: 0+0 records out Nov 26 02:28:17 volumio volumio[1134]: 0 bytes copied, 0.000225627 s, 0.0 kB/s Nov 26 02:28:17 volumio volumio[1134]: info: camilladsp spawned new process with pid 4036, instance 1, run: true Nov 26 02:28:18 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 26 02:28:18 volumio volumio[1134]: info: Received Get System Info Nov 26 02:28:18 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:18 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:18 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:18 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:18 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:18 volumio volumio[1134]: 0+0 records in Nov 26 02:28:18 volumio volumio[1134]: 0+0 records out Nov 26 02:28:18 volumio volumio[1134]: 0 bytes copied, 0.000221997 s, 0.0 kB/s Nov 26 02:28:18 volumio volumio[1134]: info: camilladsp spawned new process with pid 4041, instance 1, run: true Nov 26 02:28:19 volumio volumio[1134]: 0+0 records in Nov 26 02:28:19 volumio volumio[1134]: 0+0 records out Nov 26 02:28:19 volumio volumio[1134]: 0 bytes copied, 0.000225015 s, 0.0 kB/s Nov 26 02:28:19 volumio volumio[1134]: info: camilladsp spawned new process with pid 4046, instance 1, run: true Nov 26 02:28:20 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 26 02:28:20 volumio volumio[1134]: info: Received Get System Info Nov 26 02:28:20 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:20 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:20 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:20 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:20 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:20 volumio volumio[1134]: 0+0 records in Nov 26 02:28:20 volumio volumio[1134]: 0+0 records out Nov 26 02:28:20 volumio volumio[1134]: 0 bytes copied, 0.000211886 s, 0.0 kB/s Nov 26 02:28:20 volumio volumio[1134]: info: camilladsp spawned new process with pid 4051, instance 1, run: true Nov 26 02:28:21 volumio volumio[1134]: 0+0 records in Nov 26 02:28:21 volumio volumio[1134]: 0+0 records out Nov 26 02:28:21 volumio volumio[1134]: 0 bytes copied, 0.000216127 s, 0.0 kB/s Nov 26 02:28:21 volumio volumio[1134]: info: camilladsp spawned new process with pid 4070, instance 1, run: true Nov 26 02:28:23 volumio volumio[1134]: 0+0 records in Nov 26 02:28:23 volumio volumio[1134]: 0+0 records out Nov 26 02:28:23 volumio volumio[1134]: 0 bytes copied, 0.000215238 s, 0.0 kB/s Nov 26 02:28:23 volumio volumio[1134]: info: camilladsp spawned new process with pid 4116, instance 1, run: true Nov 26 02:28:24 volumio volumio[1134]: 0+0 records in Nov 26 02:28:24 volumio volumio[1134]: 0+0 records out Nov 26 02:28:24 volumio volumio[1134]: 0 bytes copied, 0.000220034 s, 0.0 kB/s Nov 26 02:28:24 volumio volumio[1134]: info: camilladsp spawned new process with pid 4121, instance 1, run: true Nov 26 02:28:25 volumio volumio[1134]: 0+0 records in Nov 26 02:28:25 volumio volumio[1134]: 0+0 records out Nov 26 02:28:25 volumio volumio[1134]: 0 bytes copied, 0.000235071 s, 0.0 kB/s Nov 26 02:28:25 volumio volumio[1134]: info: camilladsp spawned new process with pid 4126, instance 1, run: true Nov 26 02:28:25 volumio volumio[1134]: info: VolumeController::SetAlsaVolume58 Nov 26 02:28:26 volumio volumio[1134]: info: CoreStateMachine::pushState Nov 26 02:28:26 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 02:28:26 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState Nov 26 02:28:26 volumio volumio[1134]: info: MRS: Pushing multiroomSync output update for this device Nov 26 02:28:26 volumio volumio[1134]: info: MRS: Pushing multiroomSync output Nov 26 02:28:26 volumio volumio[1134]: info: [GPIO_Control] Status changed: play Nov 26 02:28:26 volumio volumio[1134]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Nov 26 02:28:26 volumio volumio[1134]: SPOTIFY: SPOTIFY VOLUME 77 Nov 26 02:28:26 volumio volumio[1134]: SPOTIFY: VOLUMIO VOLUME 58 Nov 26 02:28:26 volumio volumio[1134]: SPOTIFY: DELTA VOLUME ENOUGH: true Nov 26 02:28:26 volumio volumio[1134]: info: Setting Spotify Volume from Volumio: 58 Nov 26 02:28:26 volumio volumio[1134]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: xcb_connection_has_error() returned true Nov 26 02:28:26 volumio volumio[1134]: amixer: Unable to find simple control 'Digital',0 Nov 26 02:28:26 volumio volumio[1134]: 0+0 records in Nov 26 02:28:26 volumio volumio[1134]: 0+0 records out Nov 26 02:28:26 volumio volumio[1134]: 0 bytes copied, 0.00021596 s, 0.0 kB/s Nov 26 02:28:26 volumio volumio[1134]: info: camilladsp spawned new process with pid 4132, instance 1, run: true Nov 26 02:28:27 volumio volumio[1134]: info: VolumeController::SetAlsaVolume89 Nov 26 02:28:27 volumio volumio[1134]: info: CoreStateMachine::pushState Nov 26 02:28:27 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 02:28:27 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState Nov 26 02:28:27 volumio volumio[1134]: info: MRS: Pushing multiroomSync output update for this device Nov 26 02:28:27 volumio volumio[1134]: info: MRS: Pushing multiroomSync output Nov 26 02:28:27 volumio volumio[1134]: info: [GPIO_Control] Status changed: play Nov 26 02:28:27 volumio volumio[1134]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Nov 26 02:28:27 volumio volumio[1134]: SPOTIFY: SPOTIFY VOLUME 58 Nov 26 02:28:27 volumio volumio[1134]: SPOTIFY: VOLUMIO VOLUME 89 Nov 26 02:28:27 volumio volumio[1134]: SPOTIFY: DELTA VOLUME ENOUGH: true Nov 26 02:28:27 volumio volumio[1134]: info: Setting Spotify Volume from Volumio: 89 Nov 26 02:28:27 volumio volumio[1134]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: xcb_connection_has_error() returned true Nov 26 02:28:27 volumio volumio[1134]: amixer: Unable to find simple control 'Digital',0 Nov 26 02:28:27 volumio volumio[1134]: 0+0 records in Nov 26 02:28:27 volumio volumio[1134]: 0+0 records out Nov 26 02:28:27 volumio volumio[1134]: 0 bytes copied, 0.000243386 s, 0.0 kB/s Nov 26 02:28:27 volumio volumio[1134]: info: camilladsp spawned new process with pid 4138, instance 1, run: true Nov 26 02:28:27 volumio volumio[1134]: info: VolumeController::SetAlsaVolume71 Nov 26 02:28:27 volumio volumio[1134]: info: CoreStateMachine::pushState Nov 26 02:28:27 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 02:28:27 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState Nov 26 02:28:27 volumio volumio[1134]: info: MRS: Pushing multiroomSync output update for this device Nov 26 02:28:27 volumio volumio[1134]: info: MRS: Pushing multiroomSync output Nov 26 02:28:27 volumio volumio[1134]: info: [GPIO_Control] Status changed: play Nov 26 02:28:27 volumio volumio[1134]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Nov 26 02:28:27 volumio volumio[1134]: SPOTIFY: SPOTIFY VOLUME 89 Nov 26 02:28:27 volumio volumio[1134]: SPOTIFY: VOLUMIO VOLUME 71 Nov 26 02:28:27 volumio volumio[1134]: SPOTIFY: DELTA VOLUME ENOUGH: true Nov 26 02:28:27 volumio volumio[1134]: info: Setting Spotify Volume from Volumio: 71 Nov 26 02:28:27 volumio volumio[1134]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: xcb_connection_has_error() returned true Nov 26 02:28:27 volumio volumio[1134]: amixer: Unable to find simple control 'Digital',0 Nov 26 02:28:28 volumio volumio[1134]: 0+0 records in Nov 26 02:28:28 volumio volumio[1134]: 0+0 records out Nov 26 02:28:28 volumio volumio[1134]: 0 bytes copied, 0.000216738 s, 0.0 kB/s Nov 26 02:28:28 volumio volumio[1134]: info: camilladsp spawned new process with pid 4144, instance 1, run: true Nov 26 02:28:29 volumio volumio[1134]: SPOTIFY: SETTING SPOTIFY VOLUME 71 Nov 26 02:28:29 volumio volumio[1134]: info: Sending Spotify command with payload to local API: /player/volume Nov 26 02:28:29 volumio go-librespot[1427]: time="2024-11-26T02:28:29+08:00" level=debug msg="update volume to 46529/65535" Nov 26 02:28:29 volumio volumio[1134]: 0+0 records in Nov 26 02:28:29 volumio volumio[1134]: 0+0 records out Nov 26 02:28:29 volumio volumio[1134]: 0 bytes copied, 0.000213256 s, 0.0 kB/s Nov 26 02:28:29 volumio volumio[1134]: info: camilladsp spawned new process with pid 4149, instance 1, run: true Nov 26 02:28:29 volumio go-librespot[1427]: time="2024-11-26T02:28:29+08:00" level=debug msg="put connect state because VOLUME_CHANGED" Nov 26 02:28:29 volumio go-librespot[1427]: time="2024-11-26T02:28:29+08:00" level=trace msg="emitting websocket event: volume" Nov 26 02:28:29 volumio volumio[1134]: SPOTIFY: received: {"type":"volume","data":{"value":71,"max":100}} Nov 26 02:28:29 volumio volumio[1134]: SPOTIFY: RECEIVED SPOTIFY VOLUME 71 Nov 26 02:28:30 volumio volumio[1134]: 0+0 records in Nov 26 02:28:30 volumio volumio[1134]: 0+0 records out Nov 26 02:28:30 volumio volumio[1134]: 0 bytes copied, 0.00012048 s, 0.0 kB/s Nov 26 02:28:30 volumio volumio[1134]: info: camilladsp spawned new process with pid 4154, instance 1, run: true Nov 26 02:28:31 volumio volumio[1134]: 0+0 records in Nov 26 02:28:31 volumio volumio[1134]: 0+0 records out Nov 26 02:28:31 volumio volumio[1134]: 0 bytes copied, 0.00021996 s, 0.0 kB/s Nov 26 02:28:31 volumio volumio[1134]: info: camilladsp spawned new process with pid 4173, instance 1, run: true Nov 26 02:28:32 volumio volumio[1134]: 0+0 records in Nov 26 02:28:32 volumio volumio[1134]: 0+0 records out Nov 26 02:28:32 volumio volumio[1134]: 0 bytes copied, 0.000260219 s, 0.0 kB/s Nov 26 02:28:32 volumio volumio[1134]: info: camilladsp spawned new process with pid 4182, instance 1, run: true Nov 26 02:28:33 volumio volumio[1134]: 0+0 records in Nov 26 02:28:33 volumio volumio[1134]: 0+0 records out Nov 26 02:28:33 volumio volumio[1134]: 0 bytes copied, 0.000210701 s, 0.0 kB/s Nov 26 02:28:33 volumio volumio[1134]: info: camilladsp spawned new process with pid 4187, instance 1, run: true Nov 26 02:28:34 volumio volumio[1134]: 0+0 records in Nov 26 02:28:34 volumio volumio[1134]: 0+0 records out Nov 26 02:28:34 volumio volumio[1134]: 0 bytes copied, 0.000217219 s, 0.0 kB/s Nov 26 02:28:34 volumio volumio[1134]: info: camilladsp spawned new process with pid 4192, instance 1, run: true Nov 26 02:28:34 volumio volumio[1134]: info: VolumeController::SetAlsaVolume98 Nov 26 02:28:34 volumio volumio[1134]: info: CoreStateMachine::pushState Nov 26 02:28:34 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 02:28:34 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState Nov 26 02:28:34 volumio volumio[1134]: info: MRS: Pushing multiroomSync output update for this device Nov 26 02:28:34 volumio volumio[1134]: info: MRS: Pushing multiroomSync output Nov 26 02:28:34 volumio volumio[1134]: info: [GPIO_Control] Status changed: play Nov 26 02:28:34 volumio volumio[1134]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98 Nov 26 02:28:34 volumio volumio[1134]: SPOTIFY: SPOTIFY VOLUME 71 Nov 26 02:28:34 volumio volumio[1134]: SPOTIFY: VOLUMIO VOLUME 98 Nov 26 02:28:34 volumio volumio[1134]: SPOTIFY: DELTA VOLUME ENOUGH: true Nov 26 02:28:34 volumio volumio[1134]: info: Setting Spotify Volume from Volumio: 98 Nov 26 02:28:34 volumio volumio[1134]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: xcb_connection_has_error() returned true Nov 26 02:28:34 volumio volumio[1134]: amixer: Unable to find simple control 'Digital',0 Nov 26 02:28:35 volumio volumio[1134]: 0+0 records in Nov 26 02:28:35 volumio volumio[1134]: 0+0 records out Nov 26 02:28:35 volumio volumio[1134]: 0 bytes copied, 0.000220146 s, 0.0 kB/s Nov 26 02:28:35 volumio volumio[1134]: info: camilladsp spawned new process with pid 4198, instance 1, run: true Nov 26 02:28:35 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 26 02:28:35 volumio volumio[1134]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 26 02:28:35 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 26 02:28:35 volumio volumio[1134]: info: Received Get System Version Nov 26 02:28:35 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 26 02:28:35 volumio volumio[1134]: info: Received Get System Info Nov 26 02:28:35 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:35 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:35 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:35 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:35 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:36 volumio volumio[1134]: SPOTIFY: SETTING SPOTIFY VOLUME 98 Nov 26 02:28:36 volumio volumio[1134]: info: Sending Spotify command with payload to local API: /player/volume Nov 26 02:28:36 volumio go-librespot[1427]: time="2024-11-26T02:28:36+08:00" level=debug msg="update volume to 64224/65535" Nov 26 02:28:36 volumio go-librespot[1427]: time="2024-11-26T02:28:36+08:00" level=debug msg="put connect state because VOLUME_CHANGED" Nov 26 02:28:36 volumio go-librespot[1427]: time="2024-11-26T02:28:36+08:00" level=trace msg="emitting websocket event: volume" Nov 26 02:28:36 volumio volumio[1134]: 0+0 records in Nov 26 02:28:36 volumio volumio[1134]: 0+0 records out Nov 26 02:28:36 volumio volumio[1134]: 0 bytes copied, 0.000213812 s, 0.0 kB/s Nov 26 02:28:36 volumio volumio[1134]: info: camilladsp spawned new process with pid 4203, instance 1, run: true Nov 26 02:28:36 volumio volumio[1134]: SPOTIFY: received: {"type":"volume","data":{"value":98,"max":100}} Nov 26 02:28:36 volumio volumio[1134]: SPOTIFY: RECEIVED SPOTIFY VOLUME 98 Nov 26 02:28:37 volumio volumio[1134]: 0+0 records in Nov 26 02:28:37 volumio volumio[1134]: 0+0 records out Nov 26 02:28:37 volumio volumio[1134]: 0 bytes copied, 0.000217386 s, 0.0 kB/s Nov 26 02:28:37 volumio volumio[1134]: info: camilladsp spawned new process with pid 4208, instance 1, run: true Nov 26 02:28:38 volumio volumio[1134]: 0+0 records in Nov 26 02:28:38 volumio volumio[1134]: 0+0 records out Nov 26 02:28:38 volumio volumio[1134]: 0 bytes copied, 0.000261626 s, 0.0 kB/s Nov 26 02:28:38 volumio volumio[1134]: info: camilladsp spawned new process with pid 4213, instance 1, run: true Nov 26 02:28:39 volumio volumio[1134]: 0+0 records in Nov 26 02:28:39 volumio volumio[1134]: 0+0 records out Nov 26 02:28:39 volumio volumio[1134]: 0 bytes copied, 0.000229997 s, 0.0 kB/s Nov 26 02:28:39 volumio volumio[1134]: info: camilladsp spawned new process with pid 4218, instance 1, run: true Nov 26 02:28:40 volumio volumio[1134]: info: VolumeController::SetAlsaVolume55 Nov 26 02:28:40 volumio volumio[1134]: info: CoreStateMachine::pushState Nov 26 02:28:40 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 02:28:40 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState Nov 26 02:28:40 volumio volumio[1134]: info: MRS: Pushing multiroomSync output update for this device Nov 26 02:28:40 volumio volumio[1134]: info: MRS: Pushing multiroomSync output Nov 26 02:28:40 volumio volumio[1134]: info: [GPIO_Control] Status changed: play Nov 26 02:28:40 volumio volumio[1134]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55 Nov 26 02:28:40 volumio volumio[1134]: SPOTIFY: SPOTIFY VOLUME 98 Nov 26 02:28:40 volumio volumio[1134]: SPOTIFY: VOLUMIO VOLUME 55 Nov 26 02:28:40 volumio volumio[1134]: SPOTIFY: DELTA VOLUME ENOUGH: true Nov 26 02:28:40 volumio volumio[1134]: info: Setting Spotify Volume from Volumio: 55 Nov 26 02:28:40 volumio volumio[1134]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: xcb_connection_has_error() returned true Nov 26 02:28:40 volumio volumio[1134]: amixer: Unable to find simple control 'Digital',0 Nov 26 02:28:40 volumio volumio[1134]: info: VolumeController::SetAlsaVolume73 Nov 26 02:28:40 volumio volumio[1134]: info: CoreStateMachine::pushState Nov 26 02:28:40 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 02:28:40 volumio volumio[1134]: info: CoreCommandRouter::volumioPushState Nov 26 02:28:40 volumio volumio[1134]: info: MRS: Pushing multiroomSync output update for this device Nov 26 02:28:40 volumio volumio[1134]: info: MRS: Pushing multiroomSync output Nov 26 02:28:40 volumio volumio[1134]: 0+0 records in Nov 26 02:28:40 volumio volumio[1134]: 0+0 records out Nov 26 02:28:40 volumio volumio[1134]: 0 bytes copied, 0.00022083 s, 0.0 kB/s Nov 26 02:28:40 volumio volumio[1134]: info: camilladsp spawned new process with pid 4225, instance 1, run: true Nov 26 02:28:40 volumio volumio[1134]: info: [GPIO_Control] Status changed: play Nov 26 02:28:40 volumio volumio[1134]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Nov 26 02:28:40 volumio volumio[1134]: SPOTIFY: SPOTIFY VOLUME 55 Nov 26 02:28:40 volumio volumio[1134]: SPOTIFY: VOLUMIO VOLUME 73 Nov 26 02:28:40 volumio volumio[1134]: SPOTIFY: DELTA VOLUME ENOUGH: true Nov 26 02:28:40 volumio volumio[1134]: info: Setting Spotify Volume from Volumio: 73 Nov 26 02:28:40 volumio volumio[1134]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: xcb_connection_has_error() returned true Nov 26 02:28:40 volumio volumio[1134]: amixer: Unable to find simple control 'Digital',0 Nov 26 02:28:42 volumio volumio[1134]: 0+0 records in Nov 26 02:28:42 volumio volumio[1134]: 0+0 records out Nov 26 02:28:42 volumio volumio[1134]: 0 bytes copied, 0.000221127 s, 0.0 kB/s Nov 26 02:28:42 volumio volumio[1134]: info: camilladsp spawned new process with pid 4244, instance 1, run: true Nov 26 02:28:42 volumio volumio[1134]: SPOTIFY: SETTING SPOTIFY VOLUME 73 Nov 26 02:28:42 volumio volumio[1134]: info: Sending Spotify command with payload to local API: /player/volume Nov 26 02:28:42 volumio go-librespot[1427]: time="2024-11-26T02:28:42+08:00" level=debug msg="update volume to 47840/65535" Nov 26 02:28:42 volumio go-librespot[1427]: time="2024-11-26T02:28:42+08:00" level=debug msg="put connect state because VOLUME_CHANGED" Nov 26 02:28:42 volumio go-librespot[1427]: time="2024-11-26T02:28:42+08:00" level=trace msg="emitting websocket event: volume" Nov 26 02:28:42 volumio volumio[1134]: SPOTIFY: received: {"type":"volume","data":{"value":73,"max":100}} Nov 26 02:28:42 volumio volumio[1134]: SPOTIFY: RECEIVED SPOTIFY VOLUME 73 Nov 26 02:28:43 volumio volumio[1134]: 0+0 records in Nov 26 02:28:43 volumio volumio[1134]: 0+0 records out Nov 26 02:28:43 volumio volumio[1134]: 0 bytes copied, 0.000214423 s, 0.0 kB/s Nov 26 02:28:43 volumio volumio[1134]: info: camilladsp spawned new process with pid 4252, instance 1, run: true Nov 26 02:28:43 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 26 02:28:43 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 26 02:28:43 volumio volumio[1134]: info: Discovery: Getting this device information Nov 26 02:28:43 volumio volumio[1134]: info: CoreCommandRouter::volumioGetState Nov 26 02:28:43 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 26 02:28:44 volumio volumio[1134]: 0+0 records in Nov 26 02:28:44 volumio volumio[1134]: 0+0 records out Nov 26 02:28:44 volumio volumio[1134]: 0 bytes copied, 0.000214405 s, 0.0 kB/s Nov 26 02:28:44 volumio volumio[1134]: info: camilladsp spawned new process with pid 4257, instance 1, run: true Nov 26 02:28:44 volumio volumio[1134]: info: CoreCommandRouter::volumioGetVisibleSources Nov 26 02:28:44 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 26 02:28:44 volumio volumio[1134]: info: CoreCommandRouter::volumioGetQueue Nov 26 02:28:44 volumio volumio[1134]: info: CoreStateMachine::getQueue Nov 26 02:28:44 volumio volumio[1134]: info: CorePlayQueue::getQueue Nov 26 02:28:45 volumio volumio[1134]: 0+0 records in Nov 26 02:28:45 volumio volumio[1134]: 0+0 records out Nov 26 02:28:45 volumio volumio[1134]: 0 bytes copied, 0.00026496 s, 0.0 kB/s Nov 26 02:28:45 volumio volumio[1134]: info: camilladsp spawned new process with pid 4262, instance 1, run: true Nov 26 02:28:46 volumio volumio[1134]: 0+0 records in Nov 26 02:28:46 volumio volumio[1134]: 0+0 records out Nov 26 02:28:46 volumio volumio[1134]: 0 bytes copied, 0.000240256 s, 0.0 kB/s Nov 26 02:28:46 volumio volumio[1134]: info: camilladsp spawned new process with pid 4267, instance 1, run: true Nov 26 02:28:46 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 26 02:28:46 volumio volumio[1134]: info: Preload queue cleared Nov 26 02:28:47 volumio volumio[1134]: 0+0 records in Nov 26 02:28:47 volumio volumio[1134]: 0+0 records out Nov 26 02:28:47 volumio volumio[1134]: 0 bytes copied, 0.000217497 s, 0.0 kB/s Nov 26 02:28:47 volumio volumio[1134]: info: camilladsp spawned new process with pid 4272, instance 1, run: true Nov 26 02:28:48 volumio volumio[1134]: 0+0 records in Nov 26 02:28:48 volumio volumio[1134]: 0+0 records out Nov 26 02:28:48 volumio volumio[1134]: 0 bytes copied, 0.000221312 s, 0.0 kB/s Nov 26 02:28:48 volumio volumio[1134]: info: camilladsp spawned new process with pid 4277, instance 1, run: true Nov 26 02:28:49 volumio volumio[1134]: 0+0 records in Nov 26 02:28:49 volumio volumio[1134]: 0+0 records out Nov 26 02:28:49 volumio volumio[1134]: 0 bytes copied, 0.000102572 s, 0.0 kB/s Nov 26 02:28:49 volumio volumio[1134]: info: camilladsp spawned new process with pid 4282, instance 1, run: true Nov 26 02:28:50 volumio volumio[1134]: 0+0 records in Nov 26 02:28:50 volumio volumio[1134]: 0+0 records out Nov 26 02:28:50 volumio volumio[1134]: 0 bytes copied, 0.000104017 s, 0.0 kB/s Nov 26 02:28:50 volumio volumio[1134]: info: camilladsp spawned new process with pid 4287, instance 1, run: true Nov 26 02:28:51 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 26 02:28:51 volumio volumio[1134]: 0+0 records in Nov 26 02:28:51 volumio volumio[1134]: 0+0 records out Nov 26 02:28:51 volumio volumio[1134]: 0 bytes copied, 0.000245515 s, 0.0 kB/s Nov 26 02:28:51 volumio volumio[1134]: info: camilladsp spawned new process with pid 4306, instance 1, run: true Nov 26 02:28:51 volumio volumio[1134]: info: Preload queue cleared Nov 26 02:28:52 volumio volumio[1134]: 0+0 records in Nov 26 02:28:52 volumio volumio[1134]: 0+0 records out Nov 26 02:28:52 volumio volumio[1134]: 0 bytes copied, 0.000294719 s, 0.0 kB/s Nov 26 02:28:52 volumio volumio[1134]: info: camilladsp spawned new process with pid 4315, instance 1, run: true Nov 26 02:28:53 volumio volumio[1134]: 0+0 records in Nov 26 02:28:53 volumio volumio[1134]: 0+0 records out Nov 26 02:28:53 volumio volumio[1134]: 0 bytes copied, 0.000215978 s, 0.0 kB/s Nov 26 02:28:53 volumio volumio[1134]: info: camilladsp spawned new process with pid 4320, instance 1, run: true Nov 26 02:28:54 volumio volumio[1134]: 0+0 records in Nov 26 02:28:54 volumio volumio[1134]: 0+0 records out Nov 26 02:28:54 volumio volumio[1134]: 0 bytes copied, 0.000239774 s, 0.0 kB/s Nov 26 02:28:54 volumio volumio[1134]: info: camilladsp spawned new process with pid 4325, instance 1, run: true Nov 26 02:28:55 volumio volumio[1134]: 0+0 records in Nov 26 02:28:55 volumio volumio[1134]: 0+0 records out Nov 26 02:28:55 volumio volumio[1134]: 0 bytes copied, 0.00021909 s, 0.0 kB/s Nov 26 02:28:55 volumio volumio[1134]: info: camilladsp spawned new process with pid 4330, instance 1, run: true Nov 26 02:28:56 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 26 02:28:56 volumio volumio[1134]: info: Preload queue cleared Nov 26 02:28:56 volumio volumio[1134]: 0+0 records in Nov 26 02:28:56 volumio volumio[1134]: 0+0 records out Nov 26 02:28:56 volumio volumio[1134]: 0 bytes copied, 0.000221108 s, 0.0 kB/s Nov 26 02:28:56 volumio volumio[1134]: info: camilladsp spawned new process with pid 4335, instance 1, run: true Nov 26 02:28:57 volumio volumio[1134]: 0+0 records in Nov 26 02:28:57 volumio volumio[1134]: 0+0 records out Nov 26 02:28:57 volumio volumio[1134]: 0 bytes copied, 0.000220034 s, 0.0 kB/s Nov 26 02:28:57 volumio volumio[1134]: info: camilladsp spawned new process with pid 4340, instance 1, run: true Nov 26 02:28:58 volumio volumio[1134]: 0+0 records in Nov 26 02:28:58 volumio volumio[1134]: 0+0 records out Nov 26 02:28:58 volumio volumio[1134]: 0 bytes copied, 0.000221701 s, 0.0 kB/s Nov 26 02:28:58 volumio volumio[1134]: info: camilladsp spawned new process with pid 4345, instance 1, run: true Nov 26 02:28:59 volumio volumio[1134]: 0+0 records in Nov 26 02:28:59 volumio volumio[1134]: 0+0 records out Nov 26 02:28:59 volumio volumio[1134]: 0 bytes copied, 0.000218775 s, 0.0 kB/s Nov 26 02:28:59 volumio volumio[1134]: info: camilladsp spawned new process with pid 4350, instance 1, run: true Nov 26 02:28:59 volumio volumio[1134]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 26 02:29:00 volumio volumio[1134]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 02:29:00 volumio volumio[1134]: TypeError: Cannot read property 'length' of undefined Nov 26 02:29:00 volumio volumio[1134]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Nov 26 02:29:00 volumio volumio[1134]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Nov 26 02:29:00 volumio volumio[1134]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Nov 26 02:29:00 volumio volumio[1134]: at Parser.emit (events.js:315:20) Nov 26 02:29:00 volumio volumio[1134]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Nov 26 02:29:00 volumio volumio[1134]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Nov 26 02:29:00 volumio volumio[1134]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Nov 26 02:29:00 volumio volumio[1134]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Nov 26 02:29:00 volumio volumio[1134]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Nov 26 02:29:00 volumio volumio[1134]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Nov 26 02:29:00 volumio volumio[1134]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Nov 26 02:29:00 volumio volumio[1134]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Nov 26 02:29:00 volumio volumio[1134]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Nov 26 02:29:00 volumio volumio[1134]: at IncomingMessage.emit (events.js:327:22) Nov 26 02:29:00 volumio volumio[1134]: at endReadableNT (internal/streams/readable.js:1327:12) Nov 26 02:29:00 volumio volumio[1134]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 26 02:29:00 volumio volumio[1134]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 02:29:00 volumio sudo[4362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 02:28 Nov 26 02:29:00 volumio sudo[4362]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"