-- Logs begin at Fri 2025-05-30 06:44:49 UTC, end at Fri 2025-05-30 07:03:14 UTC. -- May 30 07:02:11 volumio-hp3-server volumio-remote-updater[3375]: [2025-05-30 07:02:11] [connect] Successful connection May 30 07:02:26 volumio-hp3-server volumio-remote-updater[3375]: [2025-05-30 07:02:26] [connect] Successful connection May 30 07:02:33 volumio-hp3-server volumio[942]: info: Checking if install.sh is present May 30 07:02:33 volumio-hp3-server volumio[942]: info: May 30 07:02:33 volumio-hp3-server volumio[942]: ---------------------------- MPD announces state update: player May 30 07:02:33 volumio-hp3-server volumio[942]: info: ControllerMpd::getState May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand status May 30 07:02:33 volumio-hp3-server volumio[942]: info: Executing install.sh May 30 07:02:33 volumio-hp3-server volumio[942]: info: sendMpdCommand status took 106 milliseconds May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: ControllerMpd::parseState May 30 07:02:33 volumio-hp3-server volumio[942]: info: ControllerMpd::pushState May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::servicePushState May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreStateMachine::pushState May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioPushState May 30 07:02:33 volumio-hp3-server sudo[5378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_controller/autostart/install.sh May 30 07:02:33 volumio-hp3-server volumio[942]: info: CorePlayQueue::getTrack 0 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: CURRENT POSITION 0 May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreStateMachine::syncState stateService stop May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreStateMachine::syncState currentStatus play May 30 07:02:33 volumio-hp3-server sudo[5378]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreStateMachine::play index undefined May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreStateMachine::setConsumeUpdateService undefined May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreStateMachine::pushState May 30 07:02:33 volumio-hp3-server sudo[5378]: pam_unix(sudo:session): session closed for user root May 30 07:02:33 volumio-hp3-server volumio[942]: info: CorePlayQueue::getTrack 1 May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioPushState May 30 07:02:33 volumio-hp3-server volumio[942]: info: CorePlayQueue::getTrack 1 May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreStateMachine::startPlaybackTimer May 30 07:02:33 volumio-hp3-server volumio[942]: info: CorePlayQueue::getTrack 1 May 30 07:02:33 volumio-hp3-server volumio[942]: info: [1748588553270] ControllerUPNPBrowser::clearAddPlayTrack May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand stop May 30 07:02:33 volumio-hp3-server volumio[942]: info: ------------------------------ 162ms May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreStateMachine::pushState May 30 07:02:33 volumio-hp3-server volumio[942]: info: CorePlayQueue::getTrack 1 May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioPushState May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:14 http://deb.debian.org/debian buster/main amd64 libgcc-8-dev amd64 8.3.0-6 [2298 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:15 http://deb.debian.org/debian buster/main amd64 gcc-8 amd64 8.3.0-6 [9452 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:16 http://deb.debian.org/debian buster/main amd64 gcc amd64 4:8.3.0-1 [5196 B] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:17 http://deb.debian.org/debian buster/main amd64 libstdc++-8-dev amd64 8.3.0-6 [1532 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:18 http://deb.debian.org/debian buster/main amd64 g++-8 amd64 8.3.0-6 [9752 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:19 http://deb.debian.org/debian buster/main amd64 g++ amd64 4:8.3.0-1 [1644 B] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:20 http://deb.debian.org/debian buster/main amd64 make amd64 4.2.1-1.2 [341 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:21 http://deb.debian.org/debian buster/main amd64 patch amd64 2.7.6-3+deb10u1 [126 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:22 http://deb.debian.org/debian buster/main amd64 dpkg-dev all 1.19.8 [1776 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:23 http://deb.debian.org/debian buster/main amd64 build-essential amd64 12.6 [7576 B] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:24 http://deb.debian.org/debian buster/main amd64 dh-python all 3.20190308 [99.3 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:25 http://deb.debian.org/debian buster/main amd64 libfakeroot amd64 1.23-1 [45.9 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:26 http://deb.debian.org/debian buster/main amd64 fakeroot amd64 1.23-1 [85.8 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:27 http://deb.debian.org/debian buster/main amd64 libalgorithm-diff-perl all 1.19.03-2 [47.9 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:28 http://deb.debian.org/debian buster/main amd64 libalgorithm-diff-xs-perl amd64 0.04-5+b1 [11.8 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:29 http://deb.debian.org/debian buster/main amd64 libalgorithm-merge-perl all 0.08-3 [12.7 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:30 http://deb.debian.org/debian buster/main amd64 libexpat1-dev amd64 2.2.6-2+deb10u4 [155 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:31 http://deb.debian.org/debian buster/main amd64 libpython3.7 amd64 3.7.3-2+deb10u3 [1498 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:32 http://deb.debian.org/debian buster/main amd64 libpython3.7-dev amd64 3.7.3-2+deb10u3 [48.4 MB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:33 http://deb.debian.org/debian buster/main amd64 libpython3-dev amd64 3.7.3-1 [20.1 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:34 http://deb.debian.org/debian buster/main amd64 python-pip-whl all 18.1-5 [1591 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:35 http://deb.debian.org/debian buster/main amd64 python3-multidict amd64 4.5.2-1 [60.6 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:36 http://deb.debian.org/debian buster/main amd64 python3-yarl amd64 1.3.0-1 [48.3 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:37 http://deb.debian.org/debian buster/main amd64 python3-async-timeout all 3.0.1-1 [6292 B] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:38 http://deb.debian.org/debian buster/main amd64 python3-attr all 18.2.0-1 [37.3 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:39 http://deb.debian.org/debian buster/main amd64 python3-aiohttp amd64 3.5.1-1+deb10u1 [261 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:40 http://deb.debian.org/debian buster/main amd64 python3-asn1crypto all 0.24.0-1 [78.2 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:41 http://deb.debian.org/debian buster/main amd64 python3-cffi-backend amd64 1.12.2-1 [79.7 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:42 http://deb.debian.org/debian buster/main amd64 python3-crypto amd64 2.6.1-9+b1 [263 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:43 http://deb.debian.org/debian buster/main amd64 python3-cryptography amd64 2.6.1-3+deb10u2 [219 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:44 http://deb.debian.org/debian buster/main amd64 python3-dbus amd64 1.2.8-3 [103 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:45 http://deb.debian.org/debian buster/main amd64 python3.7-dev amd64 3.7.3-2+deb10u3 [510 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:46 http://deb.debian.org/debian buster/main amd64 python3-dev amd64 3.7.3-1 [1264 B] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:47 http://deb.debian.org/debian buster/main amd64 python3-entrypoints all 0.3-1 [5508 B] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:48 http://deb.debian.org/debian buster/main amd64 python3-gi amd64 3.30.4-1 [180 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:49 http://deb.debian.org/debian buster/main amd64 python3-secretstorage all 2.3.1-2 [14.2 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:50 http://deb.debian.org/debian buster/main amd64 python3-keyring all 17.1.1-1 [43.1 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:51 http://deb.debian.org/debian buster/main amd64 python3-keyrings.alt all 3.1.1-1 [18.2 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:52 http://deb.debian.org/debian buster/main amd64 python3-pip all 18.1-5 [171 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:53 http://deb.debian.org/debian buster/main amd64 python3-setuptools all 40.8.0-1 [306 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:54 http://deb.debian.org/debian buster/main amd64 python3-wheel all 0.32.3-2 [19.4 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Get:55 http://deb.debian.org/debian buster/main amd64 python3-xdg all 0.25-5 [35.9 kB] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Fetched 85.3 MB in 3min 21s (424 kB/s) May 30 07:02:33 volumio-hp3-server volumio[942]: info: Selecting previously unselected package bzip2. May 30 07:02:33 volumio-hp3-server volumio[942]: [620B blob data] May 30 07:02:33 volumio-hp3-server volumio[942]: info: Preparing to unpack .../00-bzip2_1.0.6-9.2~deb10u1_amd64.deb ... May 30 07:02:33 volumio-hp3-server volumio[942]: info: Unpacking bzip2 (1.0.6-9.2~deb10u1) ... May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 30 07:02:33 volumio-hp3-server volumio[942]: info: sendMpdCommand stop took 271 milliseconds May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand clear May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 May 30 07:02:33 volumio-hp3-server volumio[942]: info: Install script completed May 30 07:02:33 volumio-hp3-server volumio[942]: info: Adding reference to registry May 30 07:02:33 volumio-hp3-server volumio[942]: info: Done installing plugin. May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 30 07:02:33 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 30 07:02:33 volumio-hp3-server volumio[942]: info: May 30 07:02:33 volumio-hp3-server volumio[942]: ---------------------------- MPD announces system playlist update May 30 07:02:33 volumio-hp3-server volumio[942]: info: Ignoring MPD Status Update May 30 07:02:33 volumio-hp3-server volumio[942]: info: sendMpdCommand clear took 56 milliseconds May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.2.254:8200/MediaItems/510.mp3" May 30 07:02:33 volumio-hp3-server volumio[942]: info: Installing autostart Dependencies - no special dependencies needed May 30 07:02:33 volumio-hp3-server volumio[942]: Plugin install end detected on script May 30 07:02:33 volumio-hp3-server volumio[942]: info: Installing autostart Dependencies - no special dependencies needed May 30 07:02:33 volumio-hp3-server volumio[942]: Plugin install end detected on script May 30 07:02:33 volumio-hp3-server volumio[942]: info: Folder /tmp/plugins removed May 30 07:02:33 volumio-hp3-server volumio[942]: info: Folder /tmp/downloaded_plugin.zip removed May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 May 30 07:02:33 volumio-hp3-server volumio[942]: error: updateQueue error: null May 30 07:02:33 volumio-hp3-server volumio[942]: info: ------------------------------ 55ms May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 21 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 22 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 24 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 25 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 26 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 27 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 29 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 30 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 31 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 32 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 33 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 34 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 35 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 36 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 37 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 38 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 39 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 40 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 41 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 42 May 30 07:02:33 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 43 May 30 07:02:34 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 44 May 30 07:02:34 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioGetState May 30 07:02:34 volumio-hp3-server volumio[942]: info: CorePlayQueue::getTrack 1 May 30 07:02:35 volumio-hp3-server volumio[942]: info: Folder /data/temp removed May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 45 May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.2.254:8200/MediaItems/510.mp3" May 30 07:02:35 volumio-hp3-server volumio[942]: info: May 30 07:02:35 volumio-hp3-server volumio[942]: ---------------------------- MPD announces system playlist update May 30 07:02:35 volumio-hp3-server volumio[942]: info: Ignoring MPD Status Update May 30 07:02:35 volumio-hp3-server volumio[942]: info: sendMpdCommand add "http://192.168.2.254:8200/MediaItems/510.mp3" took 4 milliseconds May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreStateMachine::setConsumeUpdateService mpd May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand play May 30 07:02:35 volumio-hp3-server volumio[942]: info: ------------------------------ 7ms May 30 07:02:35 volumio-hp3-server volumio[942]: info: sendMpdCommand play took 5 milliseconds May 30 07:02:35 volumio-hp3-server volumio[942]: info: May 30 07:02:35 volumio-hp3-server volumio[942]: ---------------------------- MPD announces state update: player May 30 07:02:35 volumio-hp3-server volumio[942]: info: ControllerMpd::getState May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand status May 30 07:02:35 volumio-hp3-server volumio[942]: info: May 30 07:02:35 volumio-hp3-server volumio[942]: ---------------------------- MPD announces state update: player May 30 07:02:35 volumio-hp3-server volumio[942]: info: sendMpdCommand status took 5 milliseconds May 30 07:02:35 volumio-hp3-server volumio[942]: info: ControllerMpd::getState May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand status May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::parseState May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:02:35 volumio-hp3-server volumio[942]: info: sendMpdCommand status took 13 milliseconds May 30 07:02:35 volumio-hp3-server volumio[942]: info: sendMpdCommand playlistinfo took 15 milliseconds May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::parseState May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::parseTrackInfo May 30 07:02:35 volumio-hp3-server volumio[942]: info: ControllerMpd::pushState May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreCommandRouter::servicePushState May 30 07:02:35 volumio-hp3-server volumio[942]: info: CorePlayQueue::getTrack 1 May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":416,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"510.mp3","artist":null,"album":null,"uri":"http://192.168.2.254:8200/MediaItems/510.mp3","trackType":"mp3"} May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: CURRENT POSITION 1 May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreStateMachine::syncState stateService play May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreStateMachine::syncState currentStatus stop May 30 07:02:35 volumio-hp3-server volumio[942]: info: ------------------------------ 30ms May 30 07:02:35 volumio-hp3-server volumio[942]: info: sendMpdCommand playlistinfo took 6 milliseconds May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: ControllerMpd::parseTrackInfo May 30 07:02:35 volumio-hp3-server volumio[942]: info: ControllerMpd::pushState May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreCommandRouter::servicePushState May 30 07:02:35 volumio-hp3-server volumio[942]: info: CorePlayQueue::getTrack 1 May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":416,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"510.mp3","artist":null,"album":null,"uri":"http://192.168.2.254:8200/MediaItems/510.mp3","trackType":"mp3"} May 30 07:02:35 volumio-hp3-server volumio[942]: verbose: CURRENT POSITION 1 May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreStateMachine::syncState stateService play May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreStateMachine::syncState currentStatus play May 30 07:02:35 volumio-hp3-server volumio[942]: info: Received an update from plugin. extracting info from payload May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreStateMachine::pushState May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioPushState May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreStateMachine::pushState May 30 07:02:35 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioPushState May 30 07:02:35 volumio-hp3-server volumio[942]: info: ------------------------------ 54ms May 30 07:02:38 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 46 May 30 07:02:41 volumio-hp3-server volumio-remote-updater[3375]: [2025-05-30 07:02:41] [connect] Successful connection May 30 07:02:41 volumio-hp3-server volumio-remote-updater[3375]: [2025-05-30 07:02:41] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748588561 101 May 30 07:02:41 volumio-hp3-server volumio[942]: 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: 47 May 30 07:02:43 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 48 May 30 07:02:49 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 49 May 30 07:02:54 volumio-hp3-server volumio[942]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 50 May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioGetVisibleSources May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioGetState May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 30 07:02:54 volumio-hp3-server volumio[942]: info: Received Get System Info May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 07:02:54 volumio-hp3-server volumio[942]: info: Discovery: Getting this device information May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioGetState May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioGetState May 30 07:02:54 volumio-hp3-server volumio[942]: info: Listing playlists May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::volumioGetQueue May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreStateMachine::getQueue May 30 07:02:54 volumio-hp3-server volumio[942]: info: CorePlayQueue::getQueue May 30 07:02:54 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 30 07:03:06 volumio-hp3-server volumio[942]: info: Enabling plugin fusiondsp May 30 07:03:06 volumio-hp3-server volumio[942]: info: Loading plugin "fusiondsp"... May 30 07:03:07 volumio-hp3-server volumio[942]: info: Preparing to generate the ALSA configuration file May 30 07:03:07 volumio-hp3-server volumio[942]: info: Asound.conf file unchanged, so no further update is needed May 30 07:03:07 volumio-hp3-server volumio[942]: info: Output device has changed, restarting MPD May 30 07:03:07 volumio-hp3-server sudo[5512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 30 07:03:07 volumio-hp3-server sudo[5512]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 07:03:07 volumio-hp3-server volumio[942]: info: Output device has changed, restarting Shairport Sync May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 07:03:07 volumio-hp3-server sudo[5512]: pam_unix(sudo:session): session closed for user root May 30 07:03:07 volumio-hp3-server sudo[5514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 30 07:03:07 volumio-hp3-server sudo[5514]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 07:03:07 volumio-hp3-server volumio[942]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 30 07:03:07 volumio-hp3-server volumio[942]: info: PLUGIN START: fusiondsp May 30 07:03:07 volumio-hp3-server systemd[1]: Stopping Music Player Daemon... May 30 07:03:07 volumio-hp3-server volumio[942]: info: Loading i18n strings for locale th May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: FusionDsp - mixtype--------------------- Hardware May 30 07:03:07 volumio-hp3-server volumio[942]: info: Preparing to generate the ALSA configuration file May 30 07:03:07 volumio-hp3-server systemd[1]: mpd.service: Succeeded. May 30 07:03:07 volumio-hp3-server volumio[942]: info: Done. May 30 07:03:07 volumio-hp3-server systemd[1]: Stopped Music Player Daemon. May 30 07:03:07 volumio-hp3-server volumio[942]: info: MPD Permissions set May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server systemd[1]: Starting Music Player Daemon... May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: Asound.conf file unchanged, so no further update is needed May 30 07:03:07 volumio-hp3-server volumio[942]: info: Output device has changed, restarting MPD May 30 07:03:07 volumio-hp3-server sudo[5528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 30 07:03:07 volumio-hp3-server sudo[5528]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 07:03:07 volumio-hp3-server sudo[5528]: pam_unix(sudo:session): session closed for user root May 30 07:03:07 volumio-hp3-server volumio[942]: info: Output device has changed, restarting Shairport Sync May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 07:03:07 volumio-hp3-server sudo[5532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 30 07:03:07 volumio-hp3-server sudo[5532]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 07:03:07 volumio-hp3-server systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM May 30 07:03:07 volumio-hp3-server systemd[1]: mpd.service: Succeeded. May 30 07:03:07 volumio-hp3-server systemd[1]: Stopped Music Player Daemon. May 30 07:03:07 volumio-hp3-server volumio[942]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 30 07:03:07 volumio-hp3-server systemd[1]: Starting Music Player Daemon... May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::getUIConfigOnPlugin May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::getUIConfigOnPlugin May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::getUIConfigOnPlugin May 30 07:03:07 volumio-hp3-server volumio[942]: info: MPD Permissions set May 30 07:03:07 volumio-hp3-server volumio[942]: info: Starting Shairport Sync May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server sudo[5540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 30 07:03:07 volumio-hp3-server sudo[5540]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 07:03:07 volumio-hp3-server systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 30 07:03:07 volumio-hp3-server systemd[1]: shairport-sync.service: Succeeded. May 30 07:03:07 volumio-hp3-server systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 30 07:03:07 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:07 volumio-hp3-server sudo[5537]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 30 07:03:07 volumio-hp3-server sudo[5537]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 07:03:07 volumio-hp3-server volumio[942]: info: FusionDsp - May 30 07:03:07 volumio-hp3-server systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 30 07:03:07 volumio-hp3-server sudo[5540]: pam_unix(sudo:session): session closed for user root May 30 07:03:07 volumio-hp3-server sudo[5537]: pam_unix(sudo:session): session closed for user root May 30 07:03:08 volumio-hp3-server volumio[942]: info: FusionDsp - May 30 07:03:08 volumio-hp3-server volumio[942]: info: FusionDsp - May 30 07:03:13 volumio-hp3-server mpd[5550]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 30 07:03:13 volumio-hp3-server mpd[5550]: output: No 'audio_output' defined in config file May 30 07:03:13 volumio-hp3-server mpd[5550]: couldn't open play stream: No such file or directory May 30 07:03:13 volumio-hp3-server mpd[5550]: sndio_output: Error opening default sndio device May 30 07:03:13 volumio-hp3-server mpd[5550]: output: Successfully detected a alsa audio device May 30 07:03:13 volumio-hp3-server mpd[5550]: zeroconf: No global port, disabling zeroconf May 30 07:03:13 volumio-hp3-server systemd[1]: Started Music Player Daemon. May 30 07:03:13 volumio-hp3-server volumio[942]: info: FusionDsp - undefined May 30 07:03:13 volumio-hp3-server sudo[5514]: pam_unix(sudo:session): session closed for user root May 30 07:03:13 volumio-hp3-server sudo[5532]: pam_unix(sudo:session): session closed for user root May 30 07:03:13 volumio-hp3-server volumio[942]: info: FusionDsp - undefined May 30 07:03:13 volumio-hp3-server volumio[942]: info: FusionDsp - undefined May 30 07:03:13 volumio-hp3-server volumio[942]: info: Enabling plugin autostart May 30 07:03:13 volumio-hp3-server volumio[942]: info: Loading plugin "autostart"... May 30 07:03:13 volumio-hp3-server volumio[942]: info: AutoStart - onVolumioStart - read config.json May 30 07:03:13 volumio-hp3-server volumio[942]: info: PLUGIN START: autostart May 30 07:03:13 volumio-hp3-server volumio[942]: info: AutoStart - onStart May 30 07:03:13 volumio-hp3-server volumio[942]: info: Done. May 30 07:03:13 volumio-hp3-server volumio[942]: info: Shairport-Sync Started May 30 07:03:13 volumio-hp3-server volumio[942]: info: camilladsp service started and running in background, instance 1 May 30 07:03:13 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 07:03:13 volumio-hp3-server volumio[942]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 30 07:03:13 volumio-hp3-server volumio[942]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 30 07:03:13 volumio-hp3-server volumio[942]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 30 07:03:13 volumio-hp3-server volumio[942]: info: FusionDsp loaded May 30 07:03:13 volumio-hp3-server volumio[942]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 07:03:13 volumio-hp3-server sudo[5579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 30 07:03:13 volumio-hp3-server sudo[5579]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 07:03:13 volumio-hp3-server volumio[942]: info: FusionDsp - Reporting Fusion DSP Enabled May 30 07:03:13 volumio-hp3-server volumio[942]: info: Adding Signal Path Element [object Object] May 30 07:03:13 volumio-hp3-server volumio[942]: info: Adding fusiondspeq DSP Signal Path Element May 30 07:03:13 volumio-hp3-server sudo[5579]: pam_unix(sudo:session): session closed for user root May 30 07:03:13 volumio-hp3-server volumio[942]: info: FusionDsp - ---- installed callbackRead May 30 07:03:13 volumio-hp3-server volumio[942]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 07:03:13 volumio-hp3-server volumio[942]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT May 30 07:03:13 volumio-hp3-server volumio[942]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) May 30 07:03:13 volumio-hp3-server volumio[942]: at onErrorNT (internal/child_process.js:472:16) May 30 07:03:13 volumio-hp3-server volumio[942]: at processTicksAndRejections (internal/process/task_queues.js:82:21) May 30 07:03:13 volumio-hp3-server volumio[942]: at runNextTicks (internal/process/task_queues.js:64:3) May 30 07:03:13 volumio-hp3-server volumio[942]: at listOnTimeout (internal/timers.js:526:9) May 30 07:03:13 volumio-hp3-server volumio[942]: at processTimers (internal/timers.js:500:7) { May 30 07:03:13 volumio-hp3-server volumio[942]: errno: -2, May 30 07:03:13 volumio-hp3-server volumio[942]: code: 'ENOENT', May 30 07:03:13 volumio-hp3-server volumio[942]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', May 30 07:03:13 volumio-hp3-server volumio[942]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', May 30 07:03:13 volumio-hp3-server volumio[942]: spawnargs: [ May 30 07:03:13 volumio-hp3-server volumio[942]: '-p', May 30 07:03:13 volumio-hp3-server volumio[942]: 9876, May 30 07:03:13 volumio-hp3-server volumio[942]: '-o', May 30 07:03:13 volumio-hp3-server volumio[942]: '/tmp/camilladsp.log', May 30 07:03:13 volumio-hp3-server volumio[942]: '-l', May 30 07:03:13 volumio-hp3-server volumio[942]: 'warn', May 30 07:03:13 volumio-hp3-server volumio[942]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' May 30 07:03:13 volumio-hp3-server volumio[942]: ] May 30 07:03:13 volumio-hp3-server volumio[942]: } May 30 07:03:13 volumio-hp3-server volumio[942]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 07:03:14 volumio-hp3-server sudo[5590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-30 07:02 May 30 07:03:14 volumio-hp3-server sudo[5590]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"