-- Logs begin at Thu 2019-02-14 10:12:00 GMT, end at Wed 2024-09-04 11:34:44 BST. -- Sep 04 11:33:00 volumio volumio[982]: verbose: New Socket.io Connection to 192.168.1.153 from 192.168.1.52 UA: Mozilla/5.0 (Linux; Android 11; M2101K6G Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 04 11:33:00 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 11:33:00 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 04 11:33:00 volumio sudo[2672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 11:33:00 volumio sudo[2672]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:33:00 volumio sudo[2672]: pam_unix(sudo:session): session closed for user root Sep 04 11:33:00 volumio sudo[2675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 11:33:00 volumio sudo[2675]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:33:00 volumio sudo[2675]: pam_unix(sudo:session): session closed for user root Sep 04 11:33:00 volumio volumio[982]: verbose: New Socket.io Connection to 192.168.1.153 from 192.168.1.52 UA: Mozilla/5.0 (Linux; Android 11; M2101K6G Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 11:33:01 volumio volumio[982]: info: Received Get System Info Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:01 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:01 volumio volumio[982]: info: Listing playlists Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 04 11:33:01 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 04 11:33:02 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 11:33:02 volumio volumio[982]: info: Received Get System Info Sep 04 11:33:02 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:02 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:02 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:02 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:02 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:02 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 04 11:33:03 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 11:33:03 volumio volumio[982]: info: Received Get System Info Sep 04 11:33:03 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:03 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:03 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:03 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:03 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:11 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 11:33:13 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:13 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:13 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:13 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:13 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:13 volumio volumio[982]: verbose: New Socket.io Connection to 192.168.1.153:3000 from 192.168.1.52 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Sep 04 11:33:13 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:13 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 04 11:33:13 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 04 11:33:20 volumio sudo[2717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 11:33:20 volumio sudo[2717]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:33:20 volumio sudo[2717]: pam_unix(sudo:session): session closed for user root Sep 04 11:33:20 volumio sudo[2720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 11:33:20 volumio sudo[2720]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:33:20 volumio sudo[2720]: pam_unix(sudo:session): session closed for user root Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=trace msg="emitting websocket event: not_playing" Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:7dq6icAlynpBD6MSrXKh3A" Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:3HBpOyKIvfSKysKZyXlaVY","play_origin":"playlist"}} Sep 04 11:33:20 volumio volumio[982]: error: Failed to decode event: not_playing Sep 04 11:33:20 volumio volumio[982]: verbose: New Socket.io Connection to 192.168.1.153 from 192.168.1.52 UA: Mozilla/5.0 (Linux; Android 11; M2101K6G Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=trace msg="emitting websocket event: will_play" Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7dq6icAlynpBD6MSrXKh3A","play_origin":"playlist"}} Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=info msg="loaded track \"Seen and Not Seen\" (paused: false, position: 0ms, duration: 204533ms, prefetched: true)" uri="spotify:track:7dq6icAlynpBD6MSrXKh3A" Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=trace msg="scheduling prefetch in 174s" Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=trace msg="emitting websocket event: metadata" Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7dq6icAlynpBD6MSrXKh3A","name":"Seen and Not Seen","artist_names":["Talking Heads"],"album_name":"Remain in Light","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02e49a405217bda217816f7bf5","position":0,"duration":204533,"release_date":"year:1980 month:10 day:8","track_number":6,"disc_number":1}} Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Sep 04 11:33:20 volumio go-librespot[1190]: time="2024-09-04T11:33:20+01:00" level=trace msg="emitting websocket event: playing" Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7dq6icAlynpBD6MSrXKh3A","play_origin":"playlist"}} Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: PUSH STATE SPOTIFY Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: {"status":"play","service":"spop","title":"Seen and Not Seen","artist":"Talking Heads","album":"Remain in Light","albumart":"https://i.scdn.co/image/ab67616d00001e02e49a405217bda217816f7bf5","uri":"spotify:track:7dq6icAlynpBD6MSrXKh3A","trackType":"spotify","seek":0,"duration":204,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Sep 04 11:33:20 volumio volumio[982]: info: CoreCommandRouter::servicePushState Sep 04 11:33:20 volumio volumio[982]: info: CoreStateMachine::pushState Sep 04 11:33:20 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 11:33:20 volumio volumio[982]: info: CoreCommandRouter::volumioPushState Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 11:33:20 volumio sudo[2723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 11:33:20 volumio sudo[2723]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:33:20 volumio sudo[2723]: pam_unix(sudo:session): session closed for user root Sep 04 11:33:20 volumio sudo[2726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 11:33:20 volumio sudo[2726]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:33:20 volumio sudo[2726]: pam_unix(sudo:session): session closed for user root Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: PUSH STATE SPOTIFY Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: {"status":"play","service":"spop","title":"Seen and Not Seen","artist":"Talking Heads","album":"Remain in Light","albumart":"https://i.scdn.co/image/ab67616d00001e02e49a405217bda217816f7bf5","uri":"spotify:track:7dq6icAlynpBD6MSrXKh3A","trackType":"spotify","seek":0,"duration":204,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Sep 04 11:33:20 volumio volumio[982]: info: CoreCommandRouter::servicePushState Sep 04 11:33:20 volumio volumio[982]: info: CoreStateMachine::pushState Sep 04 11:33:20 volumio volumio[982]: info: CoreCommandRouter::volumioPushState Sep 04 11:33:20 volumio volumio[982]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Sep 04 11:33:21 volumio volumio[982]: verbose: New Socket.io Connection to 192.168.1.153 from 192.168.1.52 UA: Mozilla/5.0 (Linux; Android 11; M2101K6G Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 11:33:21 volumio volumio[982]: info: Received Get System Info Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:21 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:21 volumio volumio[982]: info: Listing playlists Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 04 11:33:21 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 04 11:33:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 11:33:22 volumio volumio[982]: info: Received Get System Info Sep 04 11:33:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:22 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:22 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 04 11:33:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 11:33:23 volumio volumio[982]: info: Received Get System Info Sep 04 11:33:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:23 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:23 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:23 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:25 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 11:33:25 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 04 11:33:31 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 11:33:33 volumio go-librespot[1190]: time="2024-09-04T11:33:33+01:00" level=debug msg="fetched chunk 4/15, size: 524288" uri="spotify:track:7dq6icAlynpBD6MSrXKh3A" Sep 04 11:33:39 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 04 11:33:39 volumio volumio[982]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 04 11:33:39 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 04 11:33:39 volumio volumio[982]: info: Received Get System Version Sep 04 11:33:39 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 11:33:39 volumio volumio[982]: info: Received Get System Info Sep 04 11:33:39 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:39 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:39 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:39 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:39 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:43 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:43 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:43 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:43 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:43 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:46 volumio go-librespot[1190]: time="2024-09-04T11:33:46+01:00" level=debug msg="fetched chunk 5/15, size: 524288" uri="spotify:track:7dq6icAlynpBD6MSrXKh3A" Sep 04 11:33:49 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:33:49 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:33:49 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:33:49 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:33:49 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:33:59 volumio go-librespot[1190]: time="2024-09-04T11:33:59+01:00" level=debug msg="fetched chunk 6/15, size: 524288" uri="spotify:track:7dq6icAlynpBD6MSrXKh3A" Sep 04 11:34:03 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:03 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:03 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:03 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:03 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:12 volumio go-librespot[1190]: time="2024-09-04T11:34:12+01:00" level=debug msg="fetched chunk 7/15, size: 524288" uri="spotify:track:7dq6icAlynpBD6MSrXKh3A" Sep 04 11:34:14 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:14 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:14 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:14 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:14 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:14 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:14 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:14 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:14 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:14 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:22 volumio volumio[982]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Sep 04 11:34:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:22 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:22 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:22 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:24 volumio volumio[982]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Sep 04 11:34:24 volumio volumio[982]: info: Folder /tmp/plugins removed Sep 04 11:34:24 volumio volumio[982]: info: Check plugin dependencies Sep 04 11:34:24 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 11:34:24 volumio volumio[982]: info: Checking if plugin already exists Sep 04 11:34:24 volumio volumio[982]: info: Rename folder Sep 04 11:34:24 volumio volumio[982]: info: Folder /tmp/downloaded_plugin.zip removed Sep 04 11:34:24 volumio volumio[982]: info: Move to category Sep 04 11:34:25 volumio volumio[982]: info: Checking if install.sh is present Sep 04 11:34:25 volumio volumio[982]: info: Executing install.sh Sep 04 11:34:25 volumio sudo[2786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Sep 04 11:34:25 volumio sudo[2786]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:25 volumio volumio[982]: info: creating filters folder and copying demo filters Sep 04 11:34:25 volumio volumio[982]: info: copying demo flters Sep 04 11:34:25 volumio volumio[982]: info: Installing/fusiondsp dependencies Sep 04 11:34:25 volumio sudo[2807]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Sep 04 11:34:25 volumio sudo[2807]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:26 volumio volumio[982]: info: Get:1 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB] Sep 04 11:34:26 volumio volumio[982]: info: Get:2 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] Sep 04 11:34:26 volumio volumio[982]: info: Get:3 https://deb.nodesource.com/node_14.x buster InRelease [4584 B] Sep 04 11:34:26 volumio go-librespot[1190]: time="2024-09-04T11:34:26+01:00" level=debug msg="fetched chunk 8/15, size: 524288" uri="spotify:track:7dq6icAlynpBD6MSrXKh3A" Sep 04 11:34:27 volumio volumio[982]: info: Get:4 http://raspbian.raspberrypi.org/raspbian buster/main armhf Packages [13.0 MB] Sep 04 11:34:27 volumio volumio[982]: info: Get:5 https://deb.nodesource.com/node_14.x buster/main armhf Packages [786 B] Sep 04 11:34:27 volumio volumio[982]: info: Get:6 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] Sep 04 11:34:28 volumio volumio[982]: info: Get:7 http://raspbian.raspberrypi.org/raspbian buster/contrib armhf Packages [58.8 kB] Sep 04 11:34:28 volumio volumio[982]: info: Get:8 http://raspbian.raspberrypi.org/raspbian buster/non-free armhf Packages [110 kB] Sep 04 11:34:28 volumio volumio[982]: info: Get:9 http://raspbian.raspberrypi.org/raspbian buster/rpi armhf Packages [1360 B] Sep 04 11:34:32 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:32 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:32 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:32 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:32 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:33 volumio volumio[982]: info: Fetched 13.7 MB in 7s (1949 kB/s) Sep 04 11:34:34 volumio sudo[3012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 11:34:34 volumio sudo[3012]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:34 volumio sudo[3012]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:34 volumio sudo[3015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 11:34:34 volumio sudo[3015]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:34 volumio sudo[3015]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:34 volumio volumio[982]: verbose: New Socket.io Connection to 192.168.1.153 from 192.168.1.52 UA: Mozilla/5.0 (Linux; Android 11; M2101K6G Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 04 11:34:34 volumio sudo[3018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 11:34:34 volumio sudo[3018]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:34 volumio sudo[3018]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:34 volumio sudo[3021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 11:34:34 volumio sudo[3021]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:34 volumio sudo[3021]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:34 volumio volumio[982]: verbose: New Socket.io Connection to 192.168.1.153 from 192.168.1.52 UA: Mozilla/5.0 (Linux; Android 11; M2101K6G Build/RKQ1.200826.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 11:34:35 volumio volumio[982]: info: Received Get System Info Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:35 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:35 volumio volumio[982]: info: Listing playlists Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 04 11:34:35 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 11:34:36 volumio volumio[982]: info: Received Get System Info Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:36 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:36 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:36 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:37 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 11:34:37 volumio volumio[982]: info: Received Get System Info Sep 04 11:34:37 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:37 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:37 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:37 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:37 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:38 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 11:34:38 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 04 11:34:38 volumio volumio[982]: info: Reading package lists... Sep 04 11:34:39 volumio volumio[982]: info: Building dependency tree... Sep 04 11:34:39 volumio volumio[982]: info: Reading state information... Sep 04 11:34:39 volumio sudo[2807]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:39 volumio volumio[982]: info: 115 packages can be upgraded. Run 'apt list --upgradable' to see them. Sep 04 11:34:39 volumio sudo[3024]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Sep 04 11:34:39 volumio sudo[3024]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:39 volumio volumio[982]: info: Reading package lists... Sep 04 11:34:39 volumio volumio[982]: info: Building dependency tree... Sep 04 11:34:39 volumio volumio[982]: info: Reading state information... Sep 04 11:34:40 volumio go-librespot[1190]: time="2024-09-04T11:34:40+01:00" level=debug msg="fetched chunk 9/15, size: 524288" uri="spotify:track:7dq6icAlynpBD6MSrXKh3A" Sep 04 11:34:40 volumio volumio[982]: info: The following additional packages will be installed: Sep 04 11:34:40 volumio volumio[982]: info: build-essential bzip2 cpp cpp-8 dh-python dpkg-dev fakeroot g++ g++-8 gcc Sep 04 11:34:40 volumio volumio[982]: info: gcc-8 libalgorithm-diff-perl libalgorithm-diff-xs-perl Sep 04 11:34:40 volumio volumio[982]: info: libalgorithm-merge-perl libasan5 libcc1-0 libexpat1 libexpat1-dev Sep 04 11:34:40 volumio volumio[982]: info: libfakeroot libgcc-8-dev libisl19 libmpc3 libmpfr6 libpython3-dev Sep 04 11:34:40 volumio volumio[982]: info: libpython3.7 libpython3.7-dev libpython3.7-minimal libpython3.7-stdlib Sep 04 11:34:40 volumio volumio[982]: info: libstdc++-8-dev libubsan1 make patch python-pip-whl python3-asn1crypto Sep 04 11:34:40 volumio volumio[982]: info: python3-async-timeout python3-attr python3-cffi-backend python3-crypto Sep 04 11:34:40 volumio volumio[982]: info: python3-cryptography python3-dbus python3-dev python3-entrypoints python3-gi Sep 04 11:34:40 volumio volumio[982]: info: python3-keyring python3-keyrings.alt python3-multidict python3-secretstorage Sep 04 11:34:40 volumio volumio[982]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7 Sep 04 11:34:40 volumio volumio[982]: info: python3.7-dev python3.7-minimal Sep 04 11:34:40 volumio volumio[982]: info: Suggested packages: Sep 04 11:34:40 volumio volumio[982]: info: bzip2-doc cpp-doc gcc-8-locales debian-keyring gcc-8-doc libstdc++6-8-dbg Sep 04 11:34:40 volumio volumio[982]: info: gcc-multilib autoconf automake libtool flex bison gdb gcc-doc libgcc1-dbg Sep 04 11:34:40 volumio volumio[982]: info: libgomp1-dbg libitm1-dbg libatomic1-dbg libasan5-dbg liblsan0-dbg Sep 04 11:34:40 volumio volumio[982]: info: libtsan0-dbg libubsan1-dbg libmpx2-dbg libquadmath0-dbg libstdc++-8-doc Sep 04 11:34:40 volumio volumio[982]: info: make-doc ed diffutils-doc python-attr-doc python-crypto-doc Sep 04 11:34:40 volumio volumio[982]: info: python-cryptography-doc python3-cryptography-vectors python-dbus-doc Sep 04 11:34:40 volumio volumio[982]: info: python3-dbus-dbg gnome-keyring libkf5wallet-bin gir1.2-gnomekeyring-1.0 Sep 04 11:34:40 volumio volumio[982]: info: python-secretstorage-doc python-setuptools-doc python3.7-venv python3.7-doc Sep 04 11:34:40 volumio volumio[982]: info: binfmt-support Sep 04 11:34:40 volumio volumio[982]: info: The following NEW packages will be installed: Sep 04 11:34:40 volumio volumio[982]: info: build-essential bzip2 cpp cpp-8 dh-python dpkg-dev fakeroot g++ g++-8 gcc Sep 04 11:34:40 volumio volumio[982]: info: gcc-8 libalgorithm-diff-perl libalgorithm-diff-xs-perl Sep 04 11:34:40 volumio volumio[982]: info: libalgorithm-merge-perl libasan5 libcc1-0 libexpat1-dev libfakeroot Sep 04 11:34:40 volumio volumio[982]: info: libgcc-8-dev libisl19 libmpc3 libmpfr6 libpython3-dev libpython3.7 Sep 04 11:34:40 volumio volumio[982]: info: libpython3.7-dev libstdc++-8-dev libubsan1 make patch python-pip-whl Sep 04 11:34:40 volumio volumio[982]: info: python3-aiohttp python3-asn1crypto python3-async-timeout python3-attr Sep 04 11:34:40 volumio volumio[982]: info: python3-cffi-backend python3-crypto python3-cryptography python3-dbus Sep 04 11:34:40 volumio volumio[982]: info: python3-dev python3-entrypoints python3-gi python3-keyring Sep 04 11:34:40 volumio volumio[982]: info: python3-keyrings.alt python3-multidict python3-pip python3-secretstorage Sep 04 11:34:40 volumio volumio[982]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev Sep 04 11:34:40 volumio volumio[982]: info: The following packages will be upgraded: Sep 04 11:34:40 volumio volumio[982]: info: libexpat1 libpython3.7-minimal libpython3.7-stdlib python3.7 Sep 04 11:34:40 volumio volumio[982]: info: python3.7-minimal Sep 04 11:34:41 volumio volumio[982]: info: 5 upgraded, 51 newly installed, 0 to remove and 111 not upgraded. Sep 04 11:34:41 volumio volumio[982]: info: Need to get 84.3 MB of archives. Sep 04 11:34:41 volumio volumio[982]: info: After this operation, 180 MB of additional disk space will be used. Sep 04 11:34:41 volumio volumio[982]: info: Get:1 http://archive.raspberrypi.org/debian buster/main armhf python-pip-whl all 18.1-5+rpt1 [1591 kB] Sep 04 11:34:41 volumio volumio[982]: info: Get:2 http://mirror1.it.ox.ac.uk/sites/archive.raspbian.org/archive/raspbian buster/main armhf python3.7 armhf 3.7.3-2+deb10u7 [331 kB] Sep 04 11:34:41 volumio volumio[982]: info: Enabling plugin fusiondsp Sep 04 11:34:41 volumio volumio[982]: info: Loading plugin "fusiondsp"... Sep 04 11:34:41 volumio volumio[982]: info: Preparing to generate the ALSA configuration file Sep 04 11:34:41 volumio volumio[982]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Sep 04 11:34:41 volumio volumio[982]: info: Reading ALSA contributions from plugins. Sep 04 11:34:41 volumio volumio[982]: info: Get:3 http://mirror1.it.ox.ac.uk/sites/archive.raspbian.org/archive/raspbian buster/main armhf libpython3.7-stdlib armhf 3.7.3-2+deb10u7 [1665 kB] Sep 04 11:34:41 volumio volumio[982]: info: Asound.conf file unchanged, so no further update is needed Sep 04 11:34:41 volumio volumio[982]: info: Output device has changed, restarting MPD Sep 04 11:34:42 volumio sudo[3033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 11:34:42 volumio sudo[3033]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:42 volumio volumio[982]: info: Output device has changed, restarting Shairport Sync Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 11:34:42 volumio sudo[3033]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:42 volumio sudo[3036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 11:34:42 volumio sudo[3036]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:42 volumio systemd[1]: Stopping Music Player Daemon... Sep 04 11:34:42 volumio volumio[982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 11:34:42 volumio volumio[982]: info: PLUGIN START: fusiondsp Sep 04 11:34:42 volumio volumio[982]: info: Loading i18n strings for locale en Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: FusionDsp - mixtype--------------------- Software Sep 04 11:34:42 volumio volumio[982]: info: Preparing to generate the ALSA configuration file Sep 04 11:34:42 volumio volumio[982]: info: Done. Sep 04 11:34:42 volumio volumio[982]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Sep 04 11:34:42 volumio volumio[982]: info: Reading ALSA contributions from plugins. Sep 04 11:34:42 volumio volumio[982]: info: MPD Permissions set Sep 04 11:34:42 volumio volumio[982]: info: Get:4 http://mirror1.it.ox.ac.uk/sites/archive.raspbian.org/archive/raspbian buster/main armhf python3.7-minimal armhf 3.7.3-2+deb10u7 [1201 kB] Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 11:34:42 volumio volumio[982]: info: Starting Shairport Sync Sep 04 11:34:42 volumio systemd[1]: mpd.service: Succeeded. Sep 04 11:34:42 volumio systemd[1]: Stopped Music Player Daemon. Sep 04 11:34:42 volumio sudo[3047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 11:34:42 volumio sudo[3047]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:42 volumio systemd[1]: Starting Music Player Daemon... Sep 04 11:34:42 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 11:34:42 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 04 11:34:42 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 11:34:42 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 11:34:42 volumio sudo[3047]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:42 volumio volumio[982]: info: Asound.conf file unchanged, so no further update is needed Sep 04 11:34:42 volumio volumio[982]: info: Output device has changed, restarting MPD Sep 04 11:34:42 volumio sudo[3048]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 11:34:42 volumio sudo[3048]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:42 volumio sudo[3048]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:42 volumio sudo[3057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 11:34:42 volumio sudo[3057]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:42 volumio volumio[982]: info: Output device has changed, restarting Shairport Sync Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 11:34:42 volumio sudo[3057]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:42 volumio sudo[3060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 11:34:42 volumio sudo[3060]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:42 volumio volumio[982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 11:34:42 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 04 11:34:42 volumio systemd[1]: mpd.service: Succeeded. Sep 04 11:34:42 volumio systemd[1]: Stopped Music Player Daemon. Sep 04 11:34:42 volumio volumio[982]: info: MPD Permissions set Sep 04 11:34:42 volumio volumio[982]: info: Shairport-Sync Started Sep 04 11:34:42 volumio volumio[982]: info: Get:5 http://mirror0.it.ox.ac.uk/sites/archive.raspbian.org/archive/raspbian buster/main armhf libpython3.7-minimal armhf 3.7.3-2+deb10u7 [584 kB] Sep 04 11:34:42 volumio volumio[982]: info: Get:7 http://mirror1.it.ox.ac.uk/sites/archive.raspbian.org/archive/raspbian buster/main armhf bzip2 armhf 1.0.6-9.2~deb10u2 [46.3 kB] Sep 04 11:34:42 volumio volumio[982]: info: Get:8 http://archive.raspberrypi.org/debian buster/main armhf python3-pip all 18.1-5+rpt1 [171 kB] Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio systemd[1]: Starting Music Player Daemon... Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:42 volumio volumio[982]: info: Starting Shairport Sync Sep 04 11:34:42 volumio sudo[3073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 11:34:42 volumio sudo[3073]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:42 volumio sudo[3066]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 11:34:42 volumio sudo[3066]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:42 volumio sudo[3066]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:42 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 11:34:42 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 04 11:34:42 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 11:34:42 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 11:34:42 volumio volumio[982]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 11:34:42 volumio sudo[3073]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:42 volumio volumio[982]: info: Shairport-Sync Started Sep 04 11:34:42 volumio volumio[982]: info: Get:9 http://raspbian.mirror.uk.sargasso.net/raspbian buster/main armhf libisl19 armhf 0.20-2 [439 kB] Sep 04 11:34:43 volumio mpd[3076]: Sep 04 11:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 11:34:43 volumio systemd[1]: Started Music Player Daemon. Sep 04 11:34:43 volumio sudo[3036]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:43 volumio sudo[3060]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:43 volumio volumio[982]: error: MPD error: The expression evaluated to a falsy value: Sep 04 11:34:43 volumio volumio[982]: assert.ok(self.idling) Sep 04 11:34:43 volumio volumio[982]: error: The expression evaluated to a falsy value: Sep 04 11:34:43 volumio volumio[982]: assert.ok(self.idling) Sep 04 11:34:43 volumio volumio[982]: error: updateQueue error: null Sep 04 11:34:43 volumio volumio[982]: info: Get:6 http://mirror0.it.ox.ac.uk/sites/archive.raspbian.org/archive/raspbian buster/main armhf libexpat1 armhf 2.2.6-2+deb10u7 [79.7 kB] Sep 04 11:34:43 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 11:34:43 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 11:34:43 volumio volumio[982]: info: Discovery: Getting this device information Sep 04 11:34:43 volumio volumio[982]: info: CoreCommandRouter::volumioGetState Sep 04 11:34:43 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:44 volumio volumio[982]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Sep 04 11:34:44 volumio volumio[982]: info: camilladsp service started and running in background, instance 1 Sep 04 11:34:44 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 11:34:44 volumio volumio[982]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 04 11:34:44 volumio volumio[982]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Sep 04 11:34:44 volumio volumio[982]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 04 11:34:44 volumio volumio[982]: info: FusionDsp loaded Sep 04 11:34:44 volumio volumio[982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 11:34:44 volumio sudo[3093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Sep 04 11:34:44 volumio sudo[3093]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 11:34:44 volumio volumio[982]: info: FusionDsp - Reporting Fusion DSP Enabled Sep 04 11:34:44 volumio volumio[982]: info: Adding Signal Path Element [object Object] Sep 04 11:34:44 volumio volumio[982]: info: Adding fusiondspeq DSP Signal Path Element Sep 04 11:34:44 volumio volumio[982]: info: FusionDsp - ---- installed callbackRead Sep 04 11:34:44 volumio volumio[982]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 11:34:44 volumio sudo[3093]: pam_unix(sudo:session): session closed for user root Sep 04 11:34:44 volumio volumio[982]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Sep 04 11:34:44 volumio volumio[982]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Sep 04 11:34:44 volumio volumio[982]: at onErrorNT (internal/child_process.js:465:16) Sep 04 11:34:44 volumio volumio[982]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Sep 04 11:34:44 volumio volumio[982]: errno: -2, Sep 04 11:34:44 volumio volumio[982]: code: 'ENOENT', Sep 04 11:34:44 volumio volumio[982]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Sep 04 11:34:44 volumio volumio[982]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Sep 04 11:34:44 volumio volumio[982]: spawnargs: [ Sep 04 11:34:44 volumio volumio[982]: '-p', Sep 04 11:34:44 volumio volumio[982]: 9876, Sep 04 11:34:44 volumio volumio[982]: '-o', Sep 04 11:34:44 volumio volumio[982]: '/tmp/camilladsp.log', Sep 04 11:34:44 volumio volumio[982]: '-l', Sep 04 11:34:44 volumio volumio[982]: 'warn', Sep 04 11:34:44 volumio volumio[982]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Sep 04 11:34:44 volumio volumio[982]: ] Sep 04 11:34:44 volumio volumio[982]: } Sep 04 11:34:44 volumio volumio[982]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 11:34:44 volumio sudo[3104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 11:33 Sep 04 11:34:44 volumio sudo[3104]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"