Oct 16 12:27:19 rivoplus volumio[27273]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Oct 16 12:27:20 rivoplus volumio[27273]: info: handleBrowseUri took 869 milliseconds Oct 16 12:27:20 rivoplus volumio[27273]: info: Preload queue cleared Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/455523434 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/212142342 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/288436014 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/98824699 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/212142336 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/126645455 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/455523440 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/60583525 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/98824704 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/212142341 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/455523447 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/55775269 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/288436009 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/32351740 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/56355964 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/55776460 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/455523443 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/104464430 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/352669695 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/98824705 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/56340360 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/223599816 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/98824702 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/55776463 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/288436011 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/212142339 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/288436007 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/455523433 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/212142344 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/101193637 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/302007861 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/98824701 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/55775268 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/212142340 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/98824700 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/288436008 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/55775275 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/455523428 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/55776462 Oct 16 12:27:20 rivoplus volumio[27273]: info: Preloading song: qobuz://song/56355967 Oct 16 12:27:20 rivoplus volumio[27273]: info: Exploding uri qobuz://song/455523434 in service qobuz Oct 16 12:27:20 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:20 rivoplus volumio[27273]: info: Exploding uri qobuz://song/212142342 in service qobuz Oct 16 12:27:20 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:20 rivoplus volumio[27273]: info: Exploding uri qobuz://song/288436014 in service qobuz Oct 16 12:27:20 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/98824699 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/212142336 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/126645455 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/455523440 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 342 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/60583525 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/98824704 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/212142341 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/455523447 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/55775269 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 554 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/288436009 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 514 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/32351740 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/56355964 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/55776460 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/455523443 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 746 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 497 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/104464430 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/352669695 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 609 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 678 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 604 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/98824705 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 358 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/56340360 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 338 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: explodeUri took 608 milliseconds Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/223599816 in service qobuz Oct 16 12:27:21 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:21 rivoplus volumio[27273]: info: Exploding uri qobuz://song/98824702 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/55776463 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 665 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 607 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/288436011 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 335 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 339 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 406 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 743 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 414 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/212142339 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/288436007 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 361 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 615 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 349 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/455523433 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/212142344 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 370 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 330 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/101193637 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/302007861 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 343 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/98824701 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/55775268 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 335 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/212142340 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 511 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 326 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 433 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/98824700 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 329 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/288436008 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 328 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/55775275 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/455523428 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 322 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 374 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/55776462 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: Exploding uri qobuz://song/56355967 in service qobuz Oct 16 12:27:22 rivoplus volumio[27273]: https://prod.vlmapi.io/v2/qobuz/explodeUri Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 355 milliseconds Oct 16 12:27:22 rivoplus volumio[27273]: info: explodeUri took 380 milliseconds Oct 16 12:27:23 rivoplus volumio[27273]: info: explodeUri took 400 milliseconds Oct 16 12:27:23 rivoplus volumio[27273]: info: explodeUri took 372 milliseconds Oct 16 12:27:23 rivoplus volumio[27273]: info: explodeUri took 368 milliseconds Oct 16 12:27:23 rivoplus volumio[27273]: info: explodeUri took 412 milliseconds Oct 16 12:27:23 rivoplus volumio[27273]: info: explodeUri took 328 milliseconds Oct 16 12:27:23 rivoplus volumio[27273]: info: explodeUri took 404 milliseconds Oct 16 12:27:29 rivoplus volumio[27273]: Searching all installed plugins Oct 16 12:27:29 rivoplus volumio[27273]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 12:27:29 rivoplus volumio[27273]: info: CoreCommandRouter::executeOnPlugin: , search Oct 16 12:27:29 rivoplus volumio[27273]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 16 12:27:29 rivoplus volumio[27273]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Oct 16 12:27:29 rivoplus volumio[27273]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Oct 16 12:27:29 rivoplus volumio[27273]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Oct 16 12:27:29 rivoplus volumio[27273]: info: CoreCommandRouter::executeOnPlugin: webradio , search Oct 16 12:27:29 rivoplus volumio[27273]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Oct 16 12:27:29 rivoplus volumio[27273]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 12:27:29 rivoplus volumio[27273]: XMLStructuredError: Premature end of data in tag br line 187 (Line: 195, Column: 7) Oct 16 12:27:29 rivoplus volumio[27273]: at new XMLStructuredError (/volumio/node_modules/libxmljs/dist/lib/types.js:23:28) Oct 16 12:27:29 rivoplus volumio[27273]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:190:23 Oct 16 12:27:29 rivoplus volumio[27273]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49) Oct 16 12:27:29 rivoplus volumio[27273]: at /volumio/app/plugins/music_service/webradio/index.js:962:31 Oct 16 12:27:29 rivoplus volumio[27273]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) { Oct 16 12:27:29 rivoplus volumio[27273]: domain: 1, Oct 16 12:27:29 rivoplus volumio[27273]: code: 77, Oct 16 12:27:29 rivoplus volumio[27273]: level: 3, Oct 16 12:27:29 rivoplus volumio[27273]: column: 7, Oct 16 12:27:29 rivoplus volumio[27273]: file: '', Oct 16 12:27:29 rivoplus volumio[27273]: line: 195, Oct 16 12:27:29 rivoplus volumio[27273]: str1: 'br', Oct 16 12:27:29 rivoplus volumio[27273]: str2: undefined, Oct 16 12:27:29 rivoplus volumio[27273]: str3: undefined, Oct 16 12:27:29 rivoplus volumio[27273]: int1: 187 Oct 16 12:27:29 rivoplus volumio[27273]: } Oct 16 12:27:29 rivoplus volumio[27273]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 12:27:30 rivoplus sudo[28144]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 12:26' Oct 16 12:27:30 rivoplus sudo[28144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:30 rivoplus sudo[28144]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:30 rivoplus volumio-remote-updater[2981]: [2026-10-16 12:27:30] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 16 12:27:30 rivoplus volumio-remote-updater[2981]: [2026-10-16 12:27:30] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 16 12:27:30 rivoplus volumio5-onboarding[3912]: time=2026-10-16T12:27:30.485+03:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Oct 16 12:27:30 rivoplus qobuz-connect[27610]: 20261016 12:27:30.494 [27610.27610] INFO SampleApp: Socket closed Oct 16 12:27:30 rivoplus volumio5-onboarding[3912]: time=2026-10-16T12:27:30.503+03:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:40638->127.0.0.1:3000: read: connection reset by peer" Oct 16 12:27:30 rivoplus systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 16 12:27:30 rivoplus sudo[27559]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:30 rivoplus go-librespot[27618]: time="2026-10-16T12:27:30+03:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Oct 16 12:27:30 rivoplus systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 16 12:27:30 rivoplus systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 16 12:27:30 rivoplus systemd[1]: dynamicswap.service: Deactivated successfully. Oct 16 12:27:30 rivoplus systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12. Oct 16 12:27:30 rivoplus systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 16 12:27:30 rivoplus systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 16 12:27:30 rivoplus systemd[1]: Started volumio.service - Volumio Backend Module. Oct 16 12:27:30 rivoplus systemd[1]: dynamicswap.service: Deactivated successfully. Oct 16 12:27:31 rivoplus volumio5-onboarding[3912]: time=2026-10-16T12:27:31.510+03:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 12:27:32 rivoplus volumio5-onboarding[3912]: time=2026-10-16T12:27:32.514+03:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 12:27:33 rivoplus volumio[28162]: info: ------------------------------------------- Oct 16 12:27:33 rivoplus volumio[28162]: info: ----- Volumio3 ---- Oct 16 12:27:33 rivoplus volumio[28162]: info: ------------------------------------------- Oct 16 12:27:33 rivoplus volumio[28162]: info: ----- System startup ---- Oct 16 12:27:33 rivoplus volumio[28162]: info: ------------------------------------------- Oct 16 12:27:35 rivoplus volumio[28162]: info: MYVOLUMIO Environment detected Oct 16 12:27:35 rivoplus volumio[28162]: info: Plugin folders cleanup Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning into folder /volumio/app/plugins/ Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning category audio_interface Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning category miscellanea Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning category music_service Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning category plugins.json Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning category system_controller Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning category user_interface Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning into folder /data/plugins/ Oct 16 12:27:35 rivoplus volumio[28162]: info: Scanning category music_service Oct 16 12:27:35 rivoplus volumio[28162]: info: Plugin folders cleanup completed Oct 16 12:27:35 rivoplus volumio[28162]: info: ------------------------------------------- Oct 16 12:27:35 rivoplus volumio[28162]: info: ----- Core plugins startup ---- Oct 16 12:27:35 rivoplus volumio[28162]: info: ------------------------------------------- Oct 16 12:27:35 rivoplus volumio-remote-updater[2981]: [2026-10-16 12:27:35] [connect] Successful connection Oct 16 12:27:35 rivoplus volumio[28162]: info: Loading plugins from folder /volumio/app/plugins/ Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin bluetooth to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin multiroom to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin upnp to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin metavolumio to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin cd_controller to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin raat to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 16 12:27:35 rivoplus volumio[28162]: info: Loading plugins from folder /data/plugins/ Oct 16 12:27:35 rivoplus volumio[28162]: info: Loading plugin "system"... Oct 16 12:27:35 rivoplus volumio[28162]: info: Loading plugin "appearance"... Oct 16 12:27:37 rivoplus volumio[28162]: info: Loading plugin "network"... Oct 16 12:27:37 rivoplus volumio[28162]: info: Refreshing Cached IP Addresses Oct 16 12:27:37 rivoplus sudo[28190]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 12:27:37 rivoplus sudo[28192]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 12:27:37 rivoplus sudo[28190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:37 rivoplus sudo[28192]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:37 rivoplus volumio[28162]: info: Loading plugin "services"... Oct 16 12:27:37 rivoplus volumio[28162]: info: Loading plugin "volumio5onboarding"... Oct 16 12:27:37 rivoplus sudo[28192]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:37 rivoplus sudo[28190]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:37 rivoplus sudo[28195]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 16 12:27:37 rivoplus sudo[28195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:37 rivoplus volumio[28162]: info: Loading plugin "alsa_controller"... Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 12:27:37 rivoplus volumio[28162]: info: Loading plugin "wizard"... Oct 16 12:27:37 rivoplus volumio[28162]: info: Loading plugin "networkfs"... Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:37 rivoplus volumio[28162]: info: Starting Udev Watcher for removable devices Oct 16 12:27:38 rivoplus volumio[28162]: info: Ignoring mount for partition: BOOT Oct 16 12:27:38 rivoplus volumio[28162]: info: Ignoring mount for partition: volumio Oct 16 12:27:38 rivoplus volumio[28162]: info: Ignoring mount for partition: volumio_data Oct 16 12:27:38 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 12:27:38 rivoplus volumio[28162]: info: Loading plugin "volumio_command_line_client"... Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus volumio[28162]: info: Loading plugin "upnp"... Oct 16 12:27:38 rivoplus volumio[28162]: info: [1792142858040] Starting Upmpd Daemon Oct 16 12:27:38 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 12:27:38 rivoplus volumio[28162]: info: Loading plugin "my_music"... Oct 16 12:27:38 rivoplus volumio[28162]: info: Loading plugin "mpd"... Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus volumio[28162]: info: Loading plugin "upnp_browser"... Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:38 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:39 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus volumio[28162]: info: Starting UPNP Browser Oct 16 12:27:40 rivoplus volumio[28162]: info: Plugin bluetooth is not enabled Oct 16 12:27:40 rivoplus volumio[28162]: info: Loading plugin "alarm-clock"... Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus volumio[28162]: info: Loading plugin "manifestui"... Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 12:27:40 rivoplus volumio[28162]: info: Loading plugin "metavolumio"... Oct 16 12:27:40 rivoplus kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04fe8c000 drv_status 0x0 e_type 69 e_states 0 Oct 16 12:27:40 rivoplus sudo[28195]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:41 rivoplus volumio5-onboarding[3912]: time=2026-10-16T12:27:41.216+03:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.116:64161,00:00:00:00:00:00%16 @ 0x14c25d0" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Oct 16 12:27:42 rivoplus volumio[28162]: info: Loading plugin "airplay_emulation"... Oct 16 12:27:42 rivoplus volumio[28162]: info: Starting Shairport Sync Oct 16 12:27:42 rivoplus volumio[28162]: info: Plugin cd_controller is not enabled Oct 16 12:27:42 rivoplus volumio[28162]: info: Loading plugin "last_100"... Oct 16 12:27:42 rivoplus volumio[28162]: info: Loading plugin "qobuzconnect"... Oct 16 12:27:42 rivoplus volumio[28162]: info: Loading plugin "raat"... Oct 16 12:27:42 rivoplus volumio[28162]: info: RAAT Plugin loaded Oct 16 12:27:42 rivoplus volumio[28162]: info: Adding restartRAATSocket REST API Endpoint Oct 16 12:27:42 rivoplus volumio[28162]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Oct 16 12:27:42 rivoplus volumio[28162]: info: Loading plugin "streaming_services"... Oct 16 12:27:43 rivoplus volumio5-onboarding[3912]: time=2026-10-16T12:27:43.516+03:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:40654->127.0.0.1:3000: i/o timeout" Oct 16 12:27:44 rivoplus volumio[28162]: info: Plugin tidalconnect is not enabled Oct 16 12:27:44 rivoplus volumio[28162]: info: Loading plugin "webradio"... Oct 16 12:27:44 rivoplus volumio[28162]: info: Loading plugin "i2s_dacs"... Oct 16 12:27:44 rivoplus volumio[28162]: info: I2S DAC not set, start Auto-detection Oct 16 12:27:44 rivoplus volumio[28162]: info: Loading plugin "volumiodiscovery"... Oct 16 12:27:44 rivoplus volumio[28162]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 12:27:44 rivoplus volumio[28162]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 12:27:44 rivoplus volumio[28162]: *** WARNING *** For more information see Oct 16 12:27:44 rivoplus volumio[28162]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 12:27:44 rivoplus volumio[28162]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 12:27:44 rivoplus node[28162]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 12:27:44 rivoplus volumio[28162]: *** WARNING *** For more information see Oct 16 12:27:44 rivoplus node[28162]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 12:27:44 rivoplus node[28162]: *** WARNING *** For more information see Oct 16 12:27:44 rivoplus node[28162]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 12:27:44 rivoplus node[28162]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 12:27:44 rivoplus node[28162]: *** WARNING *** For more information see Oct 16 12:27:44 rivoplus volumio[28162]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 12:27:44 rivoplus volumio[28162]: info: Discovery: Started advertising with name: Rivoplus Oct 16 12:27:44 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 12:27:44 rivoplus volumio[28162]: info: Loading plugin "spop"... Oct 16 12:27:46 rivoplus volumio[28162]: info: Plugin multiroom is not enabled Oct 16 12:27:46 rivoplus volumio[28162]: info: Loading plugin "outputs"... Oct 16 12:27:46 rivoplus volumio[28162]: info: Loading plugin "albumart"... Oct 16 12:27:46 rivoplus volumio[28162]: info: Plugin example_plugin is not enabled Oct 16 12:27:46 rivoplus volumio[28162]: info: Loading plugin "hi_res_audio"... Oct 16 12:27:47 rivoplus volumio[28275]: Forking 3 albumart workers Oct 16 12:27:47 rivoplus volumio-remote-updater[2981]: [2026-10-16 12:27:47] [connect] Successful connection Oct 16 12:27:49 rivoplus volumio[28162]: info: Applying required configuration parameters for plugin hi_res_audio Oct 16 12:27:49 rivoplus volumio[28162]: info: Loading plugin "inputs"... Oct 16 12:27:49 rivoplus volumio[28282]: Starting albumart workers Oct 16 12:27:49 rivoplus volumio[28284]: Starting albumart workers Oct 16 12:27:49 rivoplus volumio[28283]: Starting albumart workers Oct 16 12:27:50 rivoplus volumio[28162]: info: Loading plugin "qobuz"... Oct 16 12:27:51 rivoplus volumio5-onboarding[3912]: time=2026-10-16T12:27:51.214+03:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Oct 16 12:27:52 rivoplus volumio[28162]: info: Loading plugin "smart_inputs"... Oct 16 12:27:52 rivoplus volumio[28162]: info: Loading plugin "tidal"... Oct 16 12:27:54 rivoplus volumio[28162]: info: Loading plugin "rivopluscontrol"... Oct 16 12:27:54 rivoplus volumio5-onboarding[3912]: time=2026-10-16T12:27:54.517+03:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:40690->127.0.0.1:3000: i/o timeout" Oct 16 12:27:54 rivoplus volumio[28162]: info: Adding this device properties Oct 16 12:27:54 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 16 12:27:54 rivoplus volumio[28162]: info: Setting Additional Device Volumio Properties: [object Object] Oct 16 12:27:54 rivoplus volumio[28162]: info: Loading plugin "updater_comm"... Oct 16 12:27:55 rivoplus volumio[28162]: info: Loading plugin "cec_controller"... Oct 16 12:27:55 rivoplus volumio[28162]: info: Applying required configuration parameters for plugin cec_controller Oct 16 12:27:55 rivoplus volumio[28162]: info: Plugin mpdemulation is not enabled Oct 16 12:27:55 rivoplus volumio[28162]: info: Loading plugin "rest_api"... Oct 16 12:27:55 rivoplus volumio[28162]: info: Loading plugin "websocket"... Oct 16 12:27:55 rivoplus volumio[28162]: info: Starting Socket.io Server version 1.7.4 Oct 16 12:27:55 rivoplus volumio[28162]: info: Loading i18n strings for locale tr Oct 16 12:27:55 rivoplus volumio[28162]: Updating browse sources language Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::initPlayerControls Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: info: VolumeController:: Starting alsactl monitor Oct 16 12:27:55 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 12:27:55 rivoplus volumio[28162]: Express server listening on port 3000 Oct 16 12:27:55 rivoplus volumio[28162]: [Metrics] WebUI: 22s 855.70ms Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreStateMachine::resetVolumioState Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreStateMachine::getcurrentVolume Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 16 12:27:56 rivoplus volumio[28162]: info: Completed loading Core Plugins Oct 16 12:27:56 rivoplus volumio[28162]: info: Preparing to generate the ALSA configuration file Oct 16 12:27:56 rivoplus sudo[28393]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 12:27:56 rivoplus sudo[28393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus sudo[28395]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 12:27:56 rivoplus sudo[28395]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus sudo[28393]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:56 rivoplus sudo[28395]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:56 rivoplus volumio[28162]: info: Volumio Network Manager: Network status updated: 1 Oct 16 12:27:56 rivoplus volumio[28162]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 16 12:27:56 rivoplus volumio[28162]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 1 Oct 16 12:27:56 rivoplus volumio[28162]: info: VolumeController:: Volume=33 Mute =false Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreStateMachine::pushState Oct 16 12:27:56 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::volumioPushState Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreStateMachine::updateTrackBlock Oct 16 12:27:56 rivoplus volumio[28162]: info: CorePlayQueue::getTrackBlock Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 12:27:56 rivoplus volumio[28162]: info: Reloading queue from file Oct 16 12:27:56 rivoplus volumio[28162]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 2 Oct 16 12:27:56 rivoplus volumio[28162]: info: Asound.conf file unchanged, so no further update is needed Oct 16 12:27:56 rivoplus volumio[28162]: info: Output device has changed, restarting MPD Oct 16 12:27:56 rivoplus volumio[28162]: info: Output device has changed, restarting Shairport Sync Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 12:27:56 rivoplus sudo[28407]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 12:27:56 rivoplus sudo[28407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus sudo[28409]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 12:27:56 rivoplus sudo[28409]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus sudo[28407]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:56 rivoplus volumio[28162]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 12:27:56 rivoplus volumio[28162]: info: ___________ START PLUGINS ___________ Oct 16 12:27:56 rivoplus volumio[28162]: info: ControllerMpd::onStart: Initializing MPD Oct 16 12:27:56 rivoplus volumio[28162]: info: Creating MPD Configuration file Oct 16 12:27:56 rivoplus systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 16 12:27:56 rivoplus sudo[28416]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 16 12:27:56 rivoplus sudo[28416]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 12:27:56 rivoplus volumio[28162]: info: [1792142876699] CoreMusicLibrary::Adding element Medya Sunucuları Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 12:27:56 rivoplus sudo[28420]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 12:27:56 rivoplus sudo[28420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus volumio[28162]: info: UPNP Browser: Client initialized successfully Oct 16 12:27:56 rivoplus sudo[28422]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 12:27:56 rivoplus sudo[28416]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:56 rivoplus sudo[28420]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:56 rivoplus sudo[28422]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus volumio[28162]: info: Adding METAVOLUMIO REST API Endpoints Oct 16 12:27:56 rivoplus volumio[28162]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 16 12:27:56 rivoplus volumio[28162]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Oct 16 12:27:56 rivoplus volumio[28162]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Oct 16 12:27:56 rivoplus volumio[28162]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 12:27:56 rivoplus volumio[28162]: info: [1792142876829] CoreMusicLibrary::Adding element Last_100 Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 12:27:56 rivoplus volumio[28162]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Oct 16 12:27:56 rivoplus volumio[28162]: info: QobuzConnect: Starting Qobuz Connect socket and service Oct 16 12:27:56 rivoplus volumio[28162]: info: Starting RAAT Plugin Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 16 12:27:56 rivoplus volumio[28162]: info: Additional UI Settings Added for plugin music_service/raat Oct 16 12:27:56 rivoplus volumio[28162]: info: Registering DSP Elements listener and retrieving current ones Oct 16 12:27:56 rivoplus volumio[28162]: info: Additional DSP elements updated Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:56 rivoplus volumio[28162]: info: Updating RAAT Signal Path Oct 16 12:27:56 rivoplus volumio[28162]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 16 12:27:56 rivoplus volumio[28162]: info: Streaming services startup Oct 16 12:27:56 rivoplus volumio[28162]: info: Starting Streaming Daemon Oct 16 12:27:56 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 16 12:27:56 rivoplus sudo[28436]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 16 12:27:56 rivoplus sudo[28436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 16 12:27:56 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 16 12:27:56 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 16 12:27:56 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 16 12:27:56 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 12:27:56 rivoplus volumio[28162]: info: [1792142876952] CoreMusicLibrary::Adding element Webradio Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 12:27:56 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 12:27:56 rivoplus sudo[28443]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 12:27:56 rivoplus volumio[28162]: info: Initializing BBC Radios Oct 16 12:27:56 rivoplus sudo[28443]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:56 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 16 12:27:57 rivoplus sudo[28436]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus sudo[28443]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus sudo[28461]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 16 12:27:57 rivoplus sudo[28461]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:57 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 12:27:57 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 12:27:57 rivoplus volumio[28162]: info: Creating Spotify config file Oct 16 12:27:57 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:57 rivoplus volumio[28162]: error: Hi Res Audio Failed Login: Missing Login Data Oct 16 12:27:57 rivoplus volumio[28162]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 16 12:27:57 rivoplus volumio[28162]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 16 12:27:57 rivoplus volumio[28162]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 16 12:27:57 rivoplus systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 16 12:27:57 rivoplus volumio[28162]: info: Touch Event Listener Process Starting Oct 16 12:27:57 rivoplus kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Oct 16 12:27:57 rivoplus volumio[28162]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 12:27:57 rivoplus volumio[28162]: info: [1792142877146] CoreMusicLibrary::Adding element QOBUZ Oct 16 12:27:57 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 12:27:57 rivoplus volumio[28162]: Cannot find translation for source QOBUZ Oct 16 12:27:57 rivoplus volumio[28162]: info: Refreshing QOBUZ token Oct 16 12:27:57 rivoplus qobuz-connect[27610]: 20261016 12:27:57.172 [27610.27610] INFO SampleApp: Stopping Local configuration server Oct 16 12:27:57 rivoplus volumio[28162]: info: Adding inputs REST Endpoints Oct 16 12:27:57 rivoplus volumio[28162]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Oct 16 12:27:57 rivoplus volumio[28162]: info: Scanning Audio Inputs Oct 16 12:27:57 rivoplus sudo[28467]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 16 12:27:57 rivoplus sudo[28467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:57 rivoplus volumio[28162]: info: Checking against Known Cards name Oct 16 12:27:57 rivoplus volumio[28162]: info: Checking against Known Cards name Oct 16 12:27:57 rivoplus volumio[28162]: info: Checking against Known Cards name Oct 16 12:27:57 rivoplus volumio[28162]: info: Checking against Known Cards name Oct 16 12:27:57 rivoplus volumio[28162]: info: Checking against Known Cards name Oct 16 12:27:57 rivoplus volumio[28162]: info: Adding Server instance for streaming Oct 16 12:27:57 rivoplus sudo[28474]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 16 12:27:57 rivoplus sudo[28474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:57 rivoplus sudo[28474]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus sudo[28477]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 16 12:27:57 rivoplus sudo[28477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:57 rivoplus sudo[28477]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus sudo[28480]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 16 12:27:57 rivoplus sudo[28480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:57 rivoplus sudo[28480]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus sudo[28483]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 16 12:27:57 rivoplus sudo[28483]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:57 rivoplus sudo[28483]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus volumio[28162]: info: Apply VIM3L Onboard LEDs Settings Oct 16 12:27:57 rivoplus volumio[28162]: info: Turning On Onboard LEDs Oct 16 12:27:57 rivoplus sudo[28450]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 12:27:57 rivoplus sudo[28450]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 16 12:27:57 rivoplus sudo[28450]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus sudo[28487]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 16 12:27:57 rivoplus sudo[28487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:57 rivoplus volumio[28162]: info: Starting CEC Event listener Oct 16 12:27:57 rivoplus volumio[28162]: info: Volumio Calling Home Oct 16 12:27:57 rivoplus sudo[28487]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus sudo[28495]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 16 12:27:57 rivoplus sudo[28495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:57 rivoplus sudo[28495]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:57 rivoplus volumio[28162]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Oct 16 12:27:57 rivoplus volumio[28162]: (node:28162) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Oct 16 12:27:57 rivoplus volumio[28162]: (Use `node --trace-deprecation ...` to show where the warning was created) Oct 16 12:27:57 rivoplus volumio[28162]: info: Adding TIDAL REST API Endpoints Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreStateMachine::setRepeat null single undefined Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreStateMachine::pushState Oct 16 12:27:58 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioPushState Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:58 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreStateMachine::setRandom null Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreStateMachine::pushState Oct 16 12:27:58 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioPushState Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:58 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:58 rivoplus volumio[28162]: info: Serial port opened successfully Oct 16 12:27:58 rivoplus volumio[28162]: info: Sending serial start messages Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: Reporting MCU Network Status: 1 Oct 16 12:27:58 rivoplus volumio[28162]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 3 Oct 16 12:27:58 rivoplus volumio[28162]: error: Cannot start Volumio Streaming Daemon Oct 16 12:27:58 rivoplus volumio[28162]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 16 12:27:58 rivoplus volumio[28162]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 16 12:27:58 rivoplus volumio[28162]: info: MPD Permissions set Oct 16 12:27:58 rivoplus volumio[28162]: info: MPD Permissions set Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Oct 16 12:27:58 rivoplus volumio[28162]: info: Setting Device Volume Override Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 16 12:27:58 rivoplus volumio[28162]: info: Updating Volume Controller Parameters: Device: 5 Name: S/PDIF + AES/EBU + I2S Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 16 12:27:58 rivoplus volumio[28162]: info: Disabling external Volume Control Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreStateMachine::pushState Oct 16 12:27:58 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioPushState Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:58 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:58 rivoplus volumio[28162]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 4 Oct 16 12:27:58 rivoplus volumio[28162]: info: VolumeController:: Volume=33 Mute =false Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreStateMachine::pushState Oct 16 12:27:58 rivoplus sudo[28526]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 16 12:27:58 rivoplus sudo[28526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:58 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioPushState Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:58 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:58 rivoplus volumio[28162]: info: Volumio called home Oct 16 12:27:58 rivoplus volumio[28162]: info: Spotify config file written Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 16 12:27:58 rivoplus volumio[28162]: info: Setting Additional System Software info: Hardware Revision: 1.0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 16 12:27:58 rivoplus volumio[28162]: info: Setting HW Firmware info: undefined Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 16 12:27:58 rivoplus volumio[28162]: info: Setting HW Version info: 1.0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 16 12:27:58 rivoplus volumio[28162]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.3.0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 16 12:27:58 rivoplus volumio[28162]: info: Setting HW Firmware info: 0.3.0 Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 16 12:27:58 rivoplus volumio[28162]: info: Setting HW Version info: 1.0 Oct 16 12:27:58 rivoplus volumio[28162]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Oct 16 12:27:58 rivoplus volumio[28162]: info: MCU Signalled Headphone Mode Disabled Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 16 12:27:58 rivoplus volumio[28162]: info: Reporting Headphone State: false Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: Updating RAAT Signal Path Oct 16 12:27:58 rivoplus volumio[28162]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 16 12:27:58 rivoplus volumio[28162]: info: MCU Signalled Sleep Mode Disabled Oct 16 12:27:58 rivoplus volumio[28162]: info: Enabling Advanced system settings configuration Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Oct 16 12:27:58 rivoplus volumio[28162]: info: Additional UI Settings Added for plugin music_service/inputs Oct 16 12:27:58 rivoplus volumio[28162]: info: MCU Signalled Auto Boot Mode On Power Active Oct 16 12:27:58 rivoplus sudo[28529]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 16 12:27:58 rivoplus sudo[28529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:58 rivoplus sudo[28526]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:58 rivoplus volumio[28162]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 5 Oct 16 12:27:58 rivoplus sudo[28531]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Oct 16 12:27:58 rivoplus sudo[28531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:58 rivoplus volumio[28162]: info: VolumeController:: alsactl monitor closed, code: 0 Oct 16 12:27:58 rivoplus volumio[28162]: info: VolumeController:: Starting alsactl monitor Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus kernel: fb: osd[0] enable: 1 (Xorg) Oct 16 12:27:58 rivoplus sudo[28531]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:58 rivoplus systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Oct 16 12:27:58 rivoplus systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 16 12:27:58 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 16 12:27:58 rivoplus systemd[1]: go-librespot-daemon.service: Deactivated successfully. Oct 16 12:27:58 rivoplus systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 16 12:27:58 rivoplus systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 16 12:27:58 rivoplus sudo[28529]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 12:27:58 rivoplus go-librespot[28540]: go-librespot daemon starting... Oct 16 12:27:58 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 16 12:27:58 rivoplus sudo[28461]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 12:27:58 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 12:27:59 rivoplus volumio[28162]: info: No need to fix Spotify hosts Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=info msg="running go-librespot 0.7.1" Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=debug msg="app state loaded" Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=debug msg="stored credentials not found" Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 16 12:27:59 rivoplus volumio[28162]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 6 Oct 16 12:27:59 rivoplus volumio[28162]: info: Upmpdcli Daemon Started Oct 16 12:27:59 rivoplus volumio[28162]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Oct 16 12:27:59 rivoplus volumio[28162]: info: MP1 GPIO: Signalled system ready via GPIO Oct 16 12:27:59 rivoplus volumio[28162]: info: VolumeController:: Volume=33 Mute =false Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreStateMachine::pushState Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumioPushState Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus volumio[28162]: info: Starting Shairport Sync Oct 16 12:27:59 rivoplus sudo[28557]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Oct 16 12:27:59 rivoplus sudo[28557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:59 rivoplus sudo[28557]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:59 rivoplus volumio[28162]: info: Starting Shairport Sync Oct 16 12:27:59 rivoplus volumio[28162]: info: Starting Shairport Sync Oct 16 12:27:59 rivoplus sudo[28560]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 12:27:59 rivoplus sudo[28560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:59 rivoplus volumio[28162]: info: Adding Inputs via Serial API Oct 16 12:27:59 rivoplus volumio[28162]: info: Adding Advanced Audio Settings via Serial API Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 16 12:27:59 rivoplus volumio[28162]: info: Additional UI Settings Added for plugin music_service/inputs Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreStateMachine::pushState Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumioPushState Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus sudo[28563]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 12:27:59 rivoplus sudo[28563]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:59 rivoplus sudo[28566]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 12:27:59 rivoplus sudo[28566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::servicePushState Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreStateMachine::pushState Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumioPushState Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus volumio[28162]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received inputs Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumiosetSourceActiveno-source Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 12:27:59 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 16 12:27:59 rivoplus volumio[28162]: Cannot find translation for source QOBUZ Oct 16 12:27:59 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 16 12:27:59 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 12:27:59 rivoplus volumio[28162]: info: Discovery: Getting this device information Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:59 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 12:27:59 rivoplus sudo[28560]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 12:27:59 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=info msg="zeroconf server listening on port 36909" Oct 16 12:27:59 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 16 12:27:59 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 16 12:27:59 rivoplus go-librespot[28543]: time="2026-10-16T12:27:59+03:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 16 12:27:59 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 16 12:27:59 rivoplus sudo[28566]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:59 rivoplus sudo[28563]: pam_unix(sudo:session): session closed for user root Oct 16 12:27:59 rivoplus volumio[28162]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 7 Oct 16 12:27:59 rivoplus volumio[28162]: info: Shairport-Sync Started Oct 16 12:27:59 rivoplus volumio[28162]: Error adding Membership: Error: addMembership EINVAL Oct 16 12:27:59 rivoplus volumio[28162]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 16 12:27:59 rivoplus volumio[28162]: info: Shairport-Sync Started Oct 16 12:27:59 rivoplus volumio[28162]: info: Shairport-Sync Started Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 12:27:59 rivoplus volumio[28162]: info: Discovery: Getting this device information Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:27:59 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:27:59 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 12:27:59 rivoplus volumio[28162]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 9 Oct 16 12:27:59 rivoplus volumio[28162]: info: Access Token successfully retrieved Oct 16 12:28:00 rivoplus volumio[28162]: info: Stopping AccessToken refresher cron for QOBUZ Oct 16 12:28:00 rivoplus volumio[28162]: info: AccessToken refresher cron started for QOBUZ Oct 16 12:28:00 rivoplus volumio[28162]: info: Adding QOBUZ REST API Endpoints Oct 16 12:28:00 rivoplus volumio[28162]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 10 Oct 16 12:28:00 rivoplus volumio[28162]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 11 Oct 16 12:28:00 rivoplus volumio[28162]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 11 Oct 16 12:28:00 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:28:00 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:28:00 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 12:28:00 rivoplus volumio[28162]: info: Listing playlists Oct 16 12:28:00 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 12:28:00 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 12:28:00 rivoplus volumio[28162]: info: Discovery: Getting this device information Oct 16 12:28:00 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:28:00 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:28:00 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 12:28:00 rivoplus volumio[28162]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 16 12:28:00 rivoplus volumio[28162]: info: Turning Off Onboard LEDs Oct 16 12:28:00 rivoplus volumio[28162]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Oct 16 12:28:00 rivoplus sudo[28597]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 16 12:28:00 rivoplus sudo[28597]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:28:00 rivoplus sudo[28597]: pam_unix(sudo:session): session closed for user root Oct 16 12:28:00 rivoplus sudo[28603]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 16 12:28:00 rivoplus sudo[28603]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 12:28:00 rivoplus sudo[28603]: pam_unix(sudo:session): session closed for user root Oct 16 12:28:01 rivoplus volumio[28162]: info: Executing endpoint qc_getconfig Oct 16 12:28:01 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.084 [28542.28542] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.163 [28542.28542] INFO VolumeManager: [0xac75af98]: Setting new playback volume: 75 Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.163 [28542.28542] INFO VolumeManager: [0xac75af98]: Setting new mute state: 0 Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.164 [28542.28542] INFO AudioStreamManager: [0xac75acf0]: Setting new audio download buffer size: 1048576 Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.164 [28542.28542] INFO QobuzConnect: [0xac75b860]: Client initialized! Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.164 [28542.28542] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.211 [28542.28542] INFO LocalConfigManager: [0xac75aa18]: Starting Local Configuration server Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.211 [28542.28542] INFO SampleApp: Starting Local configuration server Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.212 [28542.28542] INFO SampleApp: Connected to UNIX socket client 0xac745908 Oct 16 12:28:01 rivoplus volumio[28162]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.116 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 14 Oct 16 12:28:01 rivoplus volumio[28162]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 16 12:28:01 rivoplus volumio[28162]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 16 12:28:01 rivoplus qobuz-connect[28542]: 20261016 12:28:01.233 [28542.28542] INFO SampleApp: Playback volume changed: 75 Oct 16 12:28:01 rivoplus volumio[28162]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 15 Oct 16 12:28:01 rivoplus volumio[28162]: info: Onboard LEDs initialized Oct 16 12:28:01 rivoplus volumio[28162]: info: CoreCommandRouter::volumioGetState Oct 16 12:28:01 rivoplus volumio[28162]: info: CorePlayQueue::getTrack 0 Oct 16 12:28:01 rivoplus volumio[28162]: Searching all installed plugins Oct 16 12:28:01 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 12:28:01 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: , search Oct 16 12:28:01 rivoplus volumio[28162]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 16 12:28:01 rivoplus volumio[28162]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 12:28:01 rivoplus volumio[28162]: TypeError: Cannot read properties of undefined (reading 'then') Oct 16 12:28:01 rivoplus volumio[28162]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1596:17) Oct 16 12:28:01 rivoplus volumio[28162]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Oct 16 12:28:01 rivoplus volumio[28162]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44) Oct 16 12:28:01 rivoplus volumio[28162]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27) Oct 16 12:28:01 rivoplus volumio[28162]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Oct 16 12:28:01 rivoplus volumio[28162]: at Socket.emit (node:events:514:28) Oct 16 12:28:01 rivoplus volumio[28162]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 16 12:28:01 rivoplus volumio[28162]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 16 12:28:01 rivoplus volumio[28162]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 12:28:02 rivoplus sudo[28619]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 12:27' Oct 16 12:28:02 rivoplus sudo[28619]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="8ed05bf20f96eb8557ed5652c420f84f39d66325" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 16:52:40 UTC 2026" VOLUMIO_VERSION="4.208" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="ba37532a86808e19439a6278b2d45f47"