-- Logs begin at Thu 2025-06-05 08:13:58 UTC, end at Thu 2025-06-05 10:49:46 UTC. -- Jun 05 10:48:00 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:00 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:00 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:00 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:00 volumio volumio[4554]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:00 volumio volumio[4554]: Reading Config from "volspotify.toml" Jun 05 10:48:00 volumio volumio[4554]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:00 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:00 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:01 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Jun 05 10:48:03 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:03 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:03 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:03 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:03 volumio volumio[4561]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:03 volumio volumio[4561]: Reading Config from "volspotify.toml" Jun 05 10:48:03 volumio volumio[4561]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:03 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:03 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:03 volumio sudo[4565]: volumio : unable to resolve host volumio Jun 05 10:48:03 volumio sudo[4565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 05 10:48:03 volumio sudo[4565]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 10:48:03 volumio sudo[4567]: volumio : unable to resolve host volumio Jun 05 10:48:03 volumio sudo[4567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 05 10:48:03 volumio sudo[4565]: pam_unix(sudo:session): session closed for user root Jun 05 10:48:03 volumio sudo[4567]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 10:48:03 volumio sudo[4567]: pam_unix(sudo:session): session closed for user root Jun 05 10:48:04 volumio sudo[4586]: volumio : unable to resolve host volumio Jun 05 10:48:04 volumio sudo[4586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 05 10:48:04 volumio sudo[4586]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 10:48:04 volumio sudo[4588]: volumio : unable to resolve host volumio Jun 05 10:48:04 volumio sudo[4588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 05 10:48:04 volumio sudo[4586]: pam_unix(sudo:session): session closed for user root Jun 05 10:48:04 volumio sudo[4588]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 10:48:04 volumio sudo[4588]: pam_unix(sudo:session): session closed for user root Jun 05 10:48:05 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Jun 05 10:48:05 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:05 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:05 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:05 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:05 volumio volumio[4607]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:05 volumio volumio[4607]: Reading Config from "volspotify.toml" Jun 05 10:48:05 volumio volumio[4607]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:05 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:05 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:05 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 05 10:48:05 volumio volumio[1279]: info: CoreCommandRouter::volumioGetVisibleSources Jun 05 10:48:05 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 05 10:48:05 volumio volumio[1279]: info: Listing playlists Jun 05 10:48:05 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 05 10:48:05 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 05 10:48:05 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 05 10:48:05 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 05 10:48:07 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:07 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:07 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:07 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:07 volumio volumio[4618]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:07 volumio volumio[4618]: Reading Config from "volspotify.toml" Jun 05 10:48:07 volumio volumio[4618]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:07 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:07 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:07 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 05 10:48:07 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 05 10:48:09 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:09 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:09 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:09 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:09 volumio volumio[4625]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:09 volumio volumio[4625]: Reading Config from "volspotify.toml" Jun 05 10:48:09 volumio volumio[4625]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:09 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:09 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:11 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 05 10:48:12 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:12 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:12 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:12 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:12 volumio volumio[4634]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:12 volumio volumio[4634]: Reading Config from "volspotify.toml" Jun 05 10:48:12 volumio volumio[4634]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:12 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:12 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:14 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:14 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:14 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:14 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:14 volumio volumio[4660]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:14 volumio volumio[4660]: Reading Config from "volspotify.toml" Jun 05 10:48:14 volumio volumio[4660]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:14 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:14 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:16 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:16 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:16 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:16 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:16 volumio volumio[4668]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:16 volumio volumio[4668]: Reading Config from "volspotify.toml" Jun 05 10:48:16 volumio volumio[4668]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:16 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:16 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:18 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:18 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:18 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:18 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:18 volumio volumio[4675]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:18 volumio volumio[4675]: Reading Config from "volspotify.toml" Jun 05 10:48:18 volumio volumio[4675]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:18 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:18 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:21 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:21 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:21 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:21 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:21 volumio volumio[4684]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:21 volumio volumio[4684]: Reading Config from "volspotify.toml" Jun 05 10:48:21 volumio volumio[4684]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:21 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:21 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:21 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jun 05 10:48:21 volumio volumio[1279]: xcb_connection_has_error() returned true Jun 05 10:48:23 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:23 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:23 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:23 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:23 volumio volumio[4696]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:23 volumio volumio[4696]: Reading Config from "volspotify.toml" Jun 05 10:48:23 volumio volumio[4696]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:23 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:23 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 05 10:48:24 volumio volumio[1279]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 05 10:48:24 volumio volumio[1279]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Jun 05 10:48:24 volumio volumio[1279]: info: Received Get System Version Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 05 10:48:24 volumio volumio[1279]: info: Discovery: Getting this device information Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 05 10:48:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 05 10:48:25 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:25 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:25 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:25 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:25 volumio volumio[4708]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:25 volumio volumio[4708]: Reading Config from "volspotify.toml" Jun 05 10:48:25 volumio volumio[4708]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:25 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:25 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:27 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:27 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:27 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:27 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:27 volumio volumio[4715]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:27 volumio volumio[4715]: Reading Config from "volspotify.toml" Jun 05 10:48:27 volumio volumio[4715]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:27 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:27 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:30 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:30 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:30 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:30 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:30 volumio volumio[4724]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:30 volumio volumio[4724]: Reading Config from "volspotify.toml" Jun 05 10:48:30 volumio volumio[4724]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:30 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:30 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:32 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:32 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:32 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:32 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:32 volumio volumio[4733]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:32 volumio volumio[4733]: Reading Config from "volspotify.toml" Jun 05 10:48:32 volumio volumio[4733]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:32 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:32 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:34 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:34 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:34 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:34 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:34 volumio volumio[4740]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:34 volumio volumio[4740]: Reading Config from "volspotify.toml" Jun 05 10:48:34 volumio volumio[4740]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:34 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:34 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:36 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:36 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:36 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:36 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:36 volumio volumio[4747]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:36 volumio volumio[4747]: Reading Config from "volspotify.toml" Jun 05 10:48:36 volumio volumio[4747]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:36 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:36 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:39 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:39 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:39 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:39 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:39 volumio volumio[4756]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:39 volumio volumio[4756]: Reading Config from "volspotify.toml" Jun 05 10:48:39 volumio volumio[4756]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:39 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:39 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:40 volumio volumio[1279]: info: Following Redirect to: http://plugins.volumio.workers.dev/plugins/volumio/armhf/plugins.json Jun 05 10:48:41 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:41 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:41 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:41 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:41 volumio volumio[4765]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:41 volumio volumio[4765]: Reading Config from "volspotify.toml" Jun 05 10:48:41 volumio volumio[4765]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:41 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:41 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:43 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:43 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:43 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:43 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:43 volumio volumio[4772]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:43 volumio volumio[4772]: Reading Config from "volspotify.toml" Jun 05 10:48:43 volumio volumio[4772]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:43 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:43 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:44 volumio volumio[1279]: info: Tunnel connection is inactive, restarting it Jun 05 10:48:44 volumio volumio[1279]: info: Starting Tunnel 1 Jun 05 10:48:44 volumio volumio[1279]: info: Starting Tunnel Connection Checker Jun 05 10:48:44 volumio sudo[4782]: volumio : unable to resolve host volumio Jun 05 10:48:44 volumio sudo[4782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jun 05 10:48:44 volumio sudo[4782]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 10:48:44 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Jun 05 10:48:44 volumio autossh[4026]: received signal to exit (15) Jun 05 10:48:44 volumio systemd[1]: Starting MyVolumio SSH Tunnel... Jun 05 10:48:44 volumio volumio[1279]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 05 10:48:44 volumio volumio[1279]: BT PLUGIN MESSAGE: Playing: false Jun 05 10:48:44 volumio volumio[1279]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect Jun 05 10:48:44 volumio volumio[1279]: BT PLUGIN MESSAGE: STATE:undefined Jun 05 10:48:44 volumio systemd[1]: Started MyVolumio SSH Tunnel. Jun 05 10:48:44 volumio volumio[1279]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 05 10:48:44 volumio volumio[1279]: BT PLUGIN MESSAGE: Playing: false Jun 05 10:48:44 volumio volumio[1279]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect Jun 05 10:48:44 volumio volumio[1279]: BT PLUGIN MESSAGE: STATE:undefined Jun 05 10:48:44 volumio sudo[4782]: pam_unix(sudo:session): session closed for user root Jun 05 10:48:44 volumio autossh[4792]: port set to 0, monitoring disabled Jun 05 10:48:44 volumio autossh[4792]: starting ssh (count 1) Jun 05 10:48:44 volumio autossh[4792]: ssh child pid is 4796 Jun 05 10:48:45 volumio volumio[1279]: info: Remote SSH Started Jun 05 10:48:45 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Jun 05 10:48:45 volumio volumiossh-tunnel[4789]: Warning: Permanently added '[as1.myvolumio.org]:2222,[128.199.166.162]:2222' (RSA) to the list of known hosts. Jun 05 10:48:45 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:45 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:45 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:45 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:45 volumio volumio[4799]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:45 volumio volumio[4799]: Reading Config from "volspotify.toml" Jun 05 10:48:45 volumio volumio[4799]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:45 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:45 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:48 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:48 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:48 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:48 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:48 volumio volumio[4808]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:48 volumio volumio[4808]: Reading Config from "volspotify.toml" Jun 05 10:48:48 volumio volumio[4808]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:48 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:48 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:50 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:50 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:50 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:50 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:50 volumio volumio[4817]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:50 volumio volumio[4817]: Reading Config from "volspotify.toml" Jun 05 10:48:50 volumio volumio[4817]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:50 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:50 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:52 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:52 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:52 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:52 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:52 volumio volumio[4824]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:52 volumio volumio[4824]: Reading Config from "volspotify.toml" Jun 05 10:48:52 volumio volumio[4824]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:52 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:52 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:54 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 05 10:48:54 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 05 10:48:54 volumio volumio[1279]: info: Discovery: Getting this device information Jun 05 10:48:54 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Jun 05 10:48:54 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 05 10:48:54 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 05 10:48:54 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 05 10:48:54 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:54 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:54 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:54 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:54 volumio volumio[4831]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:54 volumio volumio[4831]: Reading Config from "volspotify.toml" Jun 05 10:48:54 volumio volumio[4831]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:54 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:54 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:57 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:57 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:57 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:57 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:57 volumio volumio[4840]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:57 volumio volumio[4840]: Reading Config from "volspotify.toml" Jun 05 10:48:57 volumio volumio[4840]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:57 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:57 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:48:59 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:48:59 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:48:59 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:48:59 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:48:59 volumio volumio[4847]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:48:59 volumio volumio[4847]: Reading Config from "volspotify.toml" Jun 05 10:48:59 volumio volumio[4847]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:48:59 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:48:59 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:01 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:01 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:01 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:01 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:01 volumio volumio[4856]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:01 volumio volumio[4856]: Reading Config from "volspotify.toml" Jun 05 10:49:01 volumio volumio[4856]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:01 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:01 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:03 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:03 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:03 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:03 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:03 volumio volumio[4866]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:03 volumio volumio[4866]: Reading Config from "volspotify.toml" Jun 05 10:49:03 volumio volumio[4866]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:03 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:03 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 05 10:49:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 05 10:49:04 volumio volumio[1279]: info: Discovery: Getting this device information Jun 05 10:49:04 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Jun 05 10:49:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 05 10:49:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 05 10:49:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 05 10:49:06 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:06 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:06 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:06 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:06 volumio volumio[4874]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:06 volumio volumio[4874]: Reading Config from "volspotify.toml" Jun 05 10:49:06 volumio volumio[4874]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:06 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:06 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:08 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:08 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:08 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:08 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:08 volumio volumio[4881]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:08 volumio volumio[4881]: Reading Config from "volspotify.toml" Jun 05 10:49:08 volumio volumio[4881]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:08 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:08 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:10 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:10 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:10 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:10 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:10 volumio volumio[4890]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:10 volumio volumio[4890]: Reading Config from "volspotify.toml" Jun 05 10:49:10 volumio volumio[4890]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:10 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:10 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:12 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:12 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:12 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:12 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:12 volumio volumio[4899]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:12 volumio volumio[4899]: Reading Config from "volspotify.toml" Jun 05 10:49:12 volumio volumio[4899]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:12 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:12 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:15 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:15 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:15 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:15 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:15 volumio volumio[4923]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:15 volumio volumio[4923]: Reading Config from "volspotify.toml" Jun 05 10:49:15 volumio volumio[4923]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:15 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:15 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:17 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:17 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:17 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:17 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:17 volumio volumio[4931]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:17 volumio volumio[4931]: Reading Config from "volspotify.toml" Jun 05 10:49:17 volumio volumio[4931]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:17 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:17 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:19 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:19 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:19 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:19 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:19 volumio volumio[4938]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:19 volumio volumio[4938]: Reading Config from "volspotify.toml" Jun 05 10:49:19 volumio volumio[4938]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:19 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:19 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:21 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:21 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:21 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:21 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:21 volumio volumio[4949]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:21 volumio volumio[4949]: Reading Config from "volspotify.toml" Jun 05 10:49:21 volumio volumio[4949]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:21 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:21 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:22 volumio volumio[1279]: info: Downloading plugin at http://plugins.volumio.org/plugins/volumio/armhf/music_service/spop/spop.zip Jun 05 10:49:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 05 10:49:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 05 10:49:24 volumio volumio[1279]: info: Discovery: Getting this device information Jun 05 10:49:24 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Jun 05 10:49:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 05 10:49:24 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:24 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:24 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:24 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 05 10:49:24 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 05 10:49:24 volumio volumio[4958]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:24 volumio volumio[4958]: Reading Config from "volspotify.toml" Jun 05 10:49:24 volumio volumio[4958]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:24 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:24 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:26 volumio volumio[1279]: info: END DOWNLOAD: http://plugins.volumio.org/plugins/volumio/armhf/music_service/spop/spop.zip Jun 05 10:49:26 volumio volumio[1279]: info: Folder /tmp/plugins removed Jun 05 10:49:26 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:26 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:26 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:26 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:26 volumio volumio[4968]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:26 volumio volumio[4968]: Reading Config from "volspotify.toml" Jun 05 10:49:26 volumio volumio[4968]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:26 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:26 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:27 volumio volumio[1279]: info: Checking if plugin already exists Jun 05 10:49:27 volumio volumio[1279]: info: Rename folder Jun 05 10:49:27 volumio volumio[1279]: info: Folder /tmp/downloaded_plugin.zip removed Jun 05 10:49:27 volumio volumio[1279]: info: Move to category Jun 05 10:49:28 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:28 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:28 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:28 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:28 volumio volumio[4979]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:28 volumio volumio[4979]: Reading Config from "volspotify.toml" Jun 05 10:49:28 volumio volumio[4979]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:28 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:28 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:30 volumio volumio[1279]: info: Checking if install.sh is present Jun 05 10:49:30 volumio volumio[1279]: info: Executing install.sh Jun 05 10:49:30 volumio sudo[4986]: volumio : unable to resolve host volumio Jun 05 10:49:30 volumio sudo[4986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Jun 05 10:49:30 volumio sudo[4986]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 10:49:30 volumio volumio[1279]: info: Writing systemd unit Jun 05 10:49:30 volumio sudo[4986]: pam_unix(sudo:session): session closed for user root Jun 05 10:49:30 volumio volumio[1279]: info: Install script completed Jun 05 10:49:30 volumio volumio[1279]: info: Adding reference to registry Jun 05 10:49:30 volumio volumio[1279]: info: Done installing plugin. Jun 05 10:49:30 volumio volumio[1279]: info: Setting permissions Jun 05 10:49:30 volumio volumio[1279]: info: Folder /tmp/plugins removed Jun 05 10:49:30 volumio volumio[1279]: info: Folder /tmp/downloaded_plugin.zip removed Jun 05 10:49:30 volumio volumio[1279]: info: Folder /data/temp removed Jun 05 10:49:30 volumio volumio[1279]: info: Writing startconnect unit Jun 05 10:49:30 volumio volumio[1279]: Plugin install end detected on script Jun 05 10:49:30 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:30 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:30 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:30 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:30 volumio volumio[5002]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:30 volumio volumio[5002]: Reading Config from "volspotify.toml" Jun 05 10:49:30 volumio volumio[5002]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:30 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:30 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:32 volumio volumio[1279]: info: Enabling plugin spop Jun 05 10:49:32 volumio volumio[1279]: info: Loading plugin "spop"... Jun 05 10:49:33 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:33 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:33 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:33 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:33 volumio volumio[5009]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:33 volumio volumio[5009]: Reading Config from "volspotify.toml" Jun 05 10:49:33 volumio volumio[5009]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:33 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:33 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:33 volumio volumio[1279]: info: PLUGIN START: spop Jun 05 10:49:33 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 05 10:49:33 volumio volumio[1279]: [SpotifyConnect] Creating VLS config file Jun 05 10:49:33 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 10:49:33 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 10:49:33 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 10:49:33 volumio volumio[1279]: [SpotifyConnect] Starting metadata listener Jun 05 10:49:33 volumio volumio[1279]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 Jun 05 10:49:33 volumio volumio[1279]: at Object._errnoException (util.js:1022:11) Jun 05 10:49:33 volumio volumio[1279]: at _exceptionWithHostPort (util.js:1044:20) Jun 05 10:49:33 volumio volumio[1279]: at _handle.lookup (dgram.js:266:18) Jun 05 10:49:33 volumio volumio[1279]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Jun 05 10:49:33 volumio volumio[1279]: at process._tickCallback (internal/process/next_tick.js:180:9) Jun 05 10:49:33 volumio volumio[1279]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data Jun 05 10:49:33 volumio volumio[1279]: at Socket.onListenError (dgram.js:362:22) Jun 05 10:49:33 volumio volumio[1279]: at Object.onceWrapper (events.js:315:30) Jun 05 10:49:33 volumio volumio[1279]: at emitOne (events.js:121:20) Jun 05 10:49:33 volumio volumio[1279]: at Socket.emit (events.js:211:7) Jun 05 10:49:33 volumio volumio[1279]: at _handle.lookup (dgram.js:267:14) Jun 05 10:49:33 volumio volumio[1279]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Jun 05 10:49:33 volumio volumio[1279]: at process._tickCallback (internal/process/next_tick.js:180:9) Jun 05 10:49:33 volumio sudo[5013]: volumio : unable to resolve host volumio Jun 05 10:49:33 volumio sudo[5013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Jun 05 10:49:33 volumio sudo[5013]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 10:49:33 volumio sudo[5013]: pam_unix(sudo:session): session closed for user root Jun 05 10:49:33 volumio sudo[5015]: volumio : unable to resolve host volumio Jun 05 10:49:33 volumio volumio[1279]: info: Successfully fixed Spotify hosts Jun 05 10:49:33 volumio sudo[5015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Jun 05 10:49:33 volumio sudo[5015]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 10:49:33 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:33 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:33 volumio sudo[5015]: pam_unix(sudo:session): session closed for user root Jun 05 10:49:33 volumio volumio[5029]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Jun 05 10:49:33 volumio volumio[5029]: Reading Config from "/tmp/volspotify.toml" Jun 05 10:49:33 volumio volumio[5029]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Jun 05 10:49:33 volumio volumio[1279]: [SpotifyConnect] Unable to start Daemon: sudo: unable to resolve host volumio Jun 05 10:49:33 volumio volumio[1279]: [SpotifyConnect] Vollibrespot Daemon service started! Jun 05 10:49:33 volumio volumio[1279]: [Metrics] SpotifyConnect: 0s 437.74ms Jun 05 10:49:33 volumio volumio[1279]: info: Done. Jun 05 10:49:33 volumio volumio[5029]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Jun 05 10:49:35 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:35 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:35 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:35 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:35 volumio volumio[5038]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:35 volumio volumio[5038]: Reading Config from "volspotify.toml" Jun 05 10:49:35 volumio volumio[5038]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:35 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:35 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:37 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:37 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:37 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:37 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:37 volumio volumio[5045]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:37 volumio volumio[5045]: Reading Config from "volspotify.toml" Jun 05 10:49:37 volumio volumio[5045]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:37 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:37 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:37 volumio volumio[1279]: info: Checking Spotify Web API Jun 05 10:49:39 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:39 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:39 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:39 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:39 volumio volumio[5052]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:39 volumio volumio[5052]: Reading Config from "volspotify.toml" Jun 05 10:49:39 volumio volumio[5052]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:39 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:39 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:42 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:42 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:42 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:42 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:42 volumio volumio[5059]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:42 volumio volumio[5059]: Reading Config from "volspotify.toml" Jun 05 10:49:42 volumio volumio[5059]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:42 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:42 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:44 volumio volumio[5029]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" Jun 05 10:49:44 volumio systemd[1]: volspotconnect2.service holdoff time over, scheduling restart. Jun 05 10:49:44 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jun 05 10:49:44 volumio systemd[1]: Starting Volspotconnect2 Daemon... Jun 05 10:49:44 volumio systemd[1]: Started Volspotconnect2 Daemon. Jun 05 10:49:44 volumio volumio[5072]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jun 05 10:49:44 volumio volumio[5072]: Reading Config from "volspotify.toml" Jun 05 10:49:44 volumio volumio[5072]: Malformed config key: expected newline, found an identifier at line 7 column 21 Jun 05 10:49:44 volumio systemd[1]: volspotconnect2.service: main process exited, code=exited, status=1/FAILURE Jun 05 10:49:44 volumio systemd[1]: Unit volspotconnect2.service entered failed state. Jun 05 10:49:44 volumio volumio[5029]: [Vollibrespot] : Authenticated as "12177287486" ! Jun 05 10:49:44 volumio volumio[5029]: [Vollibrespot] : Using alsa sink Jun 05 10:49:44 volumio volumio[5029]: [Vollibrespot] : Metadata pipe established Jun 05 10:49:44 volumio volumio[5029]: [Vollibrespot] : Country: "HK" Jun 05 10:49:44 volumio volumio[5029]: [Vollibrespot] : Event: Volume { volume_to_mixer: 32768 } Jun 05 10:49:44 volumio volumio[1279]: [SpotifyConnect] 50.000762951094835 Jun 05 10:49:44 volumio volumio[1279]: [SpotifyConnect] Volume: Spotify:50.000762951094835 Volumio: 50 Jun 05 10:49:44 volumio volumio[1279]: info: CoreStateMachine::pushState Jun 05 10:49:44 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState Jun 05 10:49:44 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Fetching autoplay context uri Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Event: SessionActive { became_active_at: 1749120585005 } Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : SessionActive! Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Event: PlaybackStarted { track_id: SpotifyId { id: 224956556853599295927890261180017230397, audio_type: Track } } Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Event: PlaybackLoading { track_id: SpotifyId { id: 224956556853599295927890261180017230397, audio_type: Track } } Jun 05 10:49:45 volumio volumio[1279]: [SpotifyConnect] A connect session has begun Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Loading <愛愛愛> with Spotify URI Jun 05 10:49:45 volumio volumio[1279]: [SpotifyConnect] Device palyback is active! Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Autoplay uri resolved to <"spotify:station:artist:1YrtUPrWcPfgdl9BaD9nhd"> Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Resolving uri "spotify:station:artist:1YrtUPrWcPfgdl9BaD9nhd" Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Event: GotToken { token: Token { access_token: "BQCCsEC1uzkMj0FZXkEUZoPSPSXy5KBifS5D7UrjcZ8jPo-CpQjyZtpjzivi_yFgp5_wRcxsSlfo80NIBu7rxJnONHbHsVruL-G1o5UBJI96TuAbWnvfW_kLYvJURtiAArzOu6ehsdMQa0GQQvdJbclVCUPavVQIvu5UE_vuIXRotwys3ikGq_K3_Fs2c3OQocSX3pA8U9lJhbC7H_o2Bm0Nxb2hrTeceBy1twIsAk5ZdeA", expires_in: 3600, token_type: "Bearer", scope: ["streaming", "user-read-playback-state", "user-modify-playback-state", "user-read-currently-playing", "user-read-private"] } } Jun 05 10:49:45 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState Jun 05 10:49:45 volumio volumio[1279]: [SpotifyConnect] Currently active: tidalconnect Jun 05 10:49:45 volumio volumio[1279]: [SpotifyConnect] Stopping currently active service Jun 05 10:49:45 volumio volumio[1279]: info: CoreCommandRouter::volumioStop Jun 05 10:49:45 volumio volumio[1279]: info: CoreStateMachine::stop Jun 05 10:49:45 volumio volumio[1279]: info: CoreStateMachine::serviceStop Jun 05 10:49:45 volumio volumio[1279]: info: CoreCommandRouter::serviceStop Jun 05 10:49:45 volumio volumio[1279]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 05 10:49:45 volumio volumio[1279]: TypeError: Cannot read property 'then' of undefined Jun 05 10:49:45 volumio volumio[1279]: at SpotConnEvents.SpotConn.on (/data/plugins/music_service/volspotconnect2/index.js:143:23) Jun 05 10:49:45 volumio volumio[1279]: at emitNone (events.js:106:13) Jun 05 10:49:45 volumio volumio[1279]: at SpotConnEvents.emit (events.js:208:7) Jun 05 10:49:45 volumio volumio[1279]: at SpotConnEvents.parseData (/data/plugins/music_service/volspotconnect2/SpotConnController.js:73:16) Jun 05 10:49:45 volumio volumio[1279]: at Socket.SpotConnEvents._udpsource.on.msg (/data/plugins/music_service/volspotconnect2/SpotConnController.js:15:12) Jun 05 10:49:45 volumio volumio[1279]: at emitTwo (events.js:126:13) Jun 05 10:49:45 volumio volumio[1279]: at Socket.emit (events.js:214:7) Jun 05 10:49:45 volumio volumio[1279]: at UDP.onMessage [as onmessage] (dgram.js:659:8) Jun 05 10:49:45 volumio volumio[1279]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 05 10:49:45 volumio vtcs[10779]: [2025-06-05 10:49:45.065] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:0 Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Resolved 50 tracks from <"spotify:artist:1YrtUPrWcPfgdl9BaD9nhd"> Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : <愛愛愛> (215253 ms) loaded Jun 05 10:49:45 volumio volumio[5029]: [Vollibrespot] : Event: SinkActive Jun 05 10:49:46 volumio sudo[5088]: volumio : unable to resolve host volumio Jun 05 10:49:46 volumio sudo[5088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-05 10:48 Jun 05 10:49:46 volumio sudo[5088]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"