-- Logs begin at Fri 2025-12-26 14:02:48 CET, end at Sat 2025-12-27 18:36:57 CET. --
Dec 27 18:35:00 volumio volumio[764]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done'
Dec 27 18:35:00 volumio volumio[764]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-bo39l634/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6
Dec 27 18:35:00 volumio volumio[764]: info: Successfully built camilladsp
Dec 27 18:35:05 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:35:05 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:35:09 volumio volumio[764]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
Dec 27 18:35:09 volumio volumio[764]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2
Dec 27 18:35:09 volumio volumio[764]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-rfhbbt9k
Dec 27 18:35:12 volumio volumio[764]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp-plot==1.0.2 from git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 in /usr/local/lib/python3.7/dist-packages
Dec 27 18:35:12 volumio volumio[764]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1)
Dec 27 18:35:12 volumio volumio[764]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3)
Dec 27 18:35:12 volumio nmbd[649]: [2025/12/27 18:35:12.498992, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Dec 27 18:35:12 volumio nmbd[649]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.20 for name WORKGROUP<1d>.
Dec 27 18:35:12 volumio nmbd[649]: This response was from IP 192.168.1.21, reporting an IP address of 192.168.1.21.
Dec 27 18:35:12 volumio volumio[764]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0)
Dec 27 18:35:12 volumio volumio[764]: info: Requirement already satisfied: pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (0.19.3)
Dec 27 18:35:12 volumio volumio[764]: info: Requirement already satisfied: importlib-metadata; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (6.7.0)
Dec 27 18:35:12 volumio volumio[764]: info: Requirement already satisfied: importlib-resources>=1.4.0; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (5.12.0)
Dec 27 18:35:13 volumio volumio[764]: info: Requirement already satisfied: typing-extensions; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (4.7.1)
Dec 27 18:35:13 volumio volumio[764]: info: Requirement already satisfied: pkgutil-resolve-name>=1.3.10; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (1.3.10)
Dec 27 18:35:13 volumio volumio[764]: info: Requirement already satisfied: zipp>=0.5 in /usr/local/lib/python3.7/dist-packages (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) (3.15.0)
Dec 27 18:35:13 volumio volumio[764]: info: Building wheels for collected packages: camilladsp-plot
Dec 27 18:35:13 volumio volumio[764]: info: Running setup.py bdist_wheel for camilladsp-plot: started
Dec 27 18:35:15 volumio volumio[764]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done'
Dec 27 18:35:15 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:35:15 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:35:15 volumio volumio[764]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-5gusws0s/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9
Dec 27 18:35:15 volumio volumio[764]: info: Listing playlists
Dec 27 18:35:15 volumio volumio[764]: info: Listing playlists
Dec 27 18:35:15 volumio volumio[764]: info: Successfully built camilladsp-plot
Dec 27 18:35:15 volumio volumio[764]: info: copying hw detection script
Dec 27 18:35:15 volumio volumio[764]: info: Detected cpu architecture as armv7l
Dec 27 18:35:17 volumio sudo[26905]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params
Dec 27 18:35:17 volumio sudo[26905]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 27 18:35:17 volumio sudo[26905]: pam_unix(sudo:session): session closed for user root
Dec 27 18:35:17 volumio sudo[26907]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params
Dec 27 18:35:17 volumio sudo[26907]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 27 18:35:17 volumio sudo[26907]: pam_unix(sudo:session): session closed for user root
Dec 27 18:35:17 volumio sudo[26909]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc
Dec 27 18:35:17 volumio sudo[26909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 27 18:35:17 volumio volumio[764]: info: Reading package lists...
Dec 27 18:35:18 volumio go-librespot[1066]: time="2025-12-27T18:35:18+01:00" level=trace msg="sent dealer ping"
Dec 27 18:35:18 volumio go-librespot[1066]: time="2025-12-27T18:35:18+01:00" level=trace msg="received dealer pong"
Dec 27 18:35:18 volumio volumio[764]: info: Building dependency tree...
Dec 27 18:35:18 volumio volumio[764]: info: Reading state information...
Dec 27 18:35:20 volumio volumio[764]: info: drc is already the newest version (3.2.2~dfsg0-2).
Dec 27 18:35:20 volumio sudo[26909]: pam_unix(sudo:session): session closed for user root
Dec 27 18:35:20 volumio sudo[26467]: pam_unix(sudo:session): session closed for user root
Dec 27 18:35:20 volumio volumio[764]: info: 0 upgraded, 0 newly installed, 0 to remove and 18 not upgraded.
Dec 27 18:35:20 volumio volumio[764]: info: Install script completed
Dec 27 18:35:20 volumio volumio[764]: info: Done installing plugin.
Dec 27 18:35:20 volumio volumio[764]: info: Enabling plugin fusiondsp
Dec 27 18:35:20 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 27 18:35:20 volumio volumio[764]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.62","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Jellyfin","name":"jellyfin","category":"music_service","version":"1.1.1","icon":"fa-music","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"1.2.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.0.6","icon":"fa-youtube","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Backup & Restore Data","name":"backup_restore","category":"system_controller","version":"0.7.4","icon":"fa-floppy-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"IR Remote Controller","name":"ir_controller","category":"system_hardware","version":"3.4.13","icon":"fa-magic","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.5","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true}]
Dec 27 18:35:20 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 27 18:35:20 volumio volumio[764]: info: Folder /tmp/plugins removed
Dec 27 18:35:20 volumio volumio[764]: info: Folder /tmp/downloaded_plugin.zip removed
Dec 27 18:35:20 volumio volumio[764]: Plugin install end detected on script
Dec 27 18:35:20 volumio volumio[764]: info: Folder /data/temp removed
Dec 27 18:35:25 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:35:25 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:35:35 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:35:35 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:35:35 volumio volumio[764]: info: Listing playlists
Dec 27 18:35:35 volumio volumio[764]: info: Listing playlists
Dec 27 18:35:45 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:35:45 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:35:48 volumio go-librespot[1066]: time="2025-12-27T18:35:48+01:00" level=trace msg="sent dealer ping"
Dec 27 18:35:48 volumio go-librespot[1066]: time="2025-12-27T18:35:48+01:00" level=trace msg="received dealer pong"
Dec 27 18:35:55 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:35:55 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:35:55 volumio volumio[764]: info: Listing playlists
Dec 27 18:35:55 volumio volumio[764]: info: Listing playlists
Dec 27 18:36:05 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:36:05 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:36:15 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:36:15 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:36:15 volumio volumio[764]: info: Listing playlists
Dec 27 18:36:15 volumio volumio[764]: info: Listing playlists
Dec 27 18:36:18 volumio go-librespot[1066]: time="2025-12-27T18:36:18+01:00" level=trace msg="sent dealer ping"
Dec 27 18:36:18 volumio go-librespot[1066]: time="2025-12-27T18:36:18+01:00" level=trace msg="received dealer pong"
Dec 27 18:36:25 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:36:25 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:36:35 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:36:35 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:36:35 volumio volumio[764]: info: Listing playlists
Dec 27 18:36:35 volumio volumio[764]: info: Listing playlists
Dec 27 18:36:41 volumio go-librespot[1066]: time="2025-12-27T18:36:41+01:00" level=trace msg="received accesspoint ping"
Dec 27 18:36:41 volumio go-librespot[1066]: time="2025-12-27T18:36:41+01:00" level=trace msg="received accesspoint pong ack"
Dec 27 18:36:45 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:36:45 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:36:48 volumio go-librespot[1066]: time="2025-12-27T18:36:48+01:00" level=trace msg="sent dealer ping"
Dec 27 18:36:48 volumio go-librespot[1066]: time="2025-12-27T18:36:48+01:00" level=trace msg="received dealer pong"
Dec 27 18:36:49 volumio sudo[27109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 27 18:36:49 volumio sudo[27109]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 27 18:36:49 volumio sudo[27109]: pam_unix(sudo:session): session closed for user root
Dec 27 18:36:49 volumio sudo[27112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 27 18:36:49 volumio sudo[27112]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 27 18:36:49 volumio sudo[27112]: pam_unix(sudo:session): session closed for user root
Dec 27 18:36:49 volumio volumio[764]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.81 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:36:49 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 27 18:36:49 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 27 18:36:52 volumio volumio[764]: info: Received Get System Info
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 27 18:36:52 volumio volumio[764]: info: Discovery: Getting this device information
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:36:52 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 27 18:36:52 volumio volumio[764]: info: Received Get System Info
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 27 18:36:52 volumio volumio[764]: info: Discovery: Getting this device information
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::volumioGetState
Dec 27 18:36:52 volumio volumio[764]: info: CorePlayQueue::getTrack 0
Dec 27 18:36:52 volumio volumio[764]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 27 18:36:52 volumio volumio[764]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Dec 27 18:36:54 volumio volumio[764]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Dec 27 18:36:54 volumio volumio[764]: info: FusionDsp - Stopping FusionDsp service
Dec 27 18:36:54 volumio volumio[764]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 27 18:36:55 volumio volumio[764]: TypeError: Cannot read property 'stop' of null
Dec 27 18:36:55 volumio volumio[764]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23)
Dec 27 18:36:55 volumio volumio[764]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Dec 27 18:36:55 volumio volumio[764]: at /volumio/app/pluginmanager.js:956:12
Dec 27 18:36:55 volumio volumio[764]: at ChildProcess.exithandler (child_process.js:299:7)
Dec 27 18:36:55 volumio volumio[764]: at ChildProcess.emit (events.js:315:20)
Dec 27 18:36:55 volumio volumio[764]: at maybeClose (internal/child_process.js:1048:16)
Dec 27 18:36:55 volumio volumio[764]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5)
Dec 27 18:36:55 volumio volumio[764]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 27 18:36:57 volumio sudo[27128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-27 18:35
Dec 27 18:36:57 volumio sudo[27128]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"