-- Logs begin at Thu 2024-08-22 13:19:28 CEST, end at Fri 2024-08-23 15:17:18 CEST. -- Aug 23 15:16:05 acoman volumio[971]: info: Selecting previously unselected package g++-8. Aug 23 15:16:05 acoman volumio[971]: info: Preparing to unpack .../08-g++-8_8.3.0-6+rpi1_armhf.deb ... Aug 23 15:16:05 acoman volumio[971]: info: Unpacking g++-8 (8.3.0-6+rpi1) ... Aug 23 15:16:08 acoman volumio[971]: info: Selecting previously unselected package g++. Aug 23 15:16:08 acoman volumio[971]: info: Preparing to unpack .../09-g++_4%3a8.3.0-1+rpi2_armhf.deb ... Aug 23 15:16:08 acoman volumio[971]: info: Unpacking g++ (4:8.3.0-1+rpi2) ... Aug 23 15:16:09 acoman volumio[971]: info: Selecting previously unselected package make. Aug 23 15:16:09 acoman volumio[971]: info: Preparing to unpack .../10-make_4.2.1-1.2_armhf.deb ... Aug 23 15:16:09 acoman volumio[971]: info: Unpacking make (4.2.1-1.2) ... Aug 23 15:16:09 acoman volumio[971]: info: Selecting previously unselected package patch. Aug 23 15:16:09 acoman volumio[971]: info: Preparing to unpack .../11-patch_2.7.6-3+deb10u1_armhf.deb ... Aug 23 15:16:09 acoman volumio[971]: info: Unpacking patch (2.7.6-3+deb10u1) ... Aug 23 15:16:09 acoman volumio[971]: info: Selecting previously unselected package dpkg-dev. Aug 23 15:16:09 acoman volumio[971]: info: Preparing to unpack .../12-dpkg-dev_1.19.8_all.deb ... Aug 23 15:16:09 acoman volumio[971]: info: Unpacking dpkg-dev (1.19.8) ... Aug 23 15:16:10 acoman volumio[971]: info: Selecting previously unselected package build-essential. Aug 23 15:16:10 acoman volumio[971]: info: Preparing to unpack .../13-build-essential_12.6_armhf.deb ... Aug 23 15:16:10 acoman volumio[971]: info: Unpacking build-essential (12.6) ... Aug 23 15:16:10 acoman volumio[971]: info: Selecting previously unselected package dh-python. Aug 23 15:16:10 acoman volumio[971]: info: Preparing to unpack .../14-dh-python_3.20190308_all.deb ... Aug 23 15:16:10 acoman volumio[971]: info: Unpacking dh-python (3.20190308) ... Aug 23 15:16:11 acoman volumio[971]: info: Selecting previously unselected package libfakeroot:armhf. Aug 23 15:16:11 acoman volumio[971]: info: Preparing to unpack .../15-libfakeroot_1.23-1_armhf.deb ... Aug 23 15:16:11 acoman volumio[971]: info: Unpacking libfakeroot:armhf (1.23-1) ... Aug 23 15:16:11 acoman volumio[971]: info: Selecting previously unselected package fakeroot. Aug 23 15:16:11 acoman volumio[971]: info: Preparing to unpack .../16-fakeroot_1.23-1_armhf.deb ... Aug 23 15:16:11 acoman volumio[971]: info: Unpacking fakeroot (1.23-1) ... Aug 23 15:16:11 acoman volumio[971]: info: Selecting previously unselected package libalgorithm-diff-perl. Aug 23 15:16:11 acoman volumio[971]: info: Preparing to unpack .../17-libalgorithm-diff-perl_1.19.03-2_all.deb ... Aug 23 15:16:11 acoman volumio[971]: info: Unpacking libalgorithm-diff-perl (1.19.03-2) ... Aug 23 15:16:11 acoman volumio[971]: info: Selecting previously unselected package libalgorithm-diff-xs-perl. Aug 23 15:16:11 acoman volumio[971]: info: Preparing to unpack .../18-libalgorithm-diff-xs-perl_0.04-5+b1_armhf.deb ... Aug 23 15:16:12 acoman volumio[971]: info: Unpacking libalgorithm-diff-xs-perl (0.04-5+b1) ... Aug 23 15:16:12 acoman volumio[971]: info: Selecting previously unselected package libalgorithm-merge-perl. Aug 23 15:16:12 acoman volumio[971]: info: Preparing to unpack .../19-libalgorithm-merge-perl_0.08-3_all.deb ... Aug 23 15:16:12 acoman volumio[971]: info: Unpacking libalgorithm-merge-perl (0.08-3) ... Aug 23 15:16:12 acoman volumio[971]: info: Selecting previously unselected package libexpat1-dev:armhf. Aug 23 15:16:12 acoman volumio[971]: info: Preparing to unpack .../20-libexpat1-dev_2.2.6-2+deb10u7_armhf.deb ... Aug 23 15:16:12 acoman volumio[971]: info: Unpacking libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Aug 23 15:16:12 acoman volumio[971]: info: Selecting previously unselected package libpython3.7:armhf. Aug 23 15:16:12 acoman volumio[971]: info: Preparing to unpack .../21-libpython3.7_3.7.3-2+deb10u7_armhf.deb ... Aug 23 15:16:12 acoman volumio[971]: info: Unpacking libpython3.7:armhf (3.7.3-2+deb10u7) ... Aug 23 15:16:13 acoman volumio[971]: info: Selecting previously unselected package libpython3.7-dev:armhf. Aug 23 15:16:13 acoman volumio[971]: info: Preparing to unpack .../22-libpython3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Aug 23 15:16:13 acoman volumio[971]: info: Unpacking libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Aug 23 15:16:14 acoman kernel: CIFS: __readahead_batch() returned 5/16 Aug 23 15:16:21 acoman dhcpcd[891]: wlan0: carrier lost Aug 23 15:16:21 acoman wpa_supplicant[879]: wlan0: CTRL-EVENT-DISCONNECTED bssid=d6:92:5e:db:fc:60 reason=8 Aug 23 15:16:21 acoman wpa_supplicant[879]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Aug 23 15:16:21 acoman wpa_supplicant[879]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=DE Aug 23 15:16:21 acoman dhcpcd[891]: wlan0: deleting route to 192.168.0.0/24 Aug 23 15:16:21 acoman dhcpcd[891]: wlan0: deleting default route via 192.168.0.1 Aug 23 15:16:21 acoman avahi-daemon[634]: Withdrawing address record for 192.168.0.101 on wlan0. Aug 23 15:16:21 acoman avahi-daemon[634]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.101. Aug 23 15:16:21 acoman avahi-daemon[634]: Interface wlan0.IPv4 no longer relevant for mDNS. Aug 23 15:16:21 acoman volumio[971]: info: Discovery: A device disappeared from network Aug 23 15:16:21 acoman volumio[971]: info: Discovery: Device acoman disappeared from network Aug 23 15:16:22 acoman wpa_supplicant[879]: wlan0: Trying to associate with SSID 'T-544115' Aug 23 15:16:22 acoman dhcpcd[891]: wlan0: carrier acquired Aug 23 15:16:22 acoman wpa_supplicant[879]: wlan0: Associated with d6:92:5e:db:fc:60 Aug 23 15:16:22 acoman wpa_supplicant[879]: wlan0: CTRL-EVENT-CONNECTED - Connection to d6:92:5e:db:fc:60 completed [id=0 id_str=] Aug 23 15:16:22 acoman wpa_supplicant[879]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 23 15:16:22 acoman wpa_supplicant[879]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Aug 23 15:16:24 acoman dhcpcd[891]: wlan0: IAID eb:29:4e:a4 Aug 23 15:16:24 acoman dhcpcd[891]: wlan0: carrier lost Aug 23 15:16:24 acoman ntpd[777]: Deleting interface #3 wlan0, 192.168.0.101#123, interface stats: received=221, sent=225, dropped=1, active_time=1740 secs Aug 23 15:16:24 acoman ntpd[777]: 87.197.132.218 local addr 192.168.0.101 -> Aug 23 15:16:24 acoman ntpd[777]: 87.197.97.150 local addr 192.168.0.101 -> Aug 23 15:16:24 acoman ntpd[777]: 185.242.56.5 local addr 192.168.0.101 -> Aug 23 15:16:24 acoman ntpd[777]: 84.245.104.80 local addr 192.168.0.101 -> Aug 23 15:16:24 acoman ntpd[777]: 92.240.244.202 local addr 192.168.0.101 -> Aug 23 15:16:24 acoman ntpd[777]: 62.168.94.161 local addr 192.168.0.101 -> Aug 23 15:16:24 acoman dhcpcd[891]: wlan0: carrier acquired Aug 23 15:16:24 acoman dhcpcd[891]: wlan0: IAID eb:29:4e:a4 Aug 23 15:16:25 acoman dhcpcd[891]: wlan0: soliciting an IPv6 router Aug 23 15:16:25 acoman volumio[971]: info: CorePlayQueue::getTrack 26 Aug 23 15:16:25 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:25 acoman volumio[971]: info: Prefetching next song Aug 23 15:16:25 acoman volumio[971]: info: DOING PREFETCH IN MPD Aug 23 15:16:25 acoman volumio[971]: verbose: ControllerMpd::sendMpdCommand add "NAS/synology/CLUB SOUNDS VOL. 84 (2018)/CD1/09 - Feel It Still (Ofenbach Remix).mp3" Aug 23 15:16:25 acoman volumio[971]: info: Aug 23 15:16:25 acoman volumio[971]: ---------------------------- MPD announces system playlist update Aug 23 15:16:25 acoman volumio[971]: info: Ignoring MPD Status Update Aug 23 15:16:25 acoman volumio[971]: info: sendMpdCommand add "NAS/synology/CLUB SOUNDS VOL. 84 (2018)/CD1/09 - Feel It Still (Ofenbach Remix).mp3" took 17 milliseconds Aug 23 15:16:25 acoman volumio[971]: verbose: ControllerMpd::sendMpdCommand consume 1 Aug 23 15:16:25 acoman volumio[971]: info: ------------------------------ 5ms Aug 23 15:16:25 acoman volumio[971]: info: sendMpdCommand consume 1 took 2 milliseconds Aug 23 15:16:25 acoman dhcpcd[891]: wlan0: soliciting a DHCP lease Aug 23 15:16:26 acoman volumio[971]: info: Selecting previously unselected package libpython3-dev:armhf. Aug 23 15:16:26 acoman volumio[971]: info: Preparing to unpack .../23-libpython3-dev_3.7.3-1_armhf.deb ... Aug 23 15:16:26 acoman volumio[971]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ... Aug 23 15:16:26 acoman volumio[971]: info: Selecting previously unselected package python-pip-whl. Aug 23 15:16:26 acoman volumio[971]: info: Preparing to unpack .../24-python-pip-whl_18.1-5+rpt1_all.deb ... Aug 23 15:16:26 acoman volumio[971]: info: Unpacking python-pip-whl (18.1-5+rpt1) ... Aug 23 15:16:27 acoman volumio[971]: info: Selecting previously unselected package python3-multidict. Aug 23 15:16:27 acoman volumio[971]: info: Preparing to unpack .../25-python3-multidict_4.5.2-1_armhf.deb ... Aug 23 15:16:27 acoman volumio[971]: info: Unpacking python3-multidict (4.5.2-1) ... Aug 23 15:16:27 acoman volumio[971]: info: Selecting previously unselected package python3-yarl. Aug 23 15:16:27 acoman volumio[971]: info: Preparing to unpack .../26-python3-yarl_1.3.0-1_armhf.deb ... Aug 23 15:16:27 acoman volumio[971]: info: Unpacking python3-yarl (1.3.0-1) ... Aug 23 15:16:28 acoman volumio[971]: info: Selecting previously unselected package python3-async-timeout. Aug 23 15:16:28 acoman volumio[971]: info: Preparing to unpack .../27-python3-async-timeout_3.0.1-1_all.deb ... Aug 23 15:16:28 acoman volumio[971]: info: Unpacking python3-async-timeout (3.0.1-1) ... Aug 23 15:16:28 acoman volumio[971]: info: Selecting previously unselected package python3-attr. Aug 23 15:16:28 acoman volumio[971]: info: Preparing to unpack .../28-python3-attr_18.2.0-1_all.deb ... Aug 23 15:16:28 acoman volumio[971]: info: Unpacking python3-attr (18.2.0-1) ... Aug 23 15:16:28 acoman volumio[971]: info: Selecting previously unselected package python3-aiohttp. Aug 23 15:16:28 acoman volumio[971]: info: Preparing to unpack .../29-python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ... Aug 23 15:16:28 acoman volumio[971]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ... Aug 23 15:16:29 acoman volumio[971]: info: Selecting previously unselected package python3-asn1crypto. Aug 23 15:16:29 acoman volumio[971]: info: Preparing to unpack .../30-python3-asn1crypto_0.24.0-1_all.deb ... Aug 23 15:16:29 acoman volumio[971]: info: Unpacking python3-asn1crypto (0.24.0-1) ... Aug 23 15:16:29 acoman volumio[971]: info: Selecting previously unselected package python3-cffi-backend. Aug 23 15:16:29 acoman volumio[971]: info: Preparing to unpack .../31-python3-cffi-backend_1.12.2-1_armhf.deb ... Aug 23 15:16:29 acoman volumio[971]: info: Unpacking python3-cffi-backend (1.12.2-1) ... Aug 23 15:16:29 acoman volumio[971]: info: CoreStateMachine::startPlaybackTimer Aug 23 15:16:29 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:29 acoman volumio[971]: info: Selecting previously unselected package python3-crypto. Aug 23 15:16:29 acoman volumio[971]: info: Preparing to unpack .../32-python3-crypto_2.6.1-9+b1_armhf.deb ... Aug 23 15:16:29 acoman volumio[971]: info: Unpacking python3-crypto (2.6.1-9+b1) ... Aug 23 15:16:30 acoman volumio[971]: info: CoreStateMachine::pushState Aug 23 15:16:30 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:30 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 15:16:30 acoman volumio[971]: info: CoreCommandRouter::volumioPushState Aug 23 15:16:30 acoman dhcpcd[891]: wlan0: probing address 192.168.0.101/24 Aug 23 15:16:35 acoman dhcpcd[891]: wlan0: leased 192.168.0.101 for 86400 seconds Aug 23 15:16:35 acoman avahi-daemon[634]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.101. Aug 23 15:16:35 acoman avahi-daemon[634]: New relevant interface wlan0.IPv4 for mDNS. Aug 23 15:16:35 acoman avahi-daemon[634]: Registering new address record for 192.168.0.101 on wlan0.IPv4. Aug 23 15:16:35 acoman dhcpcd[891]: wlan0: adding route to 192.168.0.0/24 Aug 23 15:16:35 acoman dhcpcd[891]: wlan0: adding default route via 192.168.0.1 Aug 23 15:16:36 acoman ntpd[777]: Listen normally on 4 wlan0 192.168.0.101:123 Aug 23 15:16:36 acoman ntpd[777]: new interface(s) found: waking up resolver Aug 23 15:16:39 acoman volumio[971]: info: Aug 23 15:16:39 acoman volumio[971]: ---------------------------- MPD announces system playlist update Aug 23 15:16:39 acoman volumio[971]: info: Ignoring MPD Status Update Aug 23 15:16:39 acoman volumio[971]: info: Aug 23 15:16:39 acoman volumio[971]: ---------------------------- MPD announces state update: player Aug 23 15:16:39 acoman volumio[971]: info: ControllerMpd::getState Aug 23 15:16:39 acoman volumio[971]: verbose: ControllerMpd::sendMpdCommand status Aug 23 15:16:39 acoman volumio[971]: info: Aug 23 15:16:39 acoman volumio[971]: ---------------------------- MPD announces state update: player Aug 23 15:16:39 acoman volumio[971]: info: ControllerMpd::getState Aug 23 15:16:39 acoman volumio[971]: verbose: ControllerMpd::sendMpdCommand status Aug 23 15:16:39 acoman volumio[971]: info: ------------------------------ 20ms Aug 23 15:16:39 acoman volumio[971]: info: sendMpdCommand status took 14 milliseconds Aug 23 15:16:39 acoman volumio[971]: verbose: ControllerMpd::parseState Aug 23 15:16:39 acoman volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 15:16:39 acoman volumio[971]: info: sendMpdCommand status took 20 milliseconds Aug 23 15:16:39 acoman volumio[971]: info: sendMpdCommand playlistinfo took 19 milliseconds Aug 23 15:16:39 acoman volumio[971]: verbose: ControllerMpd::parseState Aug 23 15:16:39 acoman volumio[971]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 15:16:39 acoman volumio[971]: verbose: ControllerMpd::parseTrackInfo Aug 23 15:16:39 acoman volumio[971]: info: ControllerMpd::pushState Aug 23 15:16:39 acoman volumio[971]: info: CoreCommandRouter::servicePushState Aug 23 15:16:39 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:39 acoman volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":176,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Feel It Still (Ofenbach Remix)","artist":"Portugal. The Man","album":"Club Sounds, Vol. 84","uri":"NAS/synology/CLUB SOUNDS VOL. 84 (2018)/CD1/09 - Feel It Still (Ofenbach Remix).mp3","trackType":"mp3"} Aug 23 15:16:39 acoman volumio[971]: verbose: CURRENT POSITION 8 Aug 23 15:16:39 acoman volumio[971]: info: CoreStateMachine::syncState stateService play Aug 23 15:16:39 acoman volumio[971]: info: CoreStateMachine::syncState currentStatus play Aug 23 15:16:39 acoman volumio[971]: info: Received an update from plugin. extracting info from payload Aug 23 15:16:39 acoman volumio[971]: info: CoreStateMachine::pushState Aug 23 15:16:39 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:39 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 15:16:39 acoman volumio[971]: info: CoreCommandRouter::volumioPushState Aug 23 15:16:39 acoman volumio[971]: info: CoreStateMachine::pushState Aug 23 15:16:39 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:39 acoman volumio[971]: info: CoreCommandRouter::volumioPushState Aug 23 15:16:39 acoman volumio[971]: info: ------------------------------ 67ms Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-cryptography. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../33-python3-cryptography_2.6.1-3+deb10u4_armhf.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-cryptography (2.6.1-3+deb10u4) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-dbus. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../34-python3-dbus_1.2.8-3_armhf.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-dbus (1.2.8-3) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3.7-dev. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../35-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-dev. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../36-python3-dev_3.7.3-1_armhf.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-dev (3.7.3-1) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-entrypoints. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../37-python3-entrypoints_0.3-1_all.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-entrypoints (0.3-1) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-gi. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../38-python3-gi_3.30.4-1_armhf.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-gi (3.30.4-1) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-secretstorage. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../39-python3-secretstorage_2.3.1-2_all.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-secretstorage (2.3.1-2) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-keyring. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../40-python3-keyring_17.1.1-1_all.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-keyring (17.1.1-1) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-keyrings.alt. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../41-python3-keyrings.alt_3.1.1-1_all.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-keyrings.alt (3.1.1-1) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-pip. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../42-python3-pip_18.1-5+rpt1_all.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-pip (18.1-5+rpt1) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-setuptools. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../43-python3-setuptools_40.8.0-1_all.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-setuptools (40.8.0-1) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-wheel. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../44-python3-wheel_0.32.3-2_all.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-wheel (0.32.3-2) ... Aug 23 15:16:39 acoman volumio[971]: info: Selecting previously unselected package python3-xdg. Aug 23 15:16:39 acoman volumio[971]: info: Preparing to unpack .../45-python3-xdg_0.25-5_all.deb ... Aug 23 15:16:39 acoman volumio[971]: info: Unpacking python3-xdg (0.25-5) ... Aug 23 15:16:39 acoman volumio[971]: info: Setting up python3-entrypoints (0.3-1) ... Aug 23 15:16:39 acoman volumio[971]: info: Setting up dh-python (3.20190308) ... Aug 23 15:16:40 acoman volumio[971]: info: sendMpdCommand playlistinfo took 411 milliseconds Aug 23 15:16:40 acoman volumio[971]: verbose: ControllerMpd::parseTrackInfo Aug 23 15:16:40 acoman volumio[971]: info: ControllerMpd::pushState Aug 23 15:16:40 acoman volumio[971]: info: CoreCommandRouter::servicePushState Aug 23 15:16:40 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:40 acoman volumio[971]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":176,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Feel It Still (Ofenbach Remix)","artist":"Portugal. The Man","album":"Club Sounds, Vol. 84","uri":"NAS/synology/CLUB SOUNDS VOL. 84 (2018)/CD1/09 - Feel It Still (Ofenbach Remix).mp3","trackType":"mp3"} Aug 23 15:16:40 acoman volumio[971]: verbose: CURRENT POSITION 8 Aug 23 15:16:40 acoman volumio[971]: info: CoreStateMachine::syncState stateService play Aug 23 15:16:40 acoman volumio[971]: info: CoreStateMachine::syncState currentStatus play Aug 23 15:16:40 acoman volumio[971]: info: Received an update from plugin. extracting info from payload Aug 23 15:16:40 acoman volumio[971]: info: CoreStateMachine::pushState Aug 23 15:16:40 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:40 acoman volumio[971]: info: CoreCommandRouter::volumioPushState Aug 23 15:16:40 acoman volumio[971]: info: CoreStateMachine::pushState Aug 23 15:16:40 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:40 acoman volumio[971]: info: CoreCommandRouter::volumioPushState Aug 23 15:16:40 acoman volumio[971]: info: ------------------------------ 465ms Aug 23 15:16:40 acoman volumio[971]: info: Setting up python3-attr (18.2.0-1) ... Aug 23 15:16:40 acoman volumio[971]: info: Discovery: adding 8172b441-ed33-4f05-87ab-0d9f98686f1b Aug 23 15:16:40 acoman volumio[971]: info: Discovery: Found device Acoman Aug 23 15:16:40 acoman volumio[971]: info: CoreCommandRouter::volumioGetState Aug 23 15:16:40 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:40 acoman ntpd[777]: Soliciting pool server 193.87.160.18 Aug 23 15:16:40 acoman volumio[971]: info: Setting up python3-dbus (1.2.8-3) ... Aug 23 15:16:41 acoman volumio[971]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.160 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::volumioGetVisibleSources Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::volumioGetState Aug 23 15:16:41 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::volumioGetState Aug 23 15:16:41 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 23 15:16:41 acoman volumio[971]: info: Received Get System Info Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 15:16:41 acoman volumio[971]: info: Discovery: Getting this device information Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::volumioGetState Aug 23 15:16:41 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::volumioGetState Aug 23 15:16:41 acoman volumio[971]: info: CorePlayQueue::getTrack 8 Aug 23 15:16:41 acoman volumio[971]: info: Listing playlists Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::volumioGetQueue Aug 23 15:16:41 acoman volumio[971]: info: CoreStateMachine::getQueue Aug 23 15:16:41 acoman volumio[971]: info: CorePlayQueue::getQueue Aug 23 15:16:41 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 23 15:16:41 acoman ntpd[777]: Soliciting pool server 212.55.254.189 Aug 23 15:16:42 acoman volumio[971]: info: Setting up python3-setuptools (40.8.0-1) ... Aug 23 15:16:43 acoman volumio[971]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ... Aug 23 15:16:44 acoman volumio[971]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ... Aug 23 15:16:44 acoman volumio[971]: info: Setting up python3-xdg (0.25-5) ... Aug 23 15:16:45 acoman volumio[971]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ... Aug 23 15:16:45 acoman volumio[971]: info: Setting up python3-wheel (0.32.3-2) ... Aug 23 15:16:46 acoman volumio[971]: info: Setting up python3-multidict (4.5.2-1) ... Aug 23 15:16:46 acoman volumio[971]: info: Setting up libfakeroot:armhf (1.23-1) ... Aug 23 15:16:46 acoman volumio[971]: info: Setting up python3-async-timeout (3.0.1-1) ... Aug 23 15:16:47 acoman volumio[971]: info: Setting up fakeroot (1.23-1) ... Aug 23 15:16:47 acoman volumio[971]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode Aug 23 15:16:47 acoman volumio[971]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/fakeroot.1.gz because associated file /usr/share/man/es/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Aug 23 15:16:47 acoman volumio[971]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/faked.1.gz because associated file /usr/share/man/es/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Aug 23 15:16:47 acoman volumio[971]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/fakeroot.1.gz because associated file /usr/share/man/fr/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Aug 23 15:16:47 acoman volumio[971]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/faked.1.gz because associated file /usr/share/man/fr/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Aug 23 15:16:47 acoman volumio[971]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/fakeroot.1.gz because associated file /usr/share/man/sv/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist Aug 23 15:16:47 acoman volumio[971]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/faked.1.gz because associated file /usr/share/man/sv/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist Aug 23 15:16:47 acoman volumio[971]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ... Aug 23 15:16:47 acoman volumio[971]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Aug 23 15:16:47 acoman volumio[971]: info: Setting up make (4.2.1-1.2) ... Aug 23 15:16:48 acoman volumio[971]: info: Setting up python3-gi (3.30.4-1) ... Aug 23 15:16:49 acoman volumio[971]: info: Setting up patch (2.7.6-3+deb10u1) ... Aug 23 15:16:49 acoman volumio[971]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ... Aug 23 15:16:49 acoman volumio[971]: info: Setting up python3-crypto (2.6.1-9+b1) ... Aug 23 15:16:50 acoman ntpd[777]: Soliciting pool server 213.81.129.99 Aug 23 15:16:50 acoman volumio[971]: info: Setting up python-pip-whl (18.1-5+rpt1) ... Aug 23 15:16:50 acoman volumio[971]: info: Setting up python3-yarl (1.3.0-1) ... Aug 23 15:16:51 acoman ntpd[777]: Soliciting pool server 91.237.170.89 Aug 23 15:16:51 acoman volumio[971]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ... Aug 23 15:16:51 acoman volumio[971]: info: Setting up python3-asn1crypto (0.24.0-1) ... Aug 23 15:16:53 acoman volumio[971]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ... Aug 23 15:16:53 acoman volumio[971]: info: Setting up python3-cffi-backend (1.12.2-1) ... Aug 23 15:16:53 acoman volumio[971]: info: Setting up libalgorithm-merge-perl (0.08-3) ... Aug 23 15:16:53 acoman volumio[971]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Aug 23 15:16:53 acoman volumio[971]: info: Setting up python3-aiohttp (3.5.1-1+deb10u1) ... Aug 23 15:16:54 acoman volumio[971]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ... Aug 23 15:16:54 acoman volumio[971]: info: Setting up dpkg-dev (1.19.8) ... Aug 23 15:16:54 acoman volumio[971]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ... Aug 23 15:16:56 acoman volumio[971]: info: Setting up python3-pip (18.1-5+rpt1) ... Aug 23 15:16:57 acoman volumio[971]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Aug 23 15:16:57 acoman volumio[971]: info: Setting up python3-keyrings.alt (3.1.1-1) ... Aug 23 15:16:58 acoman volumio[971]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Aug 23 15:16:58 acoman volumio[971]: info: Setting up gcc-8 (8.3.0-6+rpi1) ... Aug 23 15:16:58 acoman volumio[971]: info: Setting up libpython3-dev:armhf (3.7.3-1) ... Aug 23 15:16:58 acoman volumio[971]: info: Setting up gcc (4:8.3.0-1+rpi2) ... Aug 23 15:16:58 acoman volumio[971]: info: Setting up python3-secretstorage (2.3.1-2) ... Aug 23 15:16:59 acoman volumio[971]: info: Setting up python3-dev (3.7.3-1) ... Aug 23 15:16:59 acoman volumio[971]: info: Setting up g++-8 (8.3.0-6+rpi1) ... Aug 23 15:16:59 acoman volumio[971]: info: Setting up python3-keyring (17.1.1-1) ... Aug 23 15:17:00 acoman volumio[971]: info: Setting up g++ (4:8.3.0-1+rpi2) ... Aug 23 15:17:00 acoman volumio[971]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode Aug 23 15:17:00 acoman volumio[971]: info: Setting up build-essential (12.6) ... Aug 23 15:17:00 acoman volumio[971]: info: Processing triggers for man-db (2.8.5-2+deb10u1) ... Aug 23 15:17:03 acoman volumio[971]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Aug 23 15:17:05 acoman sudo[7978]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:05 acoman sudo[9106]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Aug 23 15:17:05 acoman sudo[9106]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:05 acoman volumio[971]: info: lib/systemd/system/fusiondsp.service Aug 23 15:17:05 acoman sudo[9106]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:08 acoman volumio[971]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Aug 23 15:17:08 acoman volumio[971]: info: more info at http://www.winimage.com/zLibDll/unzip.html Aug 23 15:17:08 acoman volumio[971]: info: Aug 23 15:17:08 acoman sudo[9111]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Aug 23 15:17:08 acoman volumio[971]: info: cgui-1.0.0.zip opened Aug 23 15:17:08 acoman sudo[9111]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:08 acoman volumio[971]: info: creating directory: cgui/ Aug 23 15:17:08 acoman volumio[971]: info: extracting: cgui/LICENSE.txt Aug 23 15:17:08 acoman volumio[971]: info: extracting: cgui/README.md Aug 23 15:17:08 acoman volumio[971]: info: creating directory: cgui/build/ Aug 23 15:17:08 acoman volumio[971]: info: extracting: cgui/build/robots.txt Aug 23 15:17:08 acoman volumio[971]: info: extracting: cgui/build/logo512.png Aug 23 15:17:09 acoman sudo[9111]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:09 acoman sudo[9114]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Aug 23 15:17:09 acoman sudo[9114]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:09 acoman sudo[9114]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/asset-manifest.json Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/index.html Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/.put_statics_here Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/favicon.ico Aug 23 15:17:09 acoman sudo[9116]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/logo192.png Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/manifest.json Aug 23 15:17:09 acoman sudo[9116]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/css-variables.css Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/service-worker.js Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Aug 23 15:17:09 acoman volumio[971]: info: creating directory: cgui/build/static/ Aug 23 15:17:09 acoman volumio[971]: info: creating directory: cgui/build/static/css/ Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/main.1503f6cd.css Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Aug 23 15:17:09 acoman volumio[971]: info: creating directory: cgui/build/static/media/ Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Aug 23 15:17:09 acoman volumio[971]: info: creating directory: cgui/build/static/js/ Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/main.71e11955.js Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/main.71e11955.js.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Aug 23 15:17:09 acoman volumio[971]: info: creating directory: cgui/config/ Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/config/camillagui.yml Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/config/gui-config.yml Aug 23 15:17:09 acoman volumio[971]: info: creating directory: cgui/backend/ Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/filters_test.py Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/version.py Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/filters.py Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/settings.py Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/views.py Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/filterdefaults.py Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__init__.py Aug 23 15:17:09 acoman volumio[971]: info: creating directory: cgui/backend/__pycache__/ Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/routes.py Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/backend/filemanagement.py Aug 23 15:17:09 acoman volumio[971]: info: extracting: cgui/main.py Aug 23 15:17:09 acoman sudo[9116]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:10 acoman volumio[971]: info: Enabling plugin fusiondsp Aug 23 15:17:10 acoman volumio[971]: info: Loading plugin "fusiondsp"... Aug 23 15:17:11 acoman volumio[971]: info: Preparing to generate the ALSA configuration file Aug 23 15:17:11 acoman volumio[971]: info: Asound.conf file unchanged, so no further update is needed Aug 23 15:17:11 acoman volumio[971]: info: Output device has changed, restarting MPD Aug 23 15:17:11 acoman sudo[9121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 23 15:17:11 acoman sudo[9121]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:11 acoman volumio[971]: info: Output device has changed, restarting Shairport Sync Aug 23 15:17:11 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:11 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 23 15:17:11 acoman sudo[9121]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:11 acoman sudo[9124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 23 15:17:11 acoman sudo[9124]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:11 acoman systemd[1]: Stopping Music Player Daemon... Aug 23 15:17:12 acoman volumio[971]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 23 15:17:12 acoman volumio[971]: info: PLUGIN START: fusiondsp Aug 23 15:17:12 acoman volumio[971]: info: Loading i18n strings for locale sk Aug 23 15:17:12 acoman volumio[971]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 23 15:17:12 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 23 15:17:12 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:12 acoman volumio[971]: info: FusionDsp - mixtype--------------------- Hardware Aug 23 15:17:12 acoman volumio[971]: info: Preparing to generate the ALSA configuration file Aug 23 15:17:12 acoman volumio[971]: info: Done. Aug 23 15:17:12 acoman volumio[971]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 23 15:17:12 acoman volumio[971]: info: Reading ALSA contributions from plugins. Aug 23 15:17:12 acoman volumio[971]: info: MPD Permissions set Aug 23 15:17:12 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:12 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:12 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 23 15:17:12 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:12 acoman volumio[971]: info: Starting Shairport Sync Aug 23 15:17:12 acoman volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 15:17:12 acoman volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 15:17:12 acoman sudo[9134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 23 15:17:12 acoman sudo[9134]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:12 acoman systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 23 15:17:12 acoman systemd[1]: shairport-sync.service: Succeeded. Aug 23 15:17:12 acoman systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 23 15:17:12 acoman systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 23 15:17:12 acoman sudo[9134]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:12 acoman volumio[971]: info: Asound.conf file written Aug 23 15:17:12 acoman sudo[9139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 23 15:17:12 acoman sudo[9139]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:12 acoman sudo[9139]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:13 acoman volumio[971]: info: Output device has changed, restarting MPD Aug 23 15:17:13 acoman sudo[9146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 23 15:17:13 acoman sudo[9146]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:13 acoman volumio[971]: info: Output device has changed, restarting Shairport Sync Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 23 15:17:13 acoman sudo[9146]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:13 acoman sudo[9156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 23 15:17:13 acoman sudo[9156]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:13 acoman volumio[971]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 23 15:17:13 acoman volumio[971]: info: Shairport-Sync Started Aug 23 15:17:13 acoman volumio[971]: info: MPD Permissions set Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 23 15:17:13 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:13 acoman volumio[971]: info: Starting Shairport Sync Aug 23 15:17:13 acoman sudo[9221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 23 15:17:13 acoman sudo[9221]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:13 acoman systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 23 15:17:13 acoman systemd[1]: shairport-sync.service: Succeeded. Aug 23 15:17:13 acoman systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 23 15:17:13 acoman systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 23 15:17:13 acoman systemd[1]: mpd.service: Succeeded. Aug 23 15:17:13 acoman sudo[9221]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:13 acoman volumio[971]: info: Shairport-Sync Started Aug 23 15:17:13 acoman systemd[1]: Stopped Music Player Daemon. Aug 23 15:17:13 acoman systemd[1]: Starting Music Player Daemon... Aug 23 15:17:14 acoman sudo[9225]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 23 15:17:14 acoman sudo[9225]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:14 acoman sudo[9225]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:14 acoman volumio[971]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 23 15:17:14 acoman volumio[971]: info: camilladsp service started and running in background, instance 1 Aug 23 15:17:14 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 23 15:17:14 acoman volumio[971]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 23 15:17:14 acoman volumio[971]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 23 15:17:14 acoman volumio[971]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 23 15:17:14 acoman volumio[971]: info: FusionDsp loaded Aug 23 15:17:14 acoman volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 15:17:14 acoman sudo[9241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 23 15:17:14 acoman sudo[9241]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:15 acoman volumio[971]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 23 15:17:15 acoman volumio[971]: info: Adding Signal Path Element [object Object] Aug 23 15:17:15 acoman volumio[971]: info: Adding fusiondspeq DSP Signal Path Element Aug 23 15:17:15 acoman volumio[971]: info: FusionDsp - ---- installed callbackRead Aug 23 15:17:16 acoman systemd[1]: Started FusionDsp Daemon. Aug 23 15:17:16 acoman sudo[9241]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:16 acoman volumio[971]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 15:17:16 acoman volumio[971]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 23 15:17:16 acoman volumio[971]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 23 15:17:16 acoman volumio[971]: at onErrorNT (internal/child_process.js:465:16) Aug 23 15:17:16 acoman volumio[971]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 23 15:17:16 acoman volumio[971]: errno: -2, Aug 23 15:17:16 acoman volumio[971]: code: 'ENOENT', Aug 23 15:17:16 acoman volumio[971]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 23 15:17:16 acoman volumio[971]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 23 15:17:16 acoman volumio[971]: spawnargs: [ Aug 23 15:17:16 acoman volumio[971]: '-p', Aug 23 15:17:16 acoman volumio[971]: 9876, Aug 23 15:17:16 acoman volumio[971]: '-o', Aug 23 15:17:16 acoman volumio[971]: '/tmp/camilladsp.log', Aug 23 15:17:16 acoman volumio[971]: '-l', Aug 23 15:17:16 acoman volumio[971]: 'warn', Aug 23 15:17:16 acoman volumio[971]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 23 15:17:16 acoman volumio[971]: ] Aug 23 15:17:16 acoman volumio[971]: } Aug 23 15:17:16 acoman volumio[971]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 15:17:18 acoman volumio[9243]: Traceback (most recent call last): Aug 23 15:17:18 acoman volumio[9243]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 4, in Aug 23 15:17:18 acoman volumio[9243]: from camilladsp import CamillaConnection Aug 23 15:17:18 acoman volumio[9243]: ModuleNotFoundError: No module named 'camilladsp' Aug 23 15:17:18 acoman mpd[9230]: Aug 23 15:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 23 15:17:18 acoman systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Aug 23 15:17:18 acoman systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Aug 23 15:17:18 acoman sudo[9253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-23 15:16 Aug 23 15:17:18 acoman sudo[9253]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 15:17:18 acoman systemd[1]: Started Music Player Daemon. Aug 23 15:17:18 acoman sudo[9156]: pam_unix(sudo:session): session closed for user root Aug 23 15:17:18 acoman sudo[9124]: pam_unix(sudo:session): session closed for user root 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"