-- Logs begin at Fri 2025-03-07 16:21:00 CET, end at Fri 2025-03-07 19:04:49 CET. -- Mar 07 19:03:00 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11636. Mar 07 19:03:00 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:00 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:00 volumio go-librespot[31812]: go-librespot daemon starting... Mar 07 19:03:00 volumio go-librespot[31812]: time="2025-03-07T19:03:00+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:02 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:02 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:03 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11637. Mar 07 19:03:03 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:03 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:03 volumio go-librespot[31823]: go-librespot daemon starting... Mar 07 19:03:03 volumio go-librespot[31823]: time="2025-03-07T19:03:03+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:05 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:05 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:06 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11638. Mar 07 19:03:06 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:06 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:06 volumio go-librespot[31831]: go-librespot daemon starting... Mar 07 19:03:06 volumio go-librespot[31831]: time="2025-03-07T19:03:06+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:08 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:08 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:10 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11639. Mar 07 19:03:10 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:10 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:10 volumio go-librespot[31847]: go-librespot daemon starting... Mar 07 19:03:10 volumio go-librespot[31847]: time="2025-03-07T19:03:10+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:11 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:11 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:13 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11640. Mar 07 19:03:13 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:13 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:13 volumio go-librespot[31862]: go-librespot daemon starting... Mar 07 19:03:13 volumio go-librespot[31862]: time="2025-03-07T19:03:13+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:14 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:14 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:16 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11641. Mar 07 19:03:16 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:16 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:16 volumio go-librespot[31870]: go-librespot daemon starting... Mar 07 19:03:16 volumio go-librespot[31870]: time="2025-03-07T19:03:16+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:17 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:17 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:19 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11642. Mar 07 19:03:19 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:19 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:19 volumio go-librespot[31877]: go-librespot daemon starting... Mar 07 19:03:19 volumio go-librespot[31877]: time="2025-03-07T19:03:19+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:20 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:20 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:23 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11643. Mar 07 19:03:23 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:23 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:23 volumio go-librespot[31899]: go-librespot daemon starting... Mar 07 19:03:23 volumio go-librespot[31899]: time="2025-03-07T19:03:23+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:23 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:23 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:26 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11644. Mar 07 19:03:26 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:26 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:26 volumio go-librespot[31911]: go-librespot daemon starting... Mar 07 19:03:26 volumio go-librespot[31911]: time="2025-03-07T19:03:26+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:26 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:26 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:29 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11645. Mar 07 19:03:29 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:29 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:29 volumio go-librespot[31918]: go-librespot daemon starting... Mar 07 19:03:29 volumio go-librespot[31918]: time="2025-03-07T19:03:29+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:29 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:29 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:32 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11646. Mar 07 19:03:32 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:32 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:32 volumio go-librespot[31939]: go-librespot daemon starting... Mar 07 19:03:32 volumio go-librespot[31939]: time="2025-03-07T19:03:32+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:32 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:32 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:35 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:35 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:36 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11647. Mar 07 19:03:36 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:36 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:36 volumio go-librespot[31949]: go-librespot daemon starting... Mar 07 19:03:36 volumio go-librespot[31949]: time="2025-03-07T19:03:36+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:38 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:38 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:39 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11648. Mar 07 19:03:39 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:39 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:39 volumio go-librespot[31956]: go-librespot daemon starting... Mar 07 19:03:39 volumio go-librespot[31956]: time="2025-03-07T19:03:39+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:41 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:41 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:42 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11649. Mar 07 19:03:42 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:42 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:42 volumio go-librespot[31977]: go-librespot daemon starting... Mar 07 19:03:42 volumio go-librespot[31977]: time="2025-03-07T19:03:42+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:44 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:44 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:45 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11650. Mar 07 19:03:45 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:45 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:45 volumio go-librespot[31987]: go-librespot daemon starting... Mar 07 19:03:45 volumio go-librespot[31987]: time="2025-03-07T19:03:45+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:47 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:47 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:49 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11651. Mar 07 19:03:49 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:49 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:49 volumio go-librespot[31995]: go-librespot daemon starting... Mar 07 19:03:49 volumio go-librespot[31995]: time="2025-03-07T19:03:49+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:50 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:50 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:52 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11652. Mar 07 19:03:52 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:52 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:52 volumio go-librespot[32016]: go-librespot daemon starting... Mar 07 19:03:52 volumio go-librespot[32016]: time="2025-03-07T19:03:52+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:53 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:53 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:55 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11653. Mar 07 19:03:55 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:55 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:55 volumio go-librespot[32027]: go-librespot daemon starting... Mar 07 19:03:55 volumio go-librespot[32027]: time="2025-03-07T19:03:55+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:56 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:56 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:03:58 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:03:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11654. Mar 07 19:03:58 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:03:58 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:03:58 volumio go-librespot[32036]: go-librespot daemon starting... Mar 07 19:03:58 volumio go-librespot[32036]: time="2025-03-07T19:03:58+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:03:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:03:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:03:59 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:03:59 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:02 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11655. Mar 07 19:04:02 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:02 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:02 volumio go-librespot[32102]: go-librespot daemon starting... Mar 07 19:04:02 volumio go-librespot[32102]: time="2025-03-07T19:04:02+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:02 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:02 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:05 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11656. Mar 07 19:04:05 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:05 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:05 volumio go-librespot[32112]: go-librespot daemon starting... Mar 07 19:04:05 volumio go-librespot[32112]: time="2025-03-07T19:04:05+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:05 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:05 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:08 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11657. Mar 07 19:04:08 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:08 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:08 volumio go-librespot[32119]: go-librespot daemon starting... Mar 07 19:04:08 volumio go-librespot[32119]: time="2025-03-07T19:04:08+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:08 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:08 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:11 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11658. Mar 07 19:04:11 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:11 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:11 volumio go-librespot[32140]: go-librespot daemon starting... Mar 07 19:04:11 volumio go-librespot[32140]: time="2025-03-07T19:04:11+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:11 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:11 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:14 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:14 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:15 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11659. Mar 07 19:04:15 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:15 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:15 volumio go-librespot[32151]: go-librespot daemon starting... Mar 07 19:04:15 volumio go-librespot[32151]: time="2025-03-07T19:04:15+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:17 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:17 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:18 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11660. Mar 07 19:04:18 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:18 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:18 volumio go-librespot[32158]: go-librespot daemon starting... Mar 07 19:04:18 volumio go-librespot[32158]: time="2025-03-07T19:04:18+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:20 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:20 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:21 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11661. Mar 07 19:04:21 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:21 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:21 volumio go-librespot[32179]: go-librespot daemon starting... Mar 07 19:04:21 volumio go-librespot[32179]: time="2025-03-07T19:04:21+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:23 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:23 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:24 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 19:04:24 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 19:04:24 volumio volumio[986]: info: Discovery: Getting this device information Mar 07 19:04:24 volumio volumio[986]: info: CoreCommandRouter::volumioGetState Mar 07 19:04:24 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:24 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 19:04:24 volumio volumio[986]: verbose: New Socket.io Connection to 192.168.31.137:3000 from 192.168.31.139 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Mar 07 19:04:24 volumio volumio[986]: info: CoreCommandRouter::volumioGetState Mar 07 19:04:24 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:24 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 07 19:04:24 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 07 19:04:24 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11662. Mar 07 19:04:24 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:24 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:24 volumio go-librespot[32190]: go-librespot daemon starting... Mar 07 19:04:24 volumio go-librespot[32190]: time="2025-03-07T19:04:24+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:26 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:26 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:28 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11663. Mar 07 19:04:28 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:28 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:28 volumio go-librespot[32197]: go-librespot daemon starting... Mar 07 19:04:28 volumio go-librespot[32197]: time="2025-03-07T19:04:28+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:28 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 19:04:28 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 19:04:28 volumio volumio[986]: info: Discovery: Getting this device information Mar 07 19:04:28 volumio volumio[986]: info: CoreCommandRouter::volumioGetState Mar 07 19:04:28 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:28 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 19:04:29 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:29 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:31 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11664. Mar 07 19:04:31 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:31 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:31 volumio go-librespot[32219]: go-librespot daemon starting... Mar 07 19:04:31 volumio go-librespot[32219]: time="2025-03-07T19:04:31+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:32 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:32 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:32 volumio sudo[32227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 07 19:04:32 volumio sudo[32227]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 19:04:33 volumio sudo[32227]: pam_unix(sudo:session): session closed for user root Mar 07 19:04:33 volumio sudo[32230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 07 19:04:33 volumio sudo[32230]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 19:04:33 volumio sudo[32230]: pam_unix(sudo:session): session closed for user root Mar 07 19:04:33 volumio volumio[986]: verbose: New Socket.io Connection to 192.168.31.137 from 192.168.31.139 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 07 19:04:33 volumio sudo[32236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 07 19:04:33 volumio sudo[32236]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 19:04:33 volumio sudo[32236]: pam_unix(sudo:session): session closed for user root Mar 07 19:04:33 volumio sudo[32239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 07 19:04:33 volumio sudo[32239]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 19:04:33 volumio sudo[32239]: pam_unix(sudo:session): session closed for user root Mar 07 19:04:33 volumio volumio[986]: verbose: New Socket.io Connection to 192.168.31.137 from 192.168.31.139 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::volumioGetVisibleSources Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::volumioGetState Mar 07 19:04:33 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 07 19:04:33 volumio volumio[986]: info: Received Get System Info Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 19:04:33 volumio volumio[986]: info: Discovery: Getting this device information Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::volumioGetState Mar 07 19:04:33 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::volumioGetState Mar 07 19:04:33 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:33 volumio volumio[986]: info: Listing playlists Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 07 19:04:33 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 07 19:04:34 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11665. Mar 07 19:04:34 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:34 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:34 volumio go-librespot[32241]: go-librespot daemon starting... Mar 07 19:04:34 volumio go-librespot[32241]: time="2025-03-07T19:04:34+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:35 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 07 19:04:35 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 07 19:04:35 volumio volumio[986]: info: Received Get System Info Mar 07 19:04:35 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 19:04:35 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 19:04:35 volumio volumio[986]: info: Discovery: Getting this device information Mar 07 19:04:35 volumio volumio[986]: info: CoreCommandRouter::volumioGetState Mar 07 19:04:35 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:35 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 19:04:35 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:35 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:37 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 07 19:04:37 volumio volumio[986]: info: Received Get System Info Mar 07 19:04:37 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 07 19:04:37 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 07 19:04:37 volumio volumio[986]: info: Discovery: Getting this device information Mar 07 19:04:37 volumio volumio[986]: info: CoreCommandRouter::volumioGetState Mar 07 19:04:37 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:37 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 07 19:04:37 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11666. Mar 07 19:04:37 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:37 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:37 volumio go-librespot[32249]: go-librespot daemon starting... Mar 07 19:04:37 volumio go-librespot[32249]: time="2025-03-07T19:04:37+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:38 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:38 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:39 volumio volumio[986]: info: CoreCommandRouter::volumioGetQueue Mar 07 19:04:39 volumio volumio[986]: info: CoreStateMachine::getQueue Mar 07 19:04:39 volumio volumio[986]: info: CorePlayQueue::getQueue Mar 07 19:04:41 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11667. Mar 07 19:04:41 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:41 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:41 volumio go-librespot[32270]: go-librespot daemon starting... Mar 07 19:04:41 volumio go-librespot[32270]: time="2025-03-07T19:04:41+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:41 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:41 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:43 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 07 19:04:44 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11668. Mar 07 19:04:44 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:44 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:44 volumio go-librespot[32280]: go-librespot daemon starting... Mar 07 19:04:44 volumio go-librespot[32280]: time="2025-03-07T19:04:44+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:44 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:44 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:46 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: rad357pl , handleBrowseUri Mar 07 19:04:46 volumio volumio[986]: info: [1741370686153] [rad357pl] handleBrowseUri curUri: rad357pl Mar 07 19:04:46 volumio volumio[986]: info: [1741370686153] [rad357pl] getRadioContent url: rad357pl Mar 07 19:04:46 volumio volumio[986]: info: Preload queue cleared Mar 07 19:04:47 volumio volumio[986]: info: Preload queue cleared Mar 07 19:04:47 volumio volumio[986]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::ClearQueue Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::stop Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 07 19:04:47 volumio volumio[986]: info: CorePlayQueue::clearPlayQueue Mar 07 19:04:47 volumio volumio[986]: info: CorePlayQueue::saveQueue Mar 07 19:04:47 volumio volumio[986]: info: CoreCommandRouter::volumioPushQueue Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::addQueueItems Mar 07 19:04:47 volumio volumio[986]: info: CorePlayQueue::addQueueItems Mar 07 19:04:47 volumio volumio[986]: info: Preload queue cleared Mar 07 19:04:47 volumio volumio[986]: info: Adding Item to queue: webrns/0 Mar 07 19:04:47 volumio volumio[986]: info: Exploding uri webrns/0 in service rad357pl Mar 07 19:04:47 volumio volumio[986]: info: [1741370687257] [rad357pl] explodeUri: webrns/0 Mar 07 19:04:47 volumio volumio[986]: info: CoreCommandRouter::volumioPushQueue Mar 07 19:04:47 volumio volumio[986]: info: CorePlayQueue::saveQueue Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::updateTrackBlock Mar 07 19:04:47 volumio volumio[986]: info: CorePlayQueue::getTrackBlock Mar 07 19:04:47 volumio volumio[986]: info: CoreCommandRouter::volumioPlay Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::play index 0 Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::stop Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::play index undefined Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 07 19:04:47 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::startPlaybackTimer Mar 07 19:04:47 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:47 volumio volumio[986]: verbose: ControllerMpd::sendMpdCommand stop Mar 07 19:04:47 volumio volumio[986]: info: sendMpdCommand stop took 6 milliseconds Mar 07 19:04:47 volumio volumio[986]: verbose: ControllerMpd::sendMpdCommand clear Mar 07 19:04:47 volumio volumio[986]: info: Mar 07 19:04:47 volumio volumio[986]: ---------------------------- MPD announces system playlist update Mar 07 19:04:47 volumio volumio[986]: info: Ignoring MPD Status Update Mar 07 19:04:47 volumio volumio[986]: info: sendMpdCommand clear took 1 milliseconds Mar 07 19:04:47 volumio volumio[986]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" Mar 07 19:04:47 volumio volumio[986]: error: updateQueue error: null Mar 07 19:04:47 volumio volumio[986]: info: Mar 07 19:04:47 volumio volumio[986]: ---------------------------- MPD announces system playlist update Mar 07 19:04:47 volumio volumio[986]: info: Ignoring MPD Status Update Mar 07 19:04:47 volumio volumio[986]: info: ------------------------------ 3ms Mar 07 19:04:47 volumio volumio[986]: info: sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" took 2 milliseconds Mar 07 19:04:47 volumio volumio[986]: verbose: ControllerMpd::sendMpdCommand play Mar 07 19:04:47 volumio volumio[986]: info: ------------------------------ 5ms Mar 07 19:04:47 volumio volumio[986]: info: sendMpdCommand play took 3 milliseconds Mar 07 19:04:47 volumio volumio[986]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 07 19:04:47 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Mar 07 19:04:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11669. Mar 07 19:04:47 volumio systemd[1]: Stopped go-librespot Daemon. Mar 07 19:04:47 volumio systemd[1]: Started go-librespot Daemon. Mar 07 19:04:47 volumio go-librespot[32288]: go-librespot daemon starting... Mar 07 19:04:47 volumio go-librespot[32288]: time="2025-03-07T19:04:47+01:00" level=fatal msg="failed loading config" error="failed to unmarshal configuration: 1 error(s) decoding:\n\n* cannot parse 'disable_autoplay' as bool: strconv.ParseBool: parsing \"${disable_autoplay}\": invalid syntax" Mar 07 19:04:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 07 19:04:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 07 19:04:47 volumio volumio[986]: info: Initializing connection to go-librespot Websocket Mar 07 19:04:47 volumio volumio[986]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 07 19:04:49 volumio volumio[986]: info: Mar 07 19:04:49 volumio volumio[986]: ---------------------------- MPD announces state update: player Mar 07 19:04:49 volumio volumio[986]: info: ControllerMpd::getState Mar 07 19:04:49 volumio volumio[986]: verbose: ControllerMpd::sendMpdCommand status Mar 07 19:04:49 volumio volumio[986]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 07 19:04:49 volumio volumio[986]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 07 19:04:49 volumio volumio[986]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 07 19:04:49 volumio volumio[986]: info: FusionDsp - Loudness is ON true Mar 07 19:04:49 volumio volumio[986]: info: Mar 07 19:04:49 volumio volumio[986]: ---------------------------- MPD announces system playlist update Mar 07 19:04:49 volumio volumio[986]: info: Ignoring MPD Status Update Mar 07 19:04:49 volumio volumio[986]: info: Mar 07 19:04:49 volumio volumio[986]: ---------------------------- MPD announces state update: player Mar 07 19:04:49 volumio volumio[986]: info: sendMpdCommand status took 29 milliseconds Mar 07 19:04:49 volumio volumio[986]: info: ControllerMpd::getState Mar 07 19:04:49 volumio volumio[986]: verbose: ControllerMpd::sendMpdCommand status Mar 07 19:04:49 volumio volumio[986]: verbose: ControllerMpd::parseState Mar 07 19:04:49 volumio volumio[986]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 07 19:04:49 volumio volumio[986]: info: ------------------------------ 4ms Mar 07 19:04:49 volumio volumio[986]: info: sendMpdCommand status took 3 milliseconds Mar 07 19:04:49 volumio volumio[986]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 07 19:04:49 volumio volumio[986]: verbose: ControllerMpd::parseState Mar 07 19:04:49 volumio volumio[986]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 07 19:04:49 volumio volumio[986]: verbose: ControllerMpd::parseTrackInfo Mar 07 19:04:49 volumio volumio[986]: info: ControllerMpd::pushState Mar 07 19:04:49 volumio volumio[986]: info: CoreCommandRouter::servicePushState Mar 07 19:04:49 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:49 volumio volumio[986]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Corey Taylor, Bad Omens & Aaron Gilhuis - Dust in the Wind (From 'Queen of the Ring' - Music From The Motion Picture)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 07 19:04:49 volumio volumio[986]: verbose: CURRENT POSITION 0 Mar 07 19:04:49 volumio volumio[986]: info: CoreStateMachine::syncState stateService play Mar 07 19:04:49 volumio volumio[986]: info: CoreStateMachine::syncState currentStatus stop Mar 07 19:04:49 volumio volumio[986]: info: ------------------------------ 37ms Mar 07 19:04:49 volumio volumio[986]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 07 19:04:49 volumio volumio[986]: verbose: ControllerMpd::parseTrackInfo Mar 07 19:04:49 volumio volumio[986]: info: ControllerMpd::pushState Mar 07 19:04:49 volumio volumio[986]: info: CoreCommandRouter::servicePushState Mar 07 19:04:49 volumio volumio[986]: info: CorePlayQueue::getTrack 0 Mar 07 19:04:49 volumio volumio[986]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1611,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Corey Taylor, Bad Omens & Aaron Gilhuis - Dust in the Wind (From 'Queen of the Ring' - Music From The Motion Picture)","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Mar 07 19:04:49 volumio volumio[986]: verbose: CURRENT POSITION 0 Mar 07 19:04:49 volumio volumio[986]: info: CoreStateMachine::syncState stateService play Mar 07 19:04:49 volumio volumio[986]: info: CoreStateMachine::syncState currentStatus play Mar 07 19:04:49 volumio volumio[986]: info: Received an update from plugin. extracting info from payload Mar 07 19:04:49 volumio volumio[986]: info: CoreStateMachine::pushState Mar 07 19:04:49 volumio volumio[986]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 07 19:04:49 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Mar 07 19:04:49 volumio volumio[986]: info: CoreStateMachine::pushState Mar 07 19:04:49 volumio volumio[986]: info: CoreCommandRouter::volumioPushState Mar 07 19:04:49 volumio volumio[986]: info: ------------------------------ 21ms Mar 07 19:04:49 volumio volumio[986]: info: [ASDebug] CurState: play PrevState: stop Mar 07 19:04:49 volumio volumio[986]: info: [ASDebug] Togle GPIO: ON Mar 07 19:04:49 volumio volumio[986]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 19:04:49 volumio volumio[986]: Error: ESPIPE: invalid seek, write Mar 07 19:04:49 volumio volumio[986]: at Object.writeSync (fs.js:711:3) Mar 07 19:04:49 volumio volumio[986]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Mar 07 19:04:49 volumio volumio[986]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:207:23) Mar 07 19:04:49 volumio volumio[986]: at AmpSwitchController.parseStatus (/data/plugins/system_controller/ampswitch/index.js:190:86) Mar 07 19:04:49 volumio volumio[986]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Mar 07 19:04:49 volumio volumio[986]: at Socket.onevent (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:278:10) Mar 07 19:04:49 volumio volumio[986]: at Socket.onpacket (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:236:12) Mar 07 19:04:49 volumio volumio[986]: at Manager. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Mar 07 19:04:49 volumio volumio[986]: at Manager.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Mar 07 19:04:49 volumio volumio[986]: at Manager.ondecoded (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:349:8) Mar 07 19:04:49 volumio volumio[986]: at Decoder. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Mar 07 19:04:49 volumio volumio[986]: at Decoder.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Mar 07 19:04:49 volumio volumio[986]: at Decoder.add (/data/plugins/system_controller/ampswitch/node_modules/socket.io-parser/index.js:254:12) Mar 07 19:04:49 volumio volumio[986]: at Manager.ondata (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:339:16) Mar 07 19:04:49 volumio volumio[986]: at Socket. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Mar 07 19:04:49 volumio volumio[986]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) { Mar 07 19:04:49 volumio volumio[986]: errno: -29, Mar 07 19:04:49 volumio volumio[986]: syscall: 'write', Mar 07 19:04:49 volumio volumio[986]: code: 'ESPIPE' Mar 07 19:04:49 volumio volumio[986]: } Mar 07 19:04:49 volumio volumio[986]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 19:04:49 volumio sudo[32309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-07 19:03 Mar 07 19:04:49 volumio sudo[32309]: 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"