-- Logs begin at Thu 2024-10-24 18:44:31 CEST, end at Sat 2024-10-26 22:13:40 CEST. -- Oct 26 22:12:00 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:00 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 78. Oct 26 22:12:00 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:00 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:00 ren-pi volumio[19463]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:00 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:00 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:02 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:02 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 79. Oct 26 22:12:02 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:02 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:02 ren-pi volumio[19465]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:02 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:02 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:05 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:05 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 80. Oct 26 22:12:05 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:05 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:05 ren-pi volumio[19467]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:05 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:05 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:07 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:07 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 81. Oct 26 22:12:07 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:07 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:07 ren-pi volumio[19469]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:07 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:07 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:09 ren-pi volumio[18223]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/backup_restore/volumio/buster/armhf Oct 26 22:12:09 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:09 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 82. Oct 26 22:12:09 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:09 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:09 ren-pi volumio[19474]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:09 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:09 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:10 ren-pi volumio[18223]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/backup_restore/volumio/buster/armhf Oct 26 22:12:10 ren-pi volumio[18223]: info: Folder /tmp/plugins removed Oct 26 22:12:11 ren-pi volumio[18223]: info: Check plugin dependencies Oct 26 22:12:11 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 22:12:11 ren-pi volumio[18223]: info: Checking if plugin already exists Oct 26 22:12:11 ren-pi volumio[18223]: info: Rename folder Oct 26 22:12:11 ren-pi volumio[18223]: info: Folder /tmp/downloaded_plugin.zip removed Oct 26 22:12:11 ren-pi volumio[18223]: info: Move to category Oct 26 22:12:11 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:11 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 83. Oct 26 22:12:11 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:11 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:11 ren-pi volumio[19486]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:11 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:11 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:12 ren-pi volumio[18223]: info: Checking if install.sh is present Oct 26 22:12:12 ren-pi volumio[18223]: info: Executing install.sh Oct 26 22:12:12 ren-pi sudo[19490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_controller/backup_restore/install.sh Oct 26 22:12:12 ren-pi sudo[19490]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 22:12:12 ren-pi volumio[18223]: info: Installing backup restore Dependencies Oct 26 22:12:12 ren-pi sudo[19490]: pam_unix(sudo:session): session closed for user root Oct 26 22:12:12 ren-pi volumio[18223]: info: Install script completed Oct 26 22:12:12 ren-pi volumio[18223]: info: Adding reference to registry Oct 26 22:12:12 ren-pi volumio[18223]: info: Done installing plugin. Oct 26 22:12:12 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 22:12:12 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 26 22:12:12 ren-pi volumio[18223]: info: Folder /tmp/plugins removed Oct 26 22:12:12 ren-pi volumio[18223]: info: Folder /tmp/downloaded_plugin.zip removed Oct 26 22:12:12 ren-pi volumio[18223]: Plugin install end detected on script Oct 26 22:12:12 ren-pi volumio[18223]: info: Folder /data/temp removed Oct 26 22:12:13 ren-pi volumio[18223]: info: Enabling plugin backup_restore Oct 26 22:12:13 ren-pi volumio[18223]: info: Loading plugin "backup_restore"... Oct 26 22:12:14 ren-pi volumio[18223]: info: PLUGIN START: backup_restore Oct 26 22:12:14 ren-pi volumio[18223]: info: Done. Oct 26 22:12:14 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:14 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 84. Oct 26 22:12:14 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:14 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:14 ren-pi volumio[19492]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:14 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:14 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:16 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:16 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 85. Oct 26 22:12:16 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:16 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:16 ren-pi volumio[19494]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:16 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:16 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:18 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:18 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 86. Oct 26 22:12:18 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:18 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:18 ren-pi volumio[19496]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:18 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:18 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:20 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:20 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 87. Oct 26 22:12:20 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:20 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:20 ren-pi volumio[19498]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:20 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:20 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:23 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:23 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 88. Oct 26 22:12:23 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:23 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:23 ren-pi volumio[19500]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:23 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:23 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:25 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:25 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 89. Oct 26 22:12:25 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:25 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:25 ren-pi volumio[19502]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:25 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:25 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:27 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:27 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 90. Oct 26 22:12:27 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:27 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:27 ren-pi volumio[19504]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:27 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:27 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:29 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:29 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 91. Oct 26 22:12:29 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:29 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:29 ren-pi volumio[19507]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:29 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:29 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:32 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:32 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 92. Oct 26 22:12:32 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:32 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:32 ren-pi volumio[19509]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:32 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:32 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:34 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:34 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 93. Oct 26 22:12:34 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:34 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:34 ren-pi volumio[19511]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:34 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:34 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:36 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:36 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 94. Oct 26 22:12:36 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:36 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:36 ren-pi volumio[19515]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:36 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:36 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:38 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:38 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 95. Oct 26 22:12:38 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:38 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:38 ren-pi volumio[19517]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:38 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:38 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:41 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:41 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 96. Oct 26 22:12:41 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:41 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:41 ren-pi volumio[19519]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:41 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:41 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:43 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:43 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 97. Oct 26 22:12:43 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:43 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:43 ren-pi volumio[19522]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:43 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:43 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:45 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:45 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 98. Oct 26 22:12:45 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:45 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:45 ren-pi volumio[19524]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:45 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:45 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:47 ren-pi volumio[18223]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ytmusic/volumio/buster/armhf Oct 26 22:12:47 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:47 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 99. Oct 26 22:12:47 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:47 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:47 ren-pi volumio[19569]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:47 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:47 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:48 ren-pi wpa_supplicant[915]: RRM: Ignoring radio measurement request: Not RRM network Oct 26 22:12:50 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:50 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 100. Oct 26 22:12:50 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:50 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:50 ren-pi volumio[19571]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:50 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:50 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:51 ren-pi volumio[18223]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/ytmusic/volumio/buster/armhf Oct 26 22:12:51 ren-pi volumio[18223]: info: Folder /tmp/plugins removed Oct 26 22:12:52 ren-pi volumio[18223]: info: Check plugin dependencies Oct 26 22:12:52 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 22:12:52 ren-pi volumio[18223]: info: Checking if plugin already exists Oct 26 22:12:52 ren-pi volumio[18223]: info: Rename folder Oct 26 22:12:52 ren-pi volumio[18223]: info: Folder /tmp/downloaded_plugin.zip removed Oct 26 22:12:52 ren-pi volumio[18223]: info: Move to category Oct 26 22:12:52 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:52 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 101. Oct 26 22:12:52 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:52 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:52 ren-pi volumio[19584]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:52 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:52 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:53 ren-pi volumio[18223]: info: Checking if install.sh is present Oct 26 22:12:53 ren-pi volumio[18223]: info: Executing install.sh Oct 26 22:12:53 ren-pi sudo[19589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/ytmusic/install.sh Oct 26 22:12:53 ren-pi sudo[19589]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 22:12:53 ren-pi sudo[19589]: pam_unix(sudo:session): session closed for user root Oct 26 22:12:53 ren-pi volumio[18223]: info: YouTube Music plugin installed Oct 26 22:12:53 ren-pi volumio[18223]: Plugin install end detected on script Oct 26 22:12:53 ren-pi volumio[18223]: info: Install script completed Oct 26 22:12:53 ren-pi volumio[18223]: info: Adding reference to registry Oct 26 22:12:53 ren-pi volumio[18223]: info: Done installing plugin. Oct 26 22:12:53 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 22:12:53 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 26 22:12:53 ren-pi volumio[18223]: info: Folder /tmp/plugins removed Oct 26 22:12:53 ren-pi volumio[18223]: info: Folder /tmp/downloaded_plugin.zip removed Oct 26 22:12:53 ren-pi volumio[18223]: info: Folder /data/temp removed Oct 26 22:12:54 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:54 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 102. Oct 26 22:12:54 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:54 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:54 ren-pi volumio[19591]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:54 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:54 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:56 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:56 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 103. Oct 26 22:12:56 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:56 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:56 ren-pi volumio[19593]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:56 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:56 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:12:57 ren-pi volumio[18223]: info: Enabling plugin ytmusic Oct 26 22:12:57 ren-pi volumio[18223]: info: Loading plugin "ytmusic"... Oct 26 22:12:57 ren-pi volumio[18223]: info: PLUGIN START: ytmusic Oct 26 22:12:57 ren-pi volumio[18223]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 26 22:12:57 ren-pi volumio[18223]: info: [1729973577805] CoreMusicLibrary::Adding element YouTube Music Oct 26 22:12:57 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 22:12:57 ren-pi volumio[18223]: Cannot find translation for source HiFiBerry ADC Oct 26 22:12:57 ren-pi volumio[18223]: Cannot find translation for source QOBUZ Oct 26 22:12:57 ren-pi volumio[18223]: Cannot find translation for source TIDAL Oct 26 22:12:57 ren-pi volumio[18223]: Cannot find translation for source YouTube Music Oct 26 22:12:57 ren-pi volumio[18223]: info: Done. Oct 26 22:12:59 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:12:59 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 104. Oct 26 22:12:59 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:12:59 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:12:59 ren-pi volumio[19595]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:12:59 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:12:59 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:00 ren-pi wpa_supplicant[915]: RRM: Ignoring radio measurement request: Not RRM network Oct 26 22:13:01 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:01 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 105. Oct 26 22:13:01 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:01 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:01 ren-pi volumio[19598]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:01 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:01 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:02 ren-pi wpa_supplicant[915]: RRM: Ignoring radio measurement request: Not RRM network Oct 26 22:13:03 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:03 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 106. Oct 26 22:13:03 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:03 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:03 ren-pi volumio[19600]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:03 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:03 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:05 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:05 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 107. Oct 26 22:13:05 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:05 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:05 ren-pi volumio[19602]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:05 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:05 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:08 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:08 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 108. Oct 26 22:13:08 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:08 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:08 ren-pi volumio[19604]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:08 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:08 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:10 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:10 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 109. Oct 26 22:13:10 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:10 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:10 ren-pi volumio[19607]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:10 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:10 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:10 ren-pi volumio[18223]: info: Enabling plugin youtube2 Oct 26 22:13:10 ren-pi volumio[18223]: info: Loading plugin "youtube2"... Oct 26 22:13:10 ren-pi volumio[18223]: info: PLUGIN START: youtube2 Oct 26 22:13:10 ren-pi volumio[18223]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 26 22:13:10 ren-pi volumio[18223]: info: [1729973590940] CoreMusicLibrary::Adding element YouTube2 Oct 26 22:13:10 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 22:13:10 ren-pi volumio[18223]: Cannot find translation for source HiFiBerry ADC Oct 26 22:13:10 ren-pi volumio[18223]: Cannot find translation for source QOBUZ Oct 26 22:13:10 ren-pi volumio[18223]: Cannot find translation for source TIDAL Oct 26 22:13:10 ren-pi volumio[18223]: Cannot find translation for source YouTube Music Oct 26 22:13:10 ren-pi volumio[18223]: Cannot find translation for source YouTube2 Oct 26 22:13:10 ren-pi volumio[18223]: info: Done. Oct 26 22:13:12 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:12 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 110. Oct 26 22:13:12 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:12 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:12 ren-pi volumio[19609]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:12 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:12 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:14 ren-pi volumio[18223]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesYouTube2 Oct 26 22:13:14 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 22:13:14 ren-pi volumio[18223]: Cannot find translation for source HiFiBerry ADC Oct 26 22:13:14 ren-pi volumio[18223]: Cannot find translation for source QOBUZ Oct 26 22:13:14 ren-pi volumio[18223]: Cannot find translation for source TIDAL Oct 26 22:13:14 ren-pi volumio[18223]: Cannot find translation for source YouTube Music Oct 26 22:13:14 ren-pi volumio[18223]: info: Disabling plugin youtube2 Oct 26 22:13:14 ren-pi volumio[18223]: info: Done. Oct 26 22:13:14 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:14 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 111. Oct 26 22:13:14 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:14 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:14 ren-pi volumio[19611]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:14 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:14 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:15 ren-pi volumio[18223]: info: Enabling plugin youtube2 Oct 26 22:13:15 ren-pi volumio[18223]: info: Loading plugin "youtube2"... Oct 26 22:13:15 ren-pi volumio[18223]: info: PLUGIN START: youtube2 Oct 26 22:13:15 ren-pi volumio[18223]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 26 22:13:15 ren-pi volumio[18223]: info: [1729973595713] CoreMusicLibrary::Adding element YouTube2 Oct 26 22:13:15 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 22:13:15 ren-pi volumio[18223]: Cannot find translation for source HiFiBerry ADC Oct 26 22:13:15 ren-pi volumio[18223]: Cannot find translation for source QOBUZ Oct 26 22:13:15 ren-pi volumio[18223]: Cannot find translation for source TIDAL Oct 26 22:13:15 ren-pi volumio[18223]: Cannot find translation for source YouTube Music Oct 26 22:13:15 ren-pi volumio[18223]: Cannot find translation for source YouTube2 Oct 26 22:13:15 ren-pi volumio[18223]: info: Done. Oct 26 22:13:17 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:17 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 112. Oct 26 22:13:17 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:17 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:17 ren-pi volumio[19613]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:17 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:17 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:19 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:19 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 113. Oct 26 22:13:19 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:19 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:19 ren-pi volumio[19615]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:19 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:19 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:19 ren-pi volumio[18223]: info: Enabling plugin Systeminfo Oct 26 22:13:19 ren-pi volumio[18223]: info: Loading plugin "Systeminfo"... Oct 26 22:13:19 ren-pi volumio[18223]: info: PLUGIN START: Systeminfo Oct 26 22:13:19 ren-pi volumio[18223]: info: Done. Oct 26 22:13:20 ren-pi volumio[18223]: info: Disabling plugin Systeminfo Oct 26 22:13:20 ren-pi volumio[18223]: info: Done. Oct 26 22:13:21 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:21 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 114. Oct 26 22:13:21 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:21 ren-pi volumio[18223]: info: Enabling plugin Systeminfo Oct 26 22:13:21 ren-pi volumio[18223]: info: Loading plugin "Systeminfo"... Oct 26 22:13:21 ren-pi volumio[18223]: info: PLUGIN START: Systeminfo Oct 26 22:13:21 ren-pi volumio[18223]: info: Done. Oct 26 22:13:21 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:21 ren-pi volumio[19617]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:21 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:21 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:22 ren-pi volumio[18223]: info: Enabling plugin now_playing Oct 26 22:13:22 ren-pi volumio[18223]: info: Loading plugin "now_playing"... Oct 26 22:13:22 ren-pi volumio[18223]: error: !!!! WARNING !!!! Oct 26 22:13:22 ren-pi volumio[18223]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry Oct 26 22:13:22 ren-pi volumio[18223]: error: Stack trace: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry Oct 26 22:13:22 ren-pi volumio[18223]: at tryPackage (internal/modules/cjs/loader.js:303:19) Oct 26 22:13:22 ren-pi volumio[18223]: at Function.Module._findPath (internal/modules/cjs/loader.js:516:18) Oct 26 22:13:22 ren-pi volumio[18223]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:867:27) Oct 26 22:13:22 ren-pi volumio[18223]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Oct 26 22:13:22 ren-pi volumio[18223]: at Module.require (internal/modules/cjs/loader.js:952:19) Oct 26 22:13:22 ren-pi volumio[18223]: at require (internal/modules/cjs/helpers.js:88:18) Oct 26 22:13:22 ren-pi volumio[18223]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Oct 26 22:13:22 ren-pi volumio[18223]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Oct 26 22:13:22 ren-pi volumio[18223]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Oct 26 22:13:22 ren-pi volumio[18223]: at Module.load (internal/modules/cjs/loader.js:928:32) Oct 26 22:13:22 ren-pi volumio[18223]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Oct 26 22:13:22 ren-pi volumio[18223]: at Module.require (internal/modules/cjs/loader.js:952:19) Oct 26 22:13:22 ren-pi volumio[18223]: at require (internal/modules/cjs/helpers.js:88:18) Oct 26 22:13:22 ren-pi volumio[18223]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Oct 26 22:13:22 ren-pi volumio[18223]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 26 22:13:22 ren-pi volumio[18223]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 26 22:13:22 ren-pi volumio[18223]: error: !!!! WARNING !!!! Oct 26 22:13:22 ren-pi volumio[18223]: info: Done. Oct 26 22:13:23 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:23 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 115. Oct 26 22:13:23 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:23 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:23 ren-pi volumio[19619]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:23 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:23 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:24 ren-pi volumio[18223]: info: Enabling plugin now_playing Oct 26 22:13:24 ren-pi volumio[18223]: info: Loading plugin "now_playing"... Oct 26 22:13:24 ren-pi volumio[18223]: error: !!!! WARNING !!!! Oct 26 22:13:24 ren-pi volumio[18223]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry Oct 26 22:13:24 ren-pi volumio[18223]: error: Stack trace: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry Oct 26 22:13:24 ren-pi volumio[18223]: at tryPackage (internal/modules/cjs/loader.js:303:19) Oct 26 22:13:24 ren-pi volumio[18223]: at Function.Module._findPath (internal/modules/cjs/loader.js:516:18) Oct 26 22:13:24 ren-pi volumio[18223]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:867:27) Oct 26 22:13:24 ren-pi volumio[18223]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Oct 26 22:13:24 ren-pi volumio[18223]: at Module.require (internal/modules/cjs/loader.js:952:19) Oct 26 22:13:24 ren-pi volumio[18223]: at require (internal/modules/cjs/helpers.js:88:18) Oct 26 22:13:24 ren-pi volumio[18223]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Oct 26 22:13:24 ren-pi volumio[18223]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Oct 26 22:13:24 ren-pi volumio[18223]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Oct 26 22:13:24 ren-pi volumio[18223]: at Module.load (internal/modules/cjs/loader.js:928:32) Oct 26 22:13:24 ren-pi volumio[18223]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Oct 26 22:13:24 ren-pi volumio[18223]: at Module.require (internal/modules/cjs/loader.js:952:19) Oct 26 22:13:24 ren-pi volumio[18223]: at require (internal/modules/cjs/helpers.js:88:18) Oct 26 22:13:24 ren-pi volumio[18223]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Oct 26 22:13:24 ren-pi volumio[18223]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 26 22:13:24 ren-pi volumio[18223]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 26 22:13:24 ren-pi volumio[18223]: error: !!!! WARNING !!!! Oct 26 22:13:24 ren-pi volumio[18223]: info: Error: TypeError: Cannot read property 'printToastMessage' of null Oct 26 22:13:26 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:26 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 116. Oct 26 22:13:26 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:26 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:26 ren-pi volumio[19621]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:26 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:26 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:28 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:28 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 117. Oct 26 22:13:28 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:28 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:28 ren-pi volumio[19623]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:28 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:28 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:29 ren-pi volumio[18223]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 22:13:30 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:30 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 118. Oct 26 22:13:30 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:30 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:30 ren-pi volumio[19625]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:30 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:30 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:32 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:32 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 119. Oct 26 22:13:32 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:32 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:32 ren-pi volumio[19627]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:32 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:32 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:35 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:35 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 120. Oct 26 22:13:35 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:35 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:35 ren-pi volumio[19629]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:35 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:35 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:37 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:37 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 121. Oct 26 22:13:37 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:37 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:37 ren-pi volumio[19632]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:37 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:37 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:38 ren-pi go-librespot[18489]: time="2024-10-26T22:13:38+02:00" level=debug msg="obtained new client token: AAD5dFPcJWafWOKC2ifyfzcbFt8+gH6c7LRZoGtKNRST6h2w3g87T2rBQQ/Fh6mU8Y5a0QeOuFS0I5zEPx1B61H97qcHMzT9jShEFlav1fvPdrwWFaIHi4WT+A54hBV33RmsZtA74zIKvsNXmiqMEH0aJk61N1vhVr+HJo1sahjWfxtdelf3BUGXEOl/5HDSS/QqAfffjxRv5Hk70DWQMMMSCJNUeJkg2OHkrXQWz8jucCHBdDkm1/RcUA8=" Oct 26 22:13:38 ren-pi go-librespot[18489]: time="2024-10-26T22:13:38+02:00" level=info msg="connected to ap-gew4.spotify.com:4070" Oct 26 22:13:38 ren-pi go-librespot[18489]: time="2024-10-26T22:13:38+02:00" level=debug msg="completed keyexchange" Oct 26 22:13:38 ren-pi go-librespot[18489]: time="2024-10-26T22:13:38+02:00" level=debug msg="completed challenge" Oct 26 22:13:38 ren-pi go-librespot[18489]: time="2024-10-26T22:13:38+02:00" level=debug msg="authenticated as seriousde" Oct 26 22:13:38 ren-pi go-librespot[18489]: time="2024-10-26T22:13:38+02:00" level=debug msg="authenticated as seriousde" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="dealer connection opened" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=info msg="accepted zeroconf user seriousde from René's Note20 Ultra" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 493" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="autoplay enabled: false" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="received connection id: MGNmNGYxZjctYmRhMC00MjBjLWJlMjgtZTAwNDZjYTZjN2YzK2RlYWxlcit0Y3A6Ly8wYWNhNTg0Ny5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArQkFEMTFGMjUzREZDQjBGMjg3MENDOEM2OEVDMUU4NkMxNUE1M0Q1MjBFQjMzREJGRkU4ODZCMzEwOTk2RkJGRg==" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="put connect state because NEW_DEVICE" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="handling transfer player command from 656d2acab32ac8abcdccc34b6671c24667831bd3" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="resolved context of track" uri="spotify:playlist:7dFLFZwWwXmauwhqZrjeMW" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=trace msg="fetched new page 0 with 176 items (list: 176)" uri="spotify:playlist:7dFLFZwWwXmauwhqZrjeMW" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="loading track (paused: false, position: 182557ms)" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=trace msg="emitting websocket event: will_play" Oct 26 22:13:39 ren-pi volumio[18223]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:3o8QzWsiiqTUVgBZfHgF58","play_origin":"playlist"}} Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1304" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="selected format OGG_VORBIS_320 (633373658c3d7046370724c64c286d263fb6453c)" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="requested aes key for file 633373658c3d7046370724c64c286d263fb6453c, gid: 3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:39 ren-pi systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Oct 26 22:13:39 ren-pi systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 122. Oct 26 22:13:39 ren-pi systemd[1]: Stopped Volspotconnect2 Daemon. Oct 26 22:13:39 ren-pi systemd[1]: Started Volspotconnect2 Daemon. Oct 26 22:13:39 ren-pi volumio[19635]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Oct 26 22:13:39 ren-pi systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Oct 26 22:13:39 ren-pi systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="fetched first chunk of 20, total size is 10203940 bytes" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:39 ren-pi go-librespot[18489]: time="2024-10-26T22:13:39+02:00" level=debug msg="fetched chunk 3/19, size: 524288" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="fetched chunk 15/19, size: 524288" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=trace msg="seek to 182557ms (diff: 256ms, samples: 8050763, bytes: 7942144)" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="fetched chunk 2/19, size: 524288" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="created new output device" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=info msg="loaded track \"Cherry Bomb\" (paused: false, position: 182557ms, duration: 236667ms, prefetched: false)" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="fetched chunk 1/19, size: 524288" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="fetched chunk 17/19, size: 524288" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="fetched chunk 16/19, size: 524288" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="fetched chunk 18/19, size: 524288" uri="spotify:track:3o8QzWsiiqTUVgBZfHgF58" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=trace msg="scheduling prefetch in 24s" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=trace msg="emitting websocket event: metadata" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=trace msg="emitting websocket event: active" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="sending successful reply for dealer request" Oct 26 22:13:40 ren-pi volumio[18223]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:3o8QzWsiiqTUVgBZfHgF58","name":"Cherry Bomb","artist_names":["NCT 127"],"album_name":"NCT #127 CHERRY BOMB - The 3rd Mini Album","album_cover_url":"https://i.scdn.co/image/ab67616d00001e028d47b664117ca39e7b1acfc9","position":182557,"duration":236667,"release_date":"year:2017 month:6 day:14","track_number":1,"disc_number":1}} Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Oct 26 22:13:40 ren-pi volumio[18223]: SPOTIFY: received: {"type":"active","data":null} Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Oct 26 22:13:40 ren-pi volumio[18223]: info: Aligning Spotify Volume to Volumio Volume Oct 26 22:13:40 ren-pi volumio[18223]: info: CoreCommandRouter::volumioGetState Oct 26 22:13:40 ren-pi volumio[18223]: info: CorePlayQueue::getTrack 0 Oct 26 22:13:40 ren-pi volumio[18223]: info: Setting Spotify Volume from Volumio: 100 Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 26 22:13:40 ren-pi go-librespot[18489]: time="2024-10-26T22:13:40+02:00" level=trace msg="emitting websocket event: playing" Oct 26 22:13:40 ren-pi volumio[18223]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:3o8QzWsiiqTUVgBZfHgF58","play_origin":"playlist"}} Oct 26 22:13:40 ren-pi volumio[18223]: info: Spotify is playing in volatile mode Oct 26 22:13:40 ren-pi volumio[18223]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 22:13:40 ren-pi volumio[18223]: SPOTIFY: UNSET VOLATILE Oct 26 22:13:40 ren-pi volumio[18223]: SPOTIFY: {"status":"stop","position":0,"title":"Hey Now","artist":"London Grammar","album":"If You Wait","albumart":"https://static.qobuz.com/images/covers/78/96/0060253759678_600.jpg","uri":"qobuz://song/11882605","seek":0,"duration":205,"random":false,"repeat":true,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":false,"mute":false,"updatedb":false,"volatile":false,"service":"qobuz"} Oct 26 22:13:40 ren-pi volumio[18223]: SPOTIFY: PUSH STATE SPOTIFY Oct 26 22:13:40 ren-pi volumio[18223]: SPOTIFY: {"status":"play","service":"spop","title":"Cherry Bomb","artist":"NCT 127","album":"NCT #127 CHERRY BOMB - The 3rd Mini Album","albumart":"https://i.scdn.co/image/ab67616d00001e028d47b664117ca39e7b1acfc9","uri":"spotify:track:3o8QzWsiiqTUVgBZfHgF58","trackType":"spotify","seek":182557,"duration":236,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Oct 26 22:13:40 ren-pi volumio[18223]: info: CoreCommandRouter::servicePushState Oct 26 22:13:40 ren-pi volumio[18223]: info: CoreStateMachine::pushState Oct 26 22:13:40 ren-pi volumio[18223]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 22:13:40 ren-pi volumio[18223]: info: CoreCommandRouter::volumioPushState Oct 26 22:13:40 ren-pi volumio[18223]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 22:13:40 ren-pi volumio[18223]: TypeError: Cannot read property 'pushState' of null Oct 26 22:13:40 ren-pi volumio[18223]: at /volumio/app/index.js:325:32 Oct 26 22:13:40 ren-pi volumio[18223]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Oct 26 22:13:40 ren-pi volumio[18223]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Oct 26 22:13:40 ren-pi volumio[18223]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:323:13) Oct 26 22:13:40 ren-pi volumio[18223]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:530:22) Oct 26 22:13:40 ren-pi volumio[18223]: at CoreStateMachine.syncState (/volumio/app/statemachine.js:591:10) Oct 26 22:13:40 ren-pi volumio[18223]: at CoreCommandRouter.servicePushState (/volumio/app/index.js:413:28) Oct 26 22:13:40 ren-pi volumio[18223]: at ControllerSpotify.pushState (/data/plugins/music_service/spop/index.js:430:31) Oct 26 22:13:40 ren-pi volumio[18223]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:320:14) Oct 26 22:13:40 ren-pi volumio[18223]: at WebSocket.message (/data/plugins/music_service/spop/index.js:190:14) Oct 26 22:13:40 ren-pi volumio[18223]: at WebSocket.emit (events.js:315:20) Oct 26 22:13:40 ren-pi volumio[18223]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Oct 26 22:13:40 ren-pi volumio[18223]: at Receiver.emit (events.js:315:20) Oct 26 22:13:40 ren-pi volumio[18223]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Oct 26 22:13:40 ren-pi volumio[18223]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Oct 26 22:13:40 ren-pi volumio[18223]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Oct 26 22:13:40 ren-pi volumio[18223]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 22:13:40 ren-pi sudo[19648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 22:12 Oct 26 22:13:40 ren-pi sudo[19648]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"