-- Logs begin at Mon 2025-01-20 23:31:59 CET, end at Mon 2025-01-20 23:35:29 CET. -- Jan 20 23:34:01 volumio go-librespot[1384]: time="2025-01-20T23:34:01+01:00" level=trace msg="sent dealer ping" Jan 20 23:34:01 volumio go-librespot[1384]: time="2025-01-20T23:34:01+01:00" level=trace msg="received dealer pong" Jan 20 23:34:04 volumio volumio[997]: info: BOOT COMPLETED Jan 20 23:34:06 volumio volumio[1196]: .............................................................................................................................................................................................................................................................++++ Jan 20 23:34:06 volumio volumio[1196]: e is 65537 (0x010001) Jan 20 23:34:06 volumio volumio[1196]: writing RSA key Jan 20 23:34:10 volumio go-librespot[1384]: time="2025-01-20T23:34:10+01:00" level=debug msg="fetched chunk 4/19, size: 524288" uri="spotify:track:7FLaAGmHHEiBmvmmuwMDwF" Jan 20 23:34:24 volumio go-librespot[1384]: time="2025-01-20T23:34:24+01:00" level=debug msg="fetched chunk 5/19, size: 524288" uri="spotify:track:7FLaAGmHHEiBmvmmuwMDwF" Jan 20 23:34:31 volumio go-librespot[1384]: time="2025-01-20T23:34:31+01:00" level=trace msg="sent dealer ping" Jan 20 23:34:31 volumio go-librespot[1384]: time="2025-01-20T23:34:31+01:00" level=trace msg="received dealer pong" Jan 20 23:34:35 volumio go-librespot[1384]: time="2025-01-20T23:34:35+01:00" level=debug msg="update volume to 62011/65535" Jan 20 23:34:35 volumio go-librespot[1384]: time="2025-01-20T23:34:35+01:00" level=debug msg="update volume to 59897/65535" Jan 20 23:34:35 volumio go-librespot[1384]: time="2025-01-20T23:34:35+01:00" level=debug msg="update volume to 57783/65535" Jan 20 23:34:35 volumio go-librespot[1384]: time="2025-01-20T23:34:35+01:00" level=debug msg="update volume to 54964/65535" Jan 20 23:34:36 volumio go-librespot[1384]: time="2025-01-20T23:34:36+01:00" level=debug msg="update volume to 50736/65535" Jan 20 23:34:36 volumio go-librespot[1384]: time="2025-01-20T23:34:36+01:00" level=debug msg="update volume to 50032/65535" Jan 20 23:34:36 volumio go-librespot[1384]: time="2025-01-20T23:34:36+01:00" level=debug msg="fetched chunk 6/19, size: 524288" uri="spotify:track:7FLaAGmHHEiBmvmmuwMDwF" Jan 20 23:34:37 volumio go-librespot[1384]: time="2025-01-20T23:34:37+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Jan 20 23:34:37 volumio go-librespot[1384]: time="2025-01-20T23:34:37+01:00" level=trace msg="emitting websocket event: volume" Jan 20 23:34:37 volumio volumio[997]: SPOTIFY: received: {"type":"volume","data":{"value":77,"max":100}} Jan 20 23:34:37 volumio volumio[997]: SPOTIFY: RECEIVED SPOTIFY VOLUME 77 Jan 20 23:34:37 volumio volumio[997]: info: Setting Volumio Volume from Spotify: 77 Jan 20 23:34:37 volumio volumio[997]: info: VolumeController::SetAlsaVolume77 Jan 20 23:34:37 volumio volumio[997]: info: CoreStateMachine::pushState Jan 20 23:34:37 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 23:34:37 volumio volumio[997]: info: CoreCommandRouter::volumioPushState Jan 20 23:34:37 volumio volumio[997]: info: FusionDsp - volume level for loudness 77 gain applied 0.00 Jan 20 23:34:37 volumio volumio[997]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 23:34:37 volumio volumio[997]: info: FusionDsp - Loudness is ON true Jan 20 23:34:37 volumio volumio[997]: SPOTIFY: RECEIVED VOLUMIO VOLUME 77 Jan 20 23:34:37 volumio volumio[997]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Jan 20 23:34:37 volumio volumio[997]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 23:34:49 volumio go-librespot[1384]: time="2025-01-20T23:34:49+01:00" level=debug msg="fetched chunk 7/19, size: 524288" uri="spotify:track:7FLaAGmHHEiBmvmmuwMDwF" Jan 20 23:34:55 volumio volumio[997]: info: CALLMETHOD: audio_interface fusiondsp usethispreset [object Object] Jan 20 23:34:55 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , usethispreset Jan 20 23:34:55 volumio volumio[997]: info: FusionDsp - value state4preset None,false,true,50,0,0,0,None,false,false,false,0,0,false Jan 20 23:34:55 volumio volumio[997]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 23:34:55 volumio volumio[997]: info: FusionDsp - Loudness is ON true Jan 20 23:34:55 volumio volumio[997]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 23:34:56 volumio volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 23:34:56 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jan 20 23:35:00 volumio volumio[997]: info: CALLMETHOD: audio_interface fusiondsp disableeffect undefined Jan 20 23:35:00 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , disableeffect Jan 20 23:35:01 volumio volumio[997]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 23:35:01 volumio volumio[997]: info: FusionDsp - Effects disabled Jan 20 23:35:01 volumio volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 23:35:01 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jan 20 23:35:01 volumio go-librespot[1384]: time="2025-01-20T23:35:01+01:00" level=trace msg="received accesspoint ping" Jan 20 23:35:01 volumio volumio[997]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 23:35:01 volumio go-librespot[1384]: time="2025-01-20T23:35:01+01:00" level=trace msg="received accesspoint pong ack" Jan 20 23:35:01 volumio go-librespot[1384]: time="2025-01-20T23:35:01+01:00" level=trace msg="sent dealer ping" Jan 20 23:35:01 volumio go-librespot[1384]: time="2025-01-20T23:35:01+01:00" level=trace msg="received dealer pong" Jan 20 23:35:02 volumio go-librespot[1384]: time="2025-01-20T23:35:02+01:00" level=debug msg="fetched chunk 8/19, size: 524288" uri="spotify:track:7FLaAGmHHEiBmvmmuwMDwF" Jan 20 23:35:05 volumio volumio[997]: info: CALLMETHOD: audio_interface fusiondsp enableeffect undefined Jan 20 23:35:05 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , enableeffect Jan 20 23:35:05 volumio volumio[997]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 20 23:35:05 volumio volumio[997]: info: FusionDsp - Loudness is ON true Jan 20 23:35:05 volumio volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 23:35:05 volumio volumio[997]: info: CoreCommandRouter::Close All Modals sent Jan 20 23:35:05 volumio volumio[997]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 20 23:35:15 volumio go-librespot[1384]: time="2025-01-20T23:35:15+01:00" level=debug msg="fetched chunk 9/19, size: 524288" uri="spotify:track:7FLaAGmHHEiBmvmmuwMDwF" Jan 20 23:35:15 volumio volumio[997]: info: CoreCommandRouter::volumioGetState Jan 20 23:35:20 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 20 23:35:20 volumio volumio[997]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 20 23:35:20 volumio volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 23:35:20 volumio volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 23:35:20 volumio volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 23:35:20 volumio volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 23:35:20 volumio volumio[997]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 20 23:35:28 volumio volumio[997]: info: Starting Uninstall of plugin system_hardware - iractivityled Jan 20 23:35:28 volumio volumio[997]: info: Uninstalling plugin iractivityled Jan 20 23:35:28 volumio lircd[1421]: lircd-0.10.1[1421]: Info: removed client Jan 20 23:35:28 volumio lircd-0.10.1[1421]: Info: removed client Jan 20 23:35:28 volumio volumio[997]: info: [IrActivityLed] releasing built-in LED Jan 20 23:35:28 volumio volumio[997]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 23:35:28 volumio volumio[997]: TypeError: Cannot read property 'toString' of undefined Jan 20 23:35:28 volumio volumio[997]: at IrActivityLedController.releaseLed (/data/plugins/system_hardware/iractivityled/index.js:232:61) Jan 20 23:35:28 volumio volumio[997]: at IrActivityLedController.onStop (/data/plugins/system_hardware/iractivityled/index.js:68:17) Jan 20 23:35:28 volumio volumio[997]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jan 20 23:35:28 volumio volumio[997]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Jan 20 23:35:28 volumio volumio[997]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1478:22) Jan 20 23:35:28 volumio volumio[997]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1254:45) Jan 20 23:35:28 volumio volumio[997]: at Socket.emit (events.js:315:20) Jan 20 23:35:28 volumio volumio[997]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jan 20 23:35:28 volumio volumio[997]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jan 20 23:35:28 volumio volumio[997]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 23:35:29 volumio go-librespot[1384]: time="2025-01-20T23:35:29+01:00" level=debug msg="fetched chunk 10/19, size: 524288" uri="spotify:track:7FLaAGmHHEiBmvmmuwMDwF" Jan 20 23:35:29 volumio sudo[2323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 23:34 Jan 20 23:35:29 volumio sudo[2323]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"