-- Logs begin at Fri 2024-10-25 19:15:04 UTC, end at Wed 2024-10-30 21:11:14 UTC. -- Oct 30 21:10:01 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:01 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:01 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:01 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:01 volumiorpi1 volumio[2199]: /usr/lib/startconnect.sh: line 5: 2201 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:03 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:03 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:03 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:03 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:03 volumiorpi1 volumio[2207]: /usr/lib/startconnect.sh: line 5: 2208 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:05 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:05 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:05 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:05 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:05 volumiorpi1 volumio[2215]: /usr/lib/startconnect.sh: line 5: 2216 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:08 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:08 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:08 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:08 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:08 volumiorpi1 volumio[2222]: /usr/lib/startconnect.sh: line 5: 2223 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:10 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:10 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:10 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:10 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:10 volumiorpi1 volumio[2229]: /usr/lib/startconnect.sh: line 5: 2230 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:12 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:12 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:12 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:12 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:12 volumiorpi1 volumio[2237]: /usr/lib/startconnect.sh: line 5: 2238 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:14 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:14 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:14 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:14 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:15 volumiorpi1 volumio[2244]: /usr/lib/startconnect.sh: line 5: 2247 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:17 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:17 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:17 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:17 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:17 volumiorpi1 volumio[2253]: /usr/lib/startconnect.sh: line 5: 2254 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:19 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:19 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:19 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:19 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:19 volumiorpi1 volumio[2262]: /usr/lib/startconnect.sh: line 5: 2263 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:21 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:21 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:21 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:21 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:21 volumiorpi1 volumio[2269]: /usr/lib/startconnect.sh: line 5: 2270 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:23 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:23 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:23 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:23 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:23 volumiorpi1 volumio[2276]: /usr/lib/startconnect.sh: line 5: 2277 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:25 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:10:25 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:10:25 volumiorpi1 volumio[927]: info: Discovery: Getting this device information Oct 30 21:10:25 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioGetState Oct 30 21:10:25 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:25 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 30 21:10:25 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 30 21:10:25 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:10:26 volumiorpi1 volumio[927]: info: Discovery: Getting this device information Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioGetState Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 30 21:10:26 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:26 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:26 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:26 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:26 volumiorpi1 volumio[2283]: /usr/lib/startconnect.sh: line 5: 2284 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioGetState Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 30 21:10:26 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 30 21:10:28 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:28 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:28 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:28 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:28 volumiorpi1 volumio[2290]: /usr/lib/startconnect.sh: line 5: 2291 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:30 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:30 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:30 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:30 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:31 volumiorpi1 volumio[2297]: /usr/lib/startconnect.sh: line 5: 2298 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:31 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 21:10:31 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 21:10:31 volumiorpi1 volumio[927]: info: Discovery: Getting this device information Oct 30 21:10:31 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioGetState Oct 30 21:10:31 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:31 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 30 21:10:31 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 30 21:10:31 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 30 21:10:33 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:33 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:33 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:33 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:33 volumiorpi1 volumio[2305]: /usr/lib/startconnect.sh: line 5: 2306 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:35 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:35 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:35 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:35 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:35 volumiorpi1 volumio[2312]: /usr/lib/startconnect.sh: line 5: 2313 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:37 volumiorpi1 sudo[2320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 21:10:37 volumiorpi1 sudo[2318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 30 21:10:37 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:37 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:37 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:37 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:37 volumiorpi1 sudo[2320]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:10:38 volumiorpi1 sudo[2318]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:10:38 volumiorpi1 volumio[2326]: /usr/lib/startconnect.sh: line 5: 2331 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:38 volumiorpi1 sudo[2320]: pam_unix(sudo:session): session closed for user root Oct 30 21:10:38 volumiorpi1 sudo[2318]: pam_unix(sudo:session): session closed for user root Oct 30 21:10:39 volumiorpi1 wpa_supplicant[798]: wlan0: WPA: Group rekeying completed with 48:ed:e6:a5:ee:01 [GTK=CCMP] Oct 30 21:10:40 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:40 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:40 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:40 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:40 volumiorpi1 volumio[2345]: /usr/lib/startconnect.sh: line 5: 2346 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:40 volumiorpi1 sudo[2349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 30 21:10:40 volumiorpi1 sudo[2349]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:10:41 volumiorpi1 sudo[2351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 21:10:41 volumiorpi1 sudo[2349]: pam_unix(sudo:session): session closed for user root Oct 30 21:10:41 volumiorpi1 sudo[2351]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 21:10:41 volumiorpi1 sudo[2351]: pam_unix(sudo:session): session closed for user root Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioGetState Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioGetVisibleSources Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 21:10:42 volumiorpi1 volumio[927]: info: Listing playlists Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 30 21:10:42 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 30 21:10:42 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:42 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:42 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:42 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:43 volumiorpi1 volumio[2373]: /usr/lib/startconnect.sh: line 5: 2375 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:44 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioPlay Oct 30 21:10:44 volumiorpi1 volumio[927]: verbose: UNSET VOLATILE Oct 30 21:10:44 volumiorpi1 volumio[927]: info: CoreStateMachine::play index undefined Oct 30 21:10:44 volumiorpi1 volumio[927]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 30 21:10:44 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:44 volumiorpi1 volumio[927]: info: CoreStateMachine::startPlaybackTimer Oct 30 21:10:44 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:44 volumiorpi1 volumio[927]: info: [1730322644307] ControllerWebradio::clearAddPlayTrack Oct 30 21:10:44 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand stop Oct 30 21:10:44 volumiorpi1 volumio[927]: info: sendMpdCommand stop took 491 milliseconds Oct 30 21:10:44 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand clear Oct 30 21:10:44 volumiorpi1 volumio[927]: info: Oct 30 21:10:44 volumiorpi1 volumio[927]: ---------------------------- MPD announces system playlist update Oct 30 21:10:44 volumiorpi1 volumio[927]: info: Ignoring MPD Status Update Oct 30 21:10:44 volumiorpi1 volumio[927]: info: sendMpdCommand clear took 39 milliseconds Oct 30 21:10:44 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand load "https://corn.kvsc.org/radiox" Oct 30 21:10:45 volumiorpi1 volumio[927]: error: updateQueue error: null Oct 30 21:10:45 volumiorpi1 volumio[927]: info: ------------------------------ 366ms Oct 30 21:10:45 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:45 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:45 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:45 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:45 volumiorpi1 volumio[2380]: /usr/lib/startconnect.sh: line 5: 2381 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:48 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:48 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:48 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:48 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:48 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 21:10:48 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 30 21:10:49 volumiorpi1 volumio[2383]: /usr/lib/startconnect.sh: line 5: 2384 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:51 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:51 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:51 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:51 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:51 volumiorpi1 volumio[2386]: /usr/lib/startconnect.sh: line 5: 2387 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:53 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand add "https://corn.kvsc.org/radiox" Oct 30 21:10:53 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:53 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:53 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:53 volumiorpi1 volumio[927]: info: sendMpdCommand add "https://corn.kvsc.org/radiox" took 69 milliseconds Oct 30 21:10:53 volumiorpi1 volumio[927]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 30 21:10:53 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand play Oct 30 21:10:53 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:53 volumiorpi1 volumio[927]: info: Oct 30 21:10:53 volumiorpi1 volumio[927]: ---------------------------- MPD announces system playlist update Oct 30 21:10:53 volumiorpi1 volumio[927]: info: Ignoring MPD Status Update Oct 30 21:10:53 volumiorpi1 volumio[927]: info: sendMpdCommand play took 139 milliseconds Oct 30 21:10:53 volumiorpi1 volumio[927]: info: ------------------------------ 259ms Oct 30 21:10:54 volumiorpi1 volumio[2391]: /usr/lib/startconnect.sh: line 5: 2393 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:54 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 21:10:55 volumiorpi1 volumio[927]: info: Oct 30 21:10:55 volumiorpi1 volumio[927]: ---------------------------- MPD announces state update: player Oct 30 21:10:55 volumiorpi1 volumio[927]: info: ControllerMpd::getState Oct 30 21:10:55 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand status Oct 30 21:10:55 volumiorpi1 volumio[927]: info: sendMpdCommand status took 107 milliseconds Oct 30 21:10:56 volumiorpi1 volumio[927]: verbose: ControllerMpd::parseState Oct 30 21:10:56 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 21:10:56 volumiorpi1 volumio[927]: info: Oct 30 21:10:56 volumiorpi1 volumio[927]: ---------------------------- MPD announces state update: player Oct 30 21:10:56 volumiorpi1 volumio[927]: info: ControllerMpd::getState Oct 30 21:10:56 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand status Oct 30 21:10:56 volumiorpi1 volumio[927]: info: Oct 30 21:10:56 volumiorpi1 volumio[927]: ---------------------------- MPD announces system playlist update Oct 30 21:10:56 volumiorpi1 volumio[927]: info: Ignoring MPD Status Update Oct 30 21:10:56 volumiorpi1 volumio[927]: info: Oct 30 21:10:56 volumiorpi1 volumio[927]: ---------------------------- MPD announces state update: player Oct 30 21:10:56 volumiorpi1 volumio[927]: info: sendMpdCommand playlistinfo took 112 milliseconds Oct 30 21:10:56 volumiorpi1 volumio[927]: info: ControllerMpd::getState Oct 30 21:10:56 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand status Oct 30 21:10:56 volumiorpi1 volumio[927]: verbose: ControllerMpd::parseTrackInfo Oct 30 21:10:56 volumiorpi1 volumio[927]: info: ControllerMpd::pushState Oct 30 21:10:56 volumiorpi1 volumio[927]: info: CoreCommandRouter::servicePushState Oct 30 21:10:56 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:56 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:56 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:56 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:56 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:56 volumiorpi1 volumio[927]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"97.5FM RadioX","artist":"RadioX 97.5FM","album":null,"uri":"https://corn.kvsc.org/radiox","trackType":"org/radiox"} Oct 30 21:10:56 volumiorpi1 volumio[927]: verbose: CURRENT POSITION 0 Oct 30 21:10:56 volumiorpi1 volumio[927]: info: CoreStateMachine::syncState stateService play Oct 30 21:10:56 volumiorpi1 volumio[927]: info: CoreStateMachine::syncState currentStatus stop Oct 30 21:10:56 volumiorpi1 volumio[927]: info: CoreStateMachine::pushState Oct 30 21:10:56 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioPushState Oct 30 21:10:56 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:10:56 volumiorpi1 volumio[2397]: /usr/lib/startconnect.sh: line 5: 2398 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:10:57 volumiorpi1 volumio[927]: info: ------------------------------ 1503ms Oct 30 21:10:57 volumiorpi1 volumio[927]: info: sendMpdCommand status took 1148 milliseconds Oct 30 21:10:57 volumiorpi1 volumio[927]: info: ------------------------------ 1142ms Oct 30 21:10:57 volumiorpi1 volumio[927]: info: sendMpdCommand status took 1104 milliseconds Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: ControllerMpd::parseState Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: ControllerMpd::parseState Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 30 21:10:57 volumiorpi1 volumio[927]: info: LedStatus: state = Oct 30 21:10:57 volumiorpi1 volumio[927]: info: LedStatus: stop => switch off led Oct 30 21:10:57 volumiorpi1 volumio[927]: info: LedStatus : remove blinking interval Oct 30 21:10:57 volumiorpi1 volumio[927]: info: sendMpdCommand playlistinfo took 230 milliseconds Oct 30 21:10:57 volumiorpi1 volumio[927]: info: sendMpdCommand playlistinfo took 228 milliseconds Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: ControllerMpd::parseTrackInfo Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: ControllerMpd::parseTrackInfo Oct 30 21:10:57 volumiorpi1 volumio[927]: info: ControllerMpd::pushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::servicePushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: STATE SERVICE {"status":"play","position":0,"seek":734,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"97.5FM RadioX","artist":"RadioX 97.5FM","album":null,"uri":"https://corn.kvsc.org/radiox","trackType":"org/radiox"} Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: CURRENT POSITION 0 Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreStateMachine::syncState stateService play Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreStateMachine::syncState currentStatus play Oct 30 21:10:57 volumiorpi1 volumio[927]: info: Received an update from plugin. extracting info from payload Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreStateMachine::pushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioPushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreStateMachine::pushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioPushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:10:57 volumiorpi1 volumio[927]: info: ControllerMpd::pushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::servicePushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CorePlayQueue::getTrack 0 Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"97.5FM RadioX","artist":"RadioX 97.5FM","album":null,"uri":"https://corn.kvsc.org/radiox","trackType":"org/radiox"} Oct 30 21:10:57 volumiorpi1 volumio[927]: verbose: CURRENT POSITION 0 Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreStateMachine::syncState stateService play Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreStateMachine::syncState currentStatus play Oct 30 21:10:57 volumiorpi1 volumio[927]: info: Received an update from plugin. extracting info from payload Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreStateMachine::pushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioPushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreStateMachine::pushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::volumioPushState Oct 30 21:10:57 volumiorpi1 volumio[927]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 30 21:10:58 volumiorpi1 volumio[927]: info: ------------------------------ 2062ms Oct 30 21:10:58 volumiorpi1 volumio[927]: info: ------------------------------ 2017ms Oct 30 21:10:58 volumiorpi1 volumio[927]: info: LedStatus: state = play Oct 30 21:10:58 volumiorpi1 volumio[927]: info: LedStatus: play => start blinking led Oct 30 21:10:58 volumiorpi1 volumio[927]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 21:10:58 volumiorpi1 volumio[927]: Error: The value undefined is not a number Oct 30 21:10:58 volumiorpi1 volumio[927]: at Config.forceToType (/data/plugins/user_interface/ledstatus/node_modules/v-conf/index.js:322:20) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Config.get (/data/plugins/user_interface/ledstatus/node_modules/v-conf/index.js:137:21) Oct 30 21:10:58 volumiorpi1 volumio[927]: at ledstatus.startBlink (/data/plugins/user_interface/ledstatus/index.js:93:31) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Socket. (/data/plugins/user_interface/ledstatus/index.js:41:26) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Socket.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Socket.onevent (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/socket.js:270:10) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Socket.onpacket (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/socket.js:228:12) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Manager. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Manager.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Manager.ondecoded (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/manager.js:332:8) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Decoder. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Decoder.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Decoder.add (/data/plugins/user_interface/ledstatus/node_modules/socket.io-parser/index.js:246:12) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Manager.ondata (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/manager.js:322:16) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Socket. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) Oct 30 21:10:58 volumiorpi1 volumio[927]: at Socket.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) Oct 30 21:10:58 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:10:58 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:10:58 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:10:58 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:10:58 volumiorpi1 volumio[927]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 21:10:59 volumiorpi1 volumio[2403]: /usr/lib/startconnect.sh: line 5: 2404 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:11:01 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:11:01 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:11:01 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:11:01 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:11:02 volumiorpi1 volumio[2411]: /usr/lib/startconnect.sh: line 5: 2413 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:11:04 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:11:04 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:11:04 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:11:04 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:11:04 volumiorpi1 volumio[2432]: /usr/lib/startconnect.sh: line 5: 2433 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:11:06 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:11:06 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:11:06 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:11:06 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:11:07 volumiorpi1 volumio[2436]: /usr/lib/startconnect.sh: line 5: 2437 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:11:09 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:11:09 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:11:09 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:11:09 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:11:09 volumiorpi1 volumio[2439]: /usr/lib/startconnect.sh: line 5: 2440 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:11:11 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 30 21:11:11 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 30 21:11:11 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 30 21:11:11 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 30 21:11:12 volumiorpi1 volumio[2443]: /usr/lib/startconnect.sh: line 5: 2445 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 30 21:11:14 volumiorpi1 sudo[2444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-30 21:10 Oct 30 21:11:14 volumiorpi1 sudo[2444]: 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"