-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2025-09-04 12:18:10 CEST. -- Sep 04 12:17:00 volumio volumio[1114]: info: Checking if install.sh is present Sep 04 12:17:00 volumio volumio[1114]: info: CorePlayQueue::getTrack 14 Sep 04 12:17:00 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:00 volumio volumio[1114]: info: Prefetching next song Sep 04 12:17:00 volumio volumio[1114]: info: DOING PREFETCH IN MPD Sep 04 12:17:00 volumio volumio[1114]: verbose: ControllerMpd::sendMpdCommand add "NAS/MusicaNas/Pino Daniele - Nero a metà live - Il Concerto - Milano, 22 dicembre 2014/20 Tutta n'ata storia (Live).flac" Sep 04 12:17:00 volumio volumio[1114]: info: CoreStateMachine::startPlaybackTimer Sep 04 12:17:00 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:00 volumio go-librespot[1457]: time="2025-09-04T12:17:00+02:00" level=trace msg="sent dealer ping" Sep 04 12:17:00 volumio go-librespot[1457]: time="2025-09-04T12:17:00+02:00" level=trace msg="received dealer pong" Sep 04 12:17:00 volumio volumio[1114]: info: Executing install.sh Sep 04 12:17:00 volumio volumio[1114]: info: Sep 04 12:17:00 volumio volumio[1114]: ---------------------------- MPD announces system playlist update Sep 04 12:17:00 volumio volumio[1114]: info: Ignoring MPD Status Update Sep 04 12:17:00 volumio volumio[1114]: info: sendMpdCommand add "NAS/MusicaNas/Pino Daniele - Nero a metà live - Il Concerto - Milano, 22 dicembre 2014/20 Tutta n'ata storia (Live).flac" took 171 milliseconds Sep 04 12:17:00 volumio volumio[1114]: verbose: ControllerMpd::sendMpdCommand consume 1 Sep 04 12:17:00 volumio volumio[1114]: info: Sep 04 12:17:00 volumio volumio[1114]: ---------------------------- MPD announces system playlist update Sep 04 12:17:00 volumio volumio[1114]: info: Ignoring MPD Status Update Sep 04 12:17:00 volumio volumio[1114]: info: CoreStateMachine::pushState Sep 04 12:17:00 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:00 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 12:17:00 volumio volumio[1114]: info: CoreCommandRouter::volumioPushState Sep 04 12:17:00 volumio volumio[1114]: info: ------------------------------ 54ms Sep 04 12:17:00 volumio volumio[1114]: info: sendMpdCommand consume 1 took 52 milliseconds Sep 04 12:17:00 volumio volumio[1114]: info: ------------------------------ 51ms Sep 04 12:17:00 volumio volumio[1114]: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:00 volumio volumio[1114]: verbose: New Socket.io Connection to 192.168.168.8 from 192.168.168.26 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Sep 04 12:17:00 volumio volumio[1114]: verbose: New Socket.io Connection to 192.168.168.7 from 192.168.168.26 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Sep 04 12:17:00 volumio volumio[1114]: verbose: New Socket.io Connection to 192.168.168.8 from 192.168.168.26 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Sep 04 12:17:00 volumio volumio[1114]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Sep 04 12:17:00 volumio volumio[1114]: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:00 volumio volumio[1114]: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:00 volumio volumio[1114]: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:00 volumio volumio[1114]: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:00 volumio volumio[1114]: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:00 volumio volumio[1114]: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:00 volumio volumio[1114]: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:00 volumio volumio[1114]: info: CoreCommandRouter::volumioGetState Sep 04 12:17:00 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:00 volumio sudo[7743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Sep 04 12:17:00 volumio sudo[7743]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:00 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 12:17:00 volumio volumio[1114]: info: Listing playlists Sep 04 12:17:00 volumio volumio[1114]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 12:17:00 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 12:17:00 volumio volumio[1114]: info: CoreCommandRouter::volumioGetQueue Sep 04 12:17:00 volumio volumio[1114]: info: CoreStateMachine::getQueue Sep 04 12:17:00 volumio volumio[1114]: info: CorePlayQueue::getQueue Sep 04 12:17:00 volumio volumio[1114]: info: Sep 04 12:17:00 volumio volumio[1114]: ---------------------------- MPD announces system playlist update Sep 04 12:17:00 volumio volumio[1114]: info: Ignoring MPD Status Update Sep 04 12:17:00 volumio volumio[1114]: info: Sep 04 12:17:00 volumio volumio[1114]: ---------------------------- MPD announces state update: player Sep 04 12:17:00 volumio volumio[1114]: info: ControllerMpd::getState Sep 04 12:17:00 volumio volumio[1114]: verbose: ControllerMpd::sendMpdCommand status Sep 04 12:17:00 volumio volumio[1114]: info: Sep 04 12:17:00 volumio volumio[1114]: ---------------------------- MPD announces system playlist update Sep 04 12:17:00 volumio volumio[1114]: info: Ignoring MPD Status Update Sep 04 12:17:00 volumio volumio[1114]: info: Sep 04 12:17:00 volumio volumio[1114]: ---------------------------- MPD announces state update: player Sep 04 12:17:00 volumio volumio[1114]: info: ControllerMpd::getState Sep 04 12:17:00 volumio volumio[1114]: verbose: ControllerMpd::sendMpdCommand status Sep 04 12:17:00 volumio volumio[1114]: info: CoreCommandRouter::volumioGetState Sep 04 12:17:00 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:01 volumio volumio[1114]: info: ------------------------------ 369ms Sep 04 12:17:01 volumio volumio[1114]: info: sendMpdCommand status took 364 milliseconds Sep 04 12:17:01 volumio volumio[1114]: info: ------------------------------ 364ms Sep 04 12:17:01 volumio volumio[1114]: info: sendMpdCommand status took 357 milliseconds Sep 04 12:17:01 volumio volumio[1114]: verbose: ControllerMpd::parseState Sep 04 12:17:01 volumio volumio[1114]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 12:17:01 volumio volumio[1114]: verbose: ControllerMpd::parseState Sep 04 12:17:01 volumio volumio[1114]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 04 12:17:01 volumio volumio[1114]: info: sendMpdCommand playlistinfo took 34 milliseconds Sep 04 12:17:01 volumio volumio[1114]: verbose: ControllerMpd::parseTrackInfo Sep 04 12:17:01 volumio volumio[1114]: info: ControllerMpd::pushState Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::servicePushState Sep 04 12:17:01 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:01 volumio volumio[1114]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"Tutta n'ata storia (Live)","artist":"Pino Daniele","album":"Nero a metà live - Il Concerto - Milano, 22 dicembre 2014","uri":"NAS/MusicaNas/Pino Daniele - Nero a metà live - Il Concerto - Milano, 22 dicembre 2014/20 Tutta n'ata storia (Live).flac","trackType":"flac"} Sep 04 12:17:01 volumio volumio[1114]: verbose: CURRENT POSITION 15 Sep 04 12:17:01 volumio volumio[1114]: info: CoreStateMachine::syncState stateService play Sep 04 12:17:01 volumio volumio[1114]: info: CoreStateMachine::syncState currentStatus play Sep 04 12:17:01 volumio volumio[1114]: info: Received an update from plugin. extracting info from payload Sep 04 12:17:01 volumio volumio[1114]: info: CoreStateMachine::pushState Sep 04 12:17:01 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::volumioPushState Sep 04 12:17:01 volumio volumio[1114]: info: CoreStateMachine::pushState Sep 04 12:17:01 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::volumioPushState Sep 04 12:17:01 volumio volumio[1114]: info: ControllerMpd::pushState Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::servicePushState Sep 04 12:17:01 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:01 volumio volumio[1114]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"Tutta n'ata storia (Live)","artist":"Pino Daniele","album":"Nero a metà live - Il Concerto - Milano, 22 dicembre 2014","uri":"NAS/MusicaNas/Pino Daniele - Nero a metà live - Il Concerto - Milano, 22 dicembre 2014/20 Tutta n'ata storia (Live).flac","trackType":"flac"} Sep 04 12:17:01 volumio volumio[1114]: verbose: CURRENT POSITION 15 Sep 04 12:17:01 volumio volumio[1114]: info: CoreStateMachine::syncState stateService play Sep 04 12:17:01 volumio volumio[1114]: info: CoreStateMachine::syncState currentStatus play Sep 04 12:17:01 volumio volumio[1114]: info: Received an update from plugin. extracting info from payload Sep 04 12:17:01 volumio volumio[1114]: info: CoreStateMachine::pushState Sep 04 12:17:01 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::volumioPushState Sep 04 12:17:01 volumio volumio[1114]: info: CoreStateMachine::pushState Sep 04 12:17:01 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::volumioPushState Sep 04 12:17:01 volumio volumio[1114]: info: ------------------------------ 436ms Sep 04 12:17:01 volumio volumio[1114]: info: ------------------------------ 430ms Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 12:17:01 volumio volumio[1114]: info: Listing playlists Sep 04 12:17:01 volumio sudo[7785]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Sep 04 12:17:01 volumio sudo[7785]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:01 volumio volumio[1114]: info: copying demo flters Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/ Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/2XEQ15/ Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/PEQ/ Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/convfir/ Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/convfir/kef.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/convfir/test.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/EQ15/ Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/EQ15/.Bass-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/EQ15/.Classic-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/EQ15/.Voice-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: ./presets/EQ15/.Rock-FusionDsp.json Sep 04 12:17:01 volumio volumio[1114]: info: Installing/fusiondsp dependencies Sep 04 12:17:01 volumio volumio[1114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Sep 04 12:17:01 volumio volumio[1114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 04 12:17:01 volumio volumio[1114]: info: CoreCommandRouter::volumioGetState Sep 04 12:17:01 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:01 volumio volumio[1114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Sep 04 12:17:02 volumio volumio[1114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Sep 04 12:17:02 volumio volumio[1114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Sep 04 12:17:02 volumio volumio[1114]: info: CoreCommandRouter::volumioGetState Sep 04 12:17:02 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:02 volumio volumio[1114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Sep 04 12:17:02 volumio volumio[1114]: info: CoreCommandRouter::volumioGetState Sep 04 12:17:02 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:02 volumio volumio[1114]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Sep 04 12:17:02 volumio volumio[1114]: info: Hit:1 http://raspbian.raspberrypi.org/raspbian buster InRelease Sep 04 12:17:02 volumio volumio[1114]: info: Get:2 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB] Sep 04 12:17:02 volumio volumio[1114]: info: Hit:3 https://deb.nodesource.com/node_14.x buster InRelease Sep 04 12:17:02 volumio volumio-remote-updater[567]: [2025-09-04 12:17:02] [connect] Successful connection Sep 04 12:17:02 volumio volumio-remote-updater[567]: [2025-09-04 12:17:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756981022 101 Sep 04 12:17:02 volumio volumio[1114]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 11 Sep 04 12:17:03 volumio volumio[1114]: info: Get:4 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] Sep 04 12:17:03 volumio volumio[1114]: info: Fetched 455 kB in 2s (288 kB/s) Sep 04 12:17:23 volumio volumio[1114]: info: Reading package lists... Sep 04 12:17:25 volumio volumio[1114]: info: Building dependency tree... Sep 04 12:17:25 volumio volumio[1114]: info: Reading state information... Sep 04 12:17:25 volumio volumio[1114]: info: All packages are up to date. Sep 04 12:17:25 volumio sudo[7785]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:25 volumio sudo[8091]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Sep 04 12:17:25 volumio sudo[8091]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:25 volumio volumio[1114]: info: Reading package lists... Sep 04 12:17:26 volumio volumio[1114]: info: Building dependency tree... Sep 04 12:17:26 volumio volumio[1114]: info: Reading state information... Sep 04 12:17:28 volumio volumio[1114]: info: python3-pip is already the newest version (18.1-5+rpt1). Sep 04 12:17:28 volumio volumio[1114]: info: The following additional packages will be installed: Sep 04 12:17:28 volumio volumio[1114]: info: python3-async-timeout python3-attr python3-multidict python3-yarl Sep 04 12:17:28 volumio volumio[1114]: info: Suggested packages: Sep 04 12:17:28 volumio volumio[1114]: info: python-attr-doc Sep 04 12:17:29 volumio volumio[1114]: info: The following NEW packages will be installed: Sep 04 12:17:29 volumio volumio[1114]: info: python3-aiohttp python3-async-timeout python3-attr python3-multidict Sep 04 12:17:29 volumio volumio[1114]: info: python3-yarl Sep 04 12:17:30 volumio volumio[1114]: info: 0 upgraded, 5 newly installed, 0 to remove and 2 not upgraded. Sep 04 12:17:30 volumio volumio[1114]: info: Need to get 382 kB of archives. Sep 04 12:17:30 volumio volumio[1114]: info: After this operation, 1774 kB of additional disk space will be used. Sep 04 12:17:30 volumio volumio[1114]: info: Get:1 http://raspbian.mirror.garr.it/mirrors/raspbian/raspbian buster/main armhf python3-multidict armhf 4.5.2-1 [52.9 kB] Sep 04 12:17:30 volumio go-librespot[1457]: time="2025-09-04T12:17:30+02:00" level=trace msg="received accesspoint ping" Sep 04 12:17:30 volumio go-librespot[1457]: time="2025-09-04T12:17:30+02:00" level=trace msg="received accesspoint pong ack" Sep 04 12:17:30 volumio volumio[1114]: info: Get:2 http://raspbian.mirror.garr.it/mirrors/raspbian/raspbian buster/main armhf python3-yarl armhf 1.3.0-1 [44.0 kB] Sep 04 12:17:30 volumio volumio[1114]: info: Get:3 http://raspbian.mirror.garr.it/mirrors/raspbian/raspbian buster/main armhf python3-async-timeout all 3.0.1-1 [6292 B] Sep 04 12:17:30 volumio go-librespot[1457]: time="2025-09-04T12:17:30+02:00" level=trace msg="sent dealer ping" Sep 04 12:17:30 volumio go-librespot[1457]: time="2025-09-04T12:17:30+02:00" level=trace msg="received dealer pong" Sep 04 12:17:30 volumio volumio[1114]: info: Get:4 http://raspbian.mirror.garr.it/mirrors/raspbian/raspbian buster/main armhf python3-attr all 18.2.0-1 [37.3 kB] Sep 04 12:17:30 volumio volumio[1114]: info: Get:5 http://ftp.arnes.si/mirrors/raspbian/raspbian buster/main armhf python3-aiohttp armhf 3.5.1-1+deb10u1 [241 kB] Sep 04 12:17:32 volumio volumio[1114]: info: Fetched 382 kB in 1s (327 kB/s) Sep 04 12:17:32 volumio volumio[1114]: info: Selecting previously unselected package python3-multidict. Sep 04 12:17:34 volumio volumio[1114]: [620B blob data] Sep 04 12:17:34 volumio volumio[1114]: info: Preparing to unpack .../python3-multidict_4.5.2-1_armhf.deb ... Sep 04 12:17:34 volumio volumio[1114]: info: Unpacking python3-multidict (4.5.2-1) ... Sep 04 12:17:34 volumio volumio[1114]: info: Selecting previously unselected package python3-yarl. Sep 04 12:17:34 volumio volumio[1114]: info: Preparing to unpack .../python3-yarl_1.3.0-1_armhf.deb ... Sep 04 12:17:34 volumio volumio[1114]: info: Unpacking python3-yarl (1.3.0-1) ... Sep 04 12:17:34 volumio volumio[1114]: info: Selecting previously unselected package python3-async-timeout. Sep 04 12:17:35 volumio volumio[1114]: info: Preparing to unpack .../python3-async-timeout_3.0.1-1_all.deb ... Sep 04 12:17:35 volumio volumio[1114]: info: Unpacking python3-async-timeout (3.0.1-1) ... Sep 04 12:17:35 volumio volumio[1114]: info: Selecting previously unselected package python3-attr. Sep 04 12:17:35 volumio volumio[1114]: info: Preparing to unpack .../python3-attr_18.2.0-1_all.deb ... Sep 04 12:17:35 volumio volumio[1114]: info: Unpacking python3-attr (18.2.0-1) ... Sep 04 12:17:35 volumio volumio[1114]: info: Selecting previously unselected package python3-aiohttp. Sep 04 12:17:35 volumio volumio[1114]: info: Preparing to unpack .../python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ... Sep 04 12:17:35 volumio volumio[1114]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Sep 04 12:17:35 volumio sudo[8222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 12:17:35 volumio sudo[8222]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:35 volumio sudo[8222]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:35 volumio sudo[8224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 12:17:35 volumio sudo[8224]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:35 volumio sudo[8224]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:35 volumio volumio[1114]: verbose: New Socket.io Connection to 192.168.168.7 from 192.168.168.26 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Sep 04 12:17:35 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 12:17:35 volumio volumio[1114]: info: CoreCommandRouter::volumioGetState Sep 04 12:17:35 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:35 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 04 12:17:35 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 04 12:17:35 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 04 12:17:35 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 04 12:17:35 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 04 12:17:37 volumio volumio[1114]: info: Setting up python3-attr (18.2.0-1) ... Sep 04 12:17:37 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 12:17:37 volumio volumio[1114]: info: Received Get System Info Sep 04 12:17:37 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 12:17:37 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 12:17:37 volumio volumio[1114]: info: Discovery: Getting this device information Sep 04 12:17:37 volumio volumio[1114]: info: CoreCommandRouter::volumioGetState Sep 04 12:17:37 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:37 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 12:17:38 volumio volumio[1114]: info: Setting up python3-multidict (4.5.2-1) ... Sep 04 12:17:38 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 12:17:38 volumio volumio[1114]: info: Received Get System Info Sep 04 12:17:38 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 12:17:38 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 12:17:38 volumio volumio[1114]: info: Discovery: Getting this device information Sep 04 12:17:38 volumio volumio[1114]: info: CoreCommandRouter::volumioGetState Sep 04 12:17:38 volumio volumio[1114]: info: CorePlayQueue::getTrack 15 Sep 04 12:17:38 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 12:17:38 volumio volumio[1114]: info: Setting up python3-async-timeout (3.0.1-1) ... Sep 04 12:17:39 volumio volumio[1114]: info: Setting up python3-yarl (1.3.0-1) ... Sep 04 12:17:40 volumio volumio[1114]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Sep 04 12:17:43 volumio volumio[1114]: info: Enabling plugin fusiondsp Sep 04 12:17:43 volumio volumio[1114]: info: Loading plugin "fusiondsp"... Sep 04 12:17:45 volumio volumio[1114]: info: Preparing to generate the ALSA configuration file Sep 04 12:17:45 volumio volumio[1114]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 12:17:45 volumio volumio[1114]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Sep 04 12:17:45 volumio volumio[1114]: info: Reading ALSA contributions from plugins. Sep 04 12:17:45 volumio volumio[1114]: info: FusionDsp - Sep 04 12:17:45 volumio sudo[8091]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:45 volumio sudo[8338]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Sep 04 12:17:45 volumio sudo[8338]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:45 volumio sudo[8338]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:45 volumio volumio[1114]: info: FusionDsp - undefined Sep 04 12:17:45 volumio volumio[1114]: info: lib/systemd/system/fusiondsp.service Sep 04 12:17:45 volumio volumio[1114]: info: Asound.conf file unchanged, so no further update is needed Sep 04 12:17:45 volumio volumio[1114]: info: Output device has changed, restarting MPD Sep 04 12:17:45 volumio sudo[8342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 12:17:45 volumio sudo[8342]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:45 volumio volumio[1114]: info: Output device has changed, restarting Shairport Sync Sep 04 12:17:45 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:45 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 12:17:45 volumio sudo[8342]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:45 volumio sudo[8344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 12:17:45 volumio sudo[8344]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:45 volumio systemd[1]: Stopping Music Player Daemon... Sep 04 12:17:46 volumio volumio[1114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 12:17:46 volumio volumio[1114]: info: PLUGIN START: fusiondsp Sep 04 12:17:46 volumio volumio[1114]: info: Loading i18n strings for locale it Sep 04 12:17:46 volumio volumio[1114]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: FusionDsp - mixtype--------------------- Hardware Sep 04 12:17:46 volumio volumio[1114]: info: Preparing to generate the ALSA configuration file Sep 04 12:17:46 volumio volumio[1114]: info: Done. Sep 04 12:17:46 volumio volumio[1114]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 04 12:17:46 volumio volumio[1114]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Sep 04 12:17:46 volumio volumio[1114]: info: Reading ALSA contributions from plugins. Sep 04 12:17:46 volumio volumio[1114]: info: MPD Permissions set Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: Starting Shairport Sync Sep 04 12:17:46 volumio volumio[1114]: info: Asound.conf file written Sep 04 12:17:46 volumio sudo[8357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 12:17:46 volumio sudo[8357]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:46 volumio sudo[8360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 04 12:17:46 volumio sudo[8360]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 12:17:46 volumio sudo[8360]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:46 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 04 12:17:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 12:17:46 volumio volumio[1114]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy Sep 04 12:17:46 volumio volumio[1114]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy Sep 04 12:17:46 volumio volumio[1114]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy Sep 04 12:17:46 volumio volumio[1114]: info: Output device has changed, restarting MPD Sep 04 12:17:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 12:17:46 volumio sudo[8357]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:46 volumio sudo[8367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 12:17:46 volumio sudo[8367]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:46 volumio sudo[8367]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:46 volumio volumio[1114]: info: Output device has changed, restarting Shairport Sync Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 12:17:46 volumio sudo[8370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 12:17:46 volumio sudo[8370]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:46 volumio volumio[1114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: error: Upnp client error: Error: This socket has been ended by the other party Sep 04 12:17:46 volumio volumio[1114]: info: MPD Permissions set Sep 04 12:17:46 volumio volumio[1114]: info: Shairport-Sync Started Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:46 volumio volumio[1114]: info: Starting Shairport Sync Sep 04 12:17:46 volumio sudo[8381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 12:17:46 volumio sudo[8381]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:17:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 12:17:46 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 04 12:17:46 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 04 12:17:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 12:17:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 12:17:46 volumio sudo[8381]: pam_unix(sudo:session): session closed for user root Sep 04 12:17:46 volumio volumio[1114]: info: Shairport-Sync Started Sep 04 12:17:47 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:47 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:17:47 volumio volumio[1114]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Sep 04 12:17:47 volumio volumio[1114]: info: more info at http://www.winimage.com/zLibDll/unzip.html Sep 04 12:17:47 volumio volumio[1114]: info: Sep 04 12:17:47 volumio volumio[1114]: info: cgui-1.0.0.zip opened Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/ Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/LICENSE.txt Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/README.md Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/build/ Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/robots.txt Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/logo512.png Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/asset-manifest.json Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/index.html Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/.put_statics_here Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/favicon.ico Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/logo192.png Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/manifest.json Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/css-variables.css Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/service-worker.js Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/build/static/ Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/build/static/css/ Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/main.1503f6cd.css Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/build/static/media/ Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/build/static/js/ Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/main.71e11955.js Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/main.71e11955.js.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/config/ Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/config/camillagui.yml Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/config/gui-config.yml Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/backend/ Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/filters_test.py Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/version.py Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/filters.py Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/settings.py Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/views.py Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/filterdefaults.py Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__init__.py Sep 04 12:17:47 volumio volumio[1114]: info: creating directory: cgui/backend/__pycache__/ Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/routes.py Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/backend/filemanagement.py Sep 04 12:17:47 volumio volumio[1114]: info: extracting: cgui/main.py Sep 04 12:17:57 volumio volumio-remote-updater[567]: [2025-09-04 12:17:57] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Sep 04 12:17:57 volumio sudo[8388]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Sep 04 12:17:57 volumio sudo[8388]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:18:00 volumio go-librespot[1457]: time="2025-09-04T12:18:00+02:00" level=trace msg="sent dealer ping" Sep 04 12:18:00 volumio sudo[8388]: pam_unix(sudo:session): session closed for user root Sep 04 12:18:00 volumio go-librespot[1457]: time="2025-09-04T12:18:00+02:00" level=trace msg="received dealer pong" Sep 04 12:18:02 volumio volumio-remote-updater[567]: [2025-09-04 12:18:02] [connect] Successful connection Sep 04 12:18:06 volumio volumio[1114]: info: camilladsp service started and running in background, instance 1 Sep 04 12:18:06 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 12:18:06 volumio volumio[1114]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 04 12:18:06 volumio volumio[1114]: 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 12:18:06 volumio volumio[1114]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 04 12:18:06 volumio volumio[1114]: info: FusionDsp loaded Sep 04 12:18:06 volumio volumio[1114]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 12:18:06 volumio sudo[8474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Sep 04 12:18:06 volumio sudo[8474]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:18:06 volumio volumio[1114]: info: FusionDsp - Reporting Fusion DSP Enabled Sep 04 12:18:06 volumio volumio[1114]: info: Adding Signal Path Element [object Object] Sep 04 12:18:06 volumio volumio[1114]: info: Adding fusiondspeq DSP Signal Path Element Sep 04 12:18:06 volumio volumio[1114]: info: FusionDsp - ---- installed callbackRead Sep 04 12:18:06 volumio volumio[1114]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 12:18:06 volumio sudo[8469]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Sep 04 12:18:06 volumio sudo[8469]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:18:06 volumio sudo[8469]: pam_unix(sudo:session): session closed for user root Sep 04 12:18:06 volumio volumio[1114]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Sep 04 12:18:06 volumio volumio[1114]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Sep 04 12:18:06 volumio volumio[1114]: at onErrorNT (internal/child_process.js:465:16) Sep 04 12:18:06 volumio volumio[1114]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Sep 04 12:18:06 volumio volumio[1114]: at runNextTicks (internal/process/task_queues.js:62:3) Sep 04 12:18:06 volumio volumio[1114]: at listOnTimeout (internal/timers.js:523:9) Sep 04 12:18:06 volumio volumio[1114]: at processTimers (internal/timers.js:497:7) { Sep 04 12:18:06 volumio volumio[1114]: errno: -2, Sep 04 12:18:06 volumio volumio[1114]: code: 'ENOENT', Sep 04 12:18:06 volumio volumio[1114]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Sep 04 12:18:06 volumio volumio[1114]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Sep 04 12:18:06 volumio volumio[1114]: spawnargs: [ Sep 04 12:18:06 volumio volumio[1114]: '-p', Sep 04 12:18:06 volumio volumio[1114]: 9876, Sep 04 12:18:06 volumio volumio[1114]: '-o', Sep 04 12:18:06 volumio volumio[1114]: '/tmp/camilladsp.log', Sep 04 12:18:06 volumio volumio[1114]: '-l', Sep 04 12:18:06 volumio volumio[1114]: 'warn', Sep 04 12:18:06 volumio volumio[1114]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Sep 04 12:18:06 volumio volumio[1114]: ] Sep 04 12:18:06 volumio volumio[1114]: } Sep 04 12:18:06 volumio volumio[1114]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 12:18:06 volumio sudo[8478]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Sep 04 12:18:06 volumio sudo[8478]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:18:06 volumio systemd[1]: Started FusionDsp Daemon. Sep 04 12:18:06 volumio sudo[8478]: pam_unix(sudo:session): session closed for user root Sep 04 12:18:06 volumio sudo[8474]: pam_unix(sudo:session): session closed for user root Sep 04 12:18:07 volumio mpd_monitor.sh[553]: MPD Monitor Service: MPD Appears to be inactive, restarting Sep 04 12:18:08 volumio systemd[1]: mpd.service: Succeeded. Sep 04 12:18:08 volumio systemd[1]: Stopped Music Player Daemon. Sep 04 12:18:08 volumio systemd[1]: Starting Music Player Daemon... Sep 04 12:18:08 volumio sudo[8490]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 12:18:08 volumio sudo[8490]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 12:18:08 volumio sudo[8490]: pam_unix(sudo:session): session closed for user root Sep 04 12:18:10 volumio sudo[8496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-04 12:17 Sep 04 12:18:10 volumio sudo[8496]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"