-- Logs begin at Fri 2024-10-25 19:15:04 UTC, end at Sun 2024-10-27 20:19:58 UTC. -- Oct 27 20:18:00 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:00 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:00 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:00 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:00 volumiorpi1 volumio[6272]: /usr/lib/startconnect.sh: line 5: 6273 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:00 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 27 20:18:01 volumiorpi1 sudo[6276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 27 20:18:01 volumiorpi1 sudo[6276]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:01 volumiorpi1 sudo[6276]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:01 volumiorpi1 sudo[6281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 27 20:18:02 volumiorpi1 sudo[6281]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:02 volumiorpi1 sudo[6281]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:02 volumiorpi1 sudo[6289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 27 20:18:02 volumiorpi1 sudo[6289]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:02 volumiorpi1 sudo[6289]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:03 volumiorpi1 sudo[6300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 27 20:18:03 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:03 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:03 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:03 volumiorpi1 sudo[6300]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:03 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:03 volumiorpi1 sudo[6300]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:03 volumiorpi1 volumio[6325]: /usr/lib/startconnect.sh: line 5: 6328 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:03 volumiorpi1 sudo[6315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 27 20:18:03 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 27 20:18:03 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 27 20:18:03 volumiorpi1 sudo[6315]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:03 volumiorpi1 sudo[6322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 27 20:18:03 volumiorpi1 sudo[6315]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:04 volumiorpi1 sudo[6322]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:04 volumiorpi1 sudo[6322]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:04 volumiorpi1 sudo[6342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 27 20:18:04 volumiorpi1 sudo[6342]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:04 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:04 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:04 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:05 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:05 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:05 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:05 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:05 volumiorpi1 sudo[6342]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:05 volumiorpi1 volumio[6353]: /usr/lib/startconnect.sh: line 5: 6354 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:08 volumiorpi1 sudo[6360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 27 20:18:08 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:08 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:08 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:08 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:08 volumiorpi1 sudo[6360]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:08 volumiorpi1 volumio[6366]: /usr/lib/startconnect.sh: line 5: 6370 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:18:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:18:08 volumiorpi1 volumio[851]: info: Discovery: Getting this device information Oct 27 20:18:08 volumiorpi1 sudo[6360]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioGetState Oct 27 20:18:08 volumiorpi1 sudo[6362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 27 20:18:08 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:18:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 27 20:18:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:18:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:18:08 volumiorpi1 sudo[6362]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:08 volumiorpi1 sudo[6362]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:08 volumiorpi1 sudo[6368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 27 20:18:09 volumiorpi1 sudo[6368]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:09 volumiorpi1 systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 27 20:18:09 volumiorpi1 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 27 20:18:09 volumiorpi1 sudo[6368]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:09 volumiorpi1 volumio[851]: info: Upmpdcli Daemon Started Oct 27 20:18:10 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:10 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:10 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:10 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:10 volumiorpi1 volumio[6403]: /usr/lib/startconnect.sh: line 5: 6404 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:12 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:12 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:12 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:12 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:13 volumiorpi1 volumio[6410]: /usr/lib/startconnect.sh: line 5: 6411 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:15 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:15 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:15 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:15 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:15 volumiorpi1 volumio[6417]: /usr/lib/startconnect.sh: line 5: 6418 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:15 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 27 20:18:16 volumiorpi1 volumio[851]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 27 20:18:16 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 27 20:18:16 volumiorpi1 volumio[851]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Oct 27 20:18:16 volumiorpi1 volumio[851]: info: Received Get System Version Oct 27 20:18:16 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 27 20:18:17 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:17 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:17 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:17 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:17 volumiorpi1 volumio[6428]: /usr/lib/startconnect.sh: line 5: 6429 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:19 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:19 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:19 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:19 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:19 volumiorpi1 volumio[6435]: /usr/lib/startconnect.sh: line 5: 6436 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:21 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:21 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:21 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:21 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:22 volumiorpi1 volumio[6442]: /usr/lib/startconnect.sh: line 5: 6443 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:24 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:24 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:24 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:24 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:24 volumiorpi1 volumio[6451]: /usr/lib/startconnect.sh: line 5: 6453 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:27 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:27 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:27 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:27 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:27 volumiorpi1 volumio[6459]: /usr/lib/startconnect.sh: line 5: 6460 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:29 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:29 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:29 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:29 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:29 volumiorpi1 volumio[6466]: /usr/lib/startconnect.sh: line 5: 6467 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:31 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:31 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:31 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:31 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:31 volumiorpi1 volumio[6473]: /usr/lib/startconnect.sh: line 5: 6474 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:33 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:33 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:33 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:33 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:34 volumiorpi1 volumio[6480]: /usr/lib/startconnect.sh: line 5: 6481 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:36 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:36 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:36 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:36 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:36 volumiorpi1 volumio[6504]: /usr/lib/startconnect.sh: line 5: 6505 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:18:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:18:38 volumiorpi1 volumio[851]: info: Discovery: Getting this device information Oct 27 20:18:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioGetState Oct 27 20:18:38 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:18:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 27 20:18:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:18:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:18:38 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:38 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:38 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:38 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:38 volumiorpi1 volumio[6511]: /usr/lib/startconnect.sh: line 5: 6512 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:40 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:40 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:40 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:40 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:40 volumiorpi1 volumio[6518]: /usr/lib/startconnect.sh: line 5: 6519 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:43 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:43 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:43 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:43 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:43 volumiorpi1 volumio[6526]: /usr/lib/startconnect.sh: line 5: 6527 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:45 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:45 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:45 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:45 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:45 volumiorpi1 volumio[6535]: /usr/lib/startconnect.sh: line 5: 6536 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:46 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Oct 27 20:18:46 volumiorpi1 volumio[851]: info: Saving new wireless network Oct 27 20:18:46 volumiorpi1 sudo[6541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Oct 27 20:18:47 volumiorpi1 sudo[6541]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:47 volumiorpi1 systemd[1]: Stopping Wireless Services... Oct 27 20:18:47 volumiorpi1 systemd[1]: Starting Wireless Services... Oct 27 20:18:47 volumiorpi1 sudo[6548]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Oct 27 20:18:47 volumiorpi1 sudo[6548]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:47 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:47 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:47 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:47 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:48 volumiorpi1 volumio[6555]: /usr/lib/startconnect.sh: line 5: 6556 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:48 volumiorpi1 sudo[6548]: pam_unix(sudo:session): session closed for user root Oct 27 20:18:50 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:50 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:50 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:50 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:50 volumiorpi1 volumio[6570]: /usr/lib/startconnect.sh: line 5: 6573 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:52 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:52 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:52 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:52 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:53 volumiorpi1 volumio[6579]: /usr/lib/startconnect.sh: line 5: 6581 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:55 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:55 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:55 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:55 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:56 volumiorpi1 volumio[6587]: /usr/lib/startconnect.sh: line 5: 6588 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:57 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 27 20:18:57 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 27 20:18:58 volumiorpi1 sudo[6593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 27 20:18:58 volumiorpi1 sudo[6593]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:18:58 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:18:58 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:58 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:18:58 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:18:58 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:18:58 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:59 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:59 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:59 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:59 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:59 volumiorpi1 volumio[6600]: /usr/lib/startconnect.sh: line 5: 6602 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:18:59 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:59 volumiorpi1 kernel: zd1211rw 1-1.2.1:1.0: error ioread32(CR_REG1): -110 Oct 27 20:18:59 volumiorpi1 sudo[6593]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:00 volumiorpi1 wireless.js[6563]: Cleaning previous... Oct 27 20:19:00 volumiorpi1 systemd[1]: Stopped hotspot.service. Oct 27 20:19:01 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:01 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:01 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:01 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:02 volumiorpi1 volumio[6617]: /usr/lib/startconnect.sh: line 5: 6618 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:02 volumiorpi1 sudo[6620]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 27 20:19:02 volumiorpi1 sudo[6620]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:02 volumiorpi1 sudo[6620]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:02 volumiorpi1 sudo[6631]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 27 20:19:02 volumiorpi1 sudo[6631]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:03 volumiorpi1 sudo[6631]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:03 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioPlay Oct 27 20:19:03 volumiorpi1 volumio[851]: verbose: UNSET VOLATILE Oct 27 20:19:03 volumiorpi1 volumio[851]: info: CoreStateMachine::play index undefined Oct 27 20:19:03 volumiorpi1 volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 20:19:03 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:03 volumiorpi1 volumio[851]: info: CoreStateMachine::startPlaybackTimer Oct 27 20:19:03 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:03 volumiorpi1 volumio[851]: info: [1730060343277] ControllerWebradio::clearAddPlayTrack Oct 27 20:19:03 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 20:19:03 volumiorpi1 volumio[851]: info: sendMpdCommand stop took 348 milliseconds Oct 27 20:19:03 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 20:19:03 volumiorpi1 volumio[851]: info: Oct 27 20:19:03 volumiorpi1 volumio[851]: ---------------------------- MPD announces system playlist update Oct 27 20:19:04 volumiorpi1 volumio[851]: info: Ignoring MPD Status Update Oct 27 20:19:04 volumiorpi1 volumio[851]: info: sendMpdCommand clear took 334 milliseconds Oct 27 20:19:04 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand load "https://corn.kvsc.org/radiox" Oct 27 20:19:04 volumiorpi1 wireless.js[6563]: Stopped aP Oct 27 20:19:04 volumiorpi1 volumio[851]: error: updateQueue error: null Oct 27 20:19:04 volumiorpi1 volumio[851]: info: ------------------------------ 362ms Oct 27 20:19:04 volumiorpi1 wireless.js[6563]: Start wireless flow Oct 27 20:19:04 volumiorpi1 wireless.js[6563]: Stopped hotspot (if there).. Oct 27 20:19:04 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:04 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:04 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:04 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:05 volumiorpi1 sudo[6648]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 27 20:19:05 volumiorpi1 volumio[6647]: /usr/lib/startconnect.sh: line 5: 6649 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:05 volumiorpi1 sudo[6648]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:05 volumiorpi1 sudo[6648]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:06 volumiorpi1 sudo[6658]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 27 20:19:06 volumiorpi1 sudo[6658]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:06 volumiorpi1 sudo[6658]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:07 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:07 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:07 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:07 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:07 volumiorpi1 volumio[6668]: /usr/lib/startconnect.sh: line 5: 6669 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:08 volumiorpi1 wireless.js[6563]: DHCP IP Oct 27 20:19:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:19:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:19:08 volumiorpi1 volumio[851]: info: Discovery: Getting this device information Oct 27 20:19:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioGetState Oct 27 20:19:08 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 27 20:19:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:19:08 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:19:08 volumiorpi1 wireless.js[6563]: Start ap Oct 27 20:19:09 volumiorpi1 sudo[6671]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Oct 27 20:19:09 volumiorpi1 sudo[6671]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:09 volumiorpi1 dhcpcd[6675]: version 6.0.5 starting Oct 27 20:19:09 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:09 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:09 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:09 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:10 volumiorpi1 wireless.js[6563]: trying... Oct 27 20:19:10 volumiorpi1 volumio[6676]: /usr/lib/startconnect.sh: line 5: 6678 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:12 volumiorpi1 sudo[6682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 27 20:19:12 volumiorpi1 sudo[6682]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:12 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:12 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:12 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:12 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:13 volumiorpi1 volumio[6693]: /usr/lib/startconnect.sh: line 5: 6695 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:14 volumiorpi1 wpa_supplicant[6666]: Successfully initialized wpa_supplicant Oct 27 20:19:15 volumiorpi1 sudo[6682]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:16 volumiorpi1 dhcpcd[6675]: eth0: soliciting an IPv6 router Oct 27 20:19:16 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:16 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:16 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:16 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:16 volumiorpi1 dhcpcd[6675]: eth0: rebinding lease of 192.168.1.134 Oct 27 20:19:16 volumiorpi1 dhcpcd[6675]: wlan0: waiting for carrier Oct 27 20:19:16 volumiorpi1 dhcpcd[6675]: eth0: leased 192.168.1.134 for 86400 seconds Oct 27 20:19:16 volumiorpi1 dhcpcd[6675]: eth0: adding host route to 192.168.1.134 via 127.0.0.1 Oct 27 20:19:16 volumiorpi1 dhcpcd[6675]: eth0: adding route to 192.168.1.0/24 Oct 27 20:19:16 volumiorpi1 dhcpcd[6675]: eth0: adding default route via 192.168.1.1 Oct 27 20:19:16 volumiorpi1 volumio[6724]: /usr/lib/startconnect.sh: line 5: 6726 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:17 volumiorpi1 wireless.js[6563]: trying... Oct 27 20:19:18 volumiorpi1 wpa_supplicant[6731]: wlan0: SME: Trying to authenticate with 48:ed:e6:a5:ee:01 (SSID='DIGIFIBRA-4388' freq=2462 MHz) Oct 27 20:19:18 volumiorpi1 kernel: wlan0: authenticate with 48:ed:e6:a5:ee:01 Oct 27 20:19:18 volumiorpi1 kernel: wlan0: send auth to 48:ed:e6:a5:ee:01 (try 1/3) Oct 27 20:19:18 volumiorpi1 kernel: wlan0: authenticated Oct 27 20:19:18 volumiorpi1 kernel: wlan0: associate with 48:ed:e6:a5:ee:01 (try 1/3) Oct 27 20:19:18 volumiorpi1 kernel: wlan0: RX AssocResp from 48:ed:e6:a5:ee:01 (capab=0x1c11 status=0 aid=17) Oct 27 20:19:18 volumiorpi1 kernel: wlan0: associated Oct 27 20:19:18 volumiorpi1 wpa_supplicant[6731]: wlan0: Trying to associate with 48:ed:e6:a5:ee:01 (SSID='DIGIFIBRA-4388' freq=2462 MHz) Oct 27 20:19:18 volumiorpi1 wpa_supplicant[6731]: wlan0: Associated with 48:ed:e6:a5:ee:01 Oct 27 20:19:18 volumiorpi1 kernel: wlan0: Limiting TX power to 20 (20 - 0) dBm as advertised by 48:ed:e6:a5:ee:01 Oct 27 20:19:18 volumiorpi1 dhcpcd[6675]: forked to background, child pid 6749 Oct 27 20:19:18 volumiorpi1 dhcpcd[6749]: eth0: removing route to 192.168.1.0/24 Oct 27 20:19:18 volumiorpi1 dhcpcd[6749]: eth0: removing default route via 192.168.1.1 Oct 27 20:19:18 volumiorpi1 sudo[6671]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:19 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:19 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:19 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:19 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:19 volumiorpi1 volumio[6758]: /usr/lib/startconnect.sh: line 5: 6762 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:20 volumiorpi1 wpa_supplicant[6731]: wlan0: WPA: Key negotiation completed with 48:ed:e6:a5:ee:01 [PTK=CCMP GTK=CCMP] Oct 27 20:19:20 volumiorpi1 wpa_supplicant[6731]: wlan0: CTRL-EVENT-CONNECTED - Connection to 48:ed:e6:a5:ee:01 completed [id=0 id_str=] Oct 27 20:19:20 volumiorpi1 dhcpcd[6749]: wlan0: carrier acquired Oct 27 20:19:20 volumiorpi1 sudo[6764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 27 20:19:20 volumiorpi1 wpa_supplicant[6731]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Oct 27 20:19:21 volumiorpi1 sudo[6764]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:21 volumiorpi1 sudo[6764]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:21 volumiorpi1 dhcpcd[6749]: wlan0: soliciting an IPv6 router Oct 27 20:19:22 volumiorpi1 dhcpcd[6749]: wlan0: rebinding lease of 192.168.1.178 Oct 27 20:19:22 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:22 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:22 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:22 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:22 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand add "https://corn.kvsc.org/radiox" Oct 27 20:19:22 volumiorpi1 volumio[6800]: /usr/lib/startconnect.sh: line 5: 6801 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:22 volumiorpi1 wireless.js[6563]: trying... Oct 27 20:19:23 volumiorpi1 sudo[6804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 27 20:19:23 volumiorpi1 volumio[851]: info: Oct 27 20:19:23 volumiorpi1 volumio[851]: ---------------------------- MPD announces system playlist update Oct 27 20:19:23 volumiorpi1 sudo[6804]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:23 volumiorpi1 volumio[851]: info: Ignoring MPD Status Update Oct 27 20:19:23 volumiorpi1 volumio[851]: info: sendMpdCommand add "https://corn.kvsc.org/radiox" took 1107 milliseconds Oct 27 20:19:23 volumiorpi1 sudo[6804]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:23 volumiorpi1 volumio[851]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 27 20:19:23 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand play Oct 27 20:19:24 volumiorpi1 volumio[851]: info: ------------------------------ 957ms Oct 27 20:19:24 volumiorpi1 volumio[851]: info: sendMpdCommand play took 765 milliseconds Oct 27 20:19:24 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:24 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:24 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:24 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:25 volumiorpi1 wireless.js[6563]: trying... Oct 27 20:19:25 volumiorpi1 sudo[6816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 27 20:19:25 volumiorpi1 sudo[6816]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:25 volumiorpi1 sudo[6816]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:25 volumiorpi1 volumio[6814]: /usr/lib/startconnect.sh: line 5: 6824 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:25 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioPlay Oct 27 20:19:25 volumiorpi1 volumio[851]: verbose: UNSET VOLATILE Oct 27 20:19:25 volumiorpi1 volumio[851]: info: CoreStateMachine::play index undefined Oct 27 20:19:25 volumiorpi1 volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 20:19:26 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:26 volumiorpi1 volumio[851]: info: CoreStateMachine::startPlaybackTimer Oct 27 20:19:26 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:26 volumiorpi1 volumio[851]: info: [1730060366024] ControllerWebradio::clearAddPlayTrack Oct 27 20:19:26 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 20:19:26 volumiorpi1 wireless.js[6563]: trying... Oct 27 20:19:26 volumiorpi1 sudo[6828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 27 20:19:26 volumiorpi1 dhcpcd[6749]: wlan0: leased 192.168.1.178 for 86400 seconds Oct 27 20:19:26 volumiorpi1 dhcpcd[6749]: eth0: adding route to 192.168.1.0/24 Oct 27 20:19:26 volumiorpi1 dhcpcd[6749]: eth0: adding default route via 192.168.1.1 Oct 27 20:19:26 volumiorpi1 dhcpcd[6749]: wlan0: adding host route to 192.168.1.178 via 127.0.0.1 Oct 27 20:19:26 volumiorpi1 dhcpcd[6749]: wlan0: adding route to 192.168.1.0/24 Oct 27 20:19:26 volumiorpi1 dhcpcd[6749]: wlan0: adding default route via 192.168.1.1 Oct 27 20:19:27 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioPlay Oct 27 20:19:27 volumiorpi1 sudo[6828]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:27 volumiorpi1 volumio[851]: verbose: UNSET VOLATILE Oct 27 20:19:27 volumiorpi1 volumio[851]: info: CoreStateMachine::play index undefined Oct 27 20:19:27 volumiorpi1 volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 27 20:19:27 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:27 volumiorpi1 volumio[851]: info: CoreStateMachine::startPlaybackTimer Oct 27 20:19:27 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:27 volumiorpi1 volumio[851]: info: [1730060367295] ControllerWebradio::clearAddPlayTrack Oct 27 20:19:27 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand stop Oct 27 20:19:27 volumiorpi1 sudo[6828]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:27 volumiorpi1 avahi-daemon[650]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.178. Oct 27 20:19:27 volumiorpi1 avahi-daemon[650]: New relevant interface wlan0.IPv4 for mDNS. Oct 27 20:19:27 volumiorpi1 avahi-daemon[650]: Registering new address record for 192.168.1.178 on wlan0.IPv4. Oct 27 20:19:27 volumiorpi1 wireless.js[6563]: Connected to: ----DIGIFIBRA-4388 Oct 27 20:19:27 volumiorpi1 wireless.js[6563]: ---- Oct 27 20:19:27 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:27 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:27 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:27 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:29 volumiorpi1 volumio[6847]: /usr/lib/startconnect.sh: line 5: 6854 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:29 volumiorpi1 sudo[6855]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 27 20:19:29 volumiorpi1 ntpd[706]: Listen normally on 5 wlan0 192.168.1.178 UDP 123 Oct 27 20:19:29 volumiorpi1 dhcpcd[6749]: eth0: removing route to 192.168.1.0/24 Oct 27 20:19:29 volumiorpi1 dhcpcd[6749]: eth0: removing default route via 192.168.1.1 Oct 27 20:19:29 volumiorpi1 ntpd[706]: peers refreshed Oct 27 20:19:29 volumiorpi1 volumio[851]: Discovery: this is already registered, be867bfd-a1e3-4978-8908-13f77aa172d6 Oct 27 20:19:30 volumiorpi1 volumio[851]: info: mDNS: Found device Volumiorpi1 Oct 27 20:19:30 volumiorpi1 sudo[6855]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:30 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioGetState Oct 27 20:19:30 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:30 volumiorpi1 sudo[6855]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:30 volumiorpi1 wireless.js[6563]: trying... Oct 27 20:19:30 volumiorpi1 volumio[851]: info: Oct 27 20:19:30 volumiorpi1 volumio[851]: ---------------------------- MPD announces state update: player Oct 27 20:19:30 volumiorpi1 volumio[851]: info: sendMpdCommand stop took 4614 milliseconds Oct 27 20:19:31 volumiorpi1 volumio[851]: info: ControllerMpd::getState Oct 27 20:19:31 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:19:31 volumiorpi1 volumio[851]: info: sendMpdCommand stop took 3732 milliseconds Oct 27 20:19:31 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 20:19:31 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand clear Oct 27 20:19:31 volumiorpi1 sudo[6873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 27 20:19:31 volumiorpi1 volumio[851]: info: Oct 27 20:19:31 volumiorpi1 volumio[851]: ---------------------------- MPD announces system playlist update Oct 27 20:19:31 volumiorpi1 sudo[6873]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:31 volumiorpi1 volumio[851]: info: Ignoring MPD Status Update Oct 27 20:19:31 volumiorpi1 volumio[851]: info: Oct 27 20:19:31 volumiorpi1 volumio[851]: ---------------------------- MPD announces system playlist update Oct 27 20:19:31 volumiorpi1 volumio[851]: info: Ignoring MPD Status Update Oct 27 20:19:31 volumiorpi1 sudo[6873]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:31 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:31 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:31 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:31 volumiorpi1 volumio[851]: info: sendMpdCommand status took 614 milliseconds Oct 27 20:19:31 volumiorpi1 volumio[851]: info: sendMpdCommand clear took 616 milliseconds Oct 27 20:19:31 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:31 volumiorpi1 volumio[851]: info: sendMpdCommand clear took 593 milliseconds Oct 27 20:19:31 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseState Oct 27 20:19:31 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:19:31 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand load "https://corn.kvsc.org/radiox" Oct 27 20:19:31 volumiorpi1 wireless.js[6563]: Connected to: ----DIGIFIBRA-4388 Oct 27 20:19:31 volumiorpi1 wireless.js[6563]: ---- Oct 27 20:19:31 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand load "https://corn.kvsc.org/radiox" Oct 27 20:19:32 volumiorpi1 volumio[851]: error: updateQueue error: null Oct 27 20:19:32 volumiorpi1 volumio[851]: error: updateQueue error: null Oct 27 20:19:32 volumiorpi1 volumio[851]: info: ------------------------------ 743ms Oct 27 20:19:32 volumiorpi1 volumio[851]: info: ------------------------------ 724ms Oct 27 20:19:32 volumiorpi1 volumio[851]: info: sendMpdCommand playlistinfo took 287 milliseconds Oct 27 20:19:32 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:19:32 volumiorpi1 volumio[6880]: /usr/lib/startconnect.sh: line 5: 6883 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:32 volumiorpi1 volumio[851]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 27 20:19:32 volumiorpi1 volumio[851]: info: ------------------------------ 1424ms Oct 27 20:19:32 volumiorpi1 sudo[6884]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 27 20:19:32 volumiorpi1 wireless.js[6563]: ... joined AP, wlan0 IPv4 is 192.168.1.178, ipV6 is undefined Oct 27 20:19:32 volumiorpi1 wireless.js[6563]: It's done! AP Oct 27 20:19:32 volumiorpi1 sudo[6884]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:33 volumiorpi1 sudo[6884]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:33 volumiorpi1 wireless.js[6563]: ... joined AP, wlan0 IPv4 is 192.168.1.178, ipV6 is undefined Oct 27 20:19:33 volumiorpi1 wireless.js[6563]: It's done! AP Oct 27 20:19:34 volumiorpi1 systemd[1]: Started Wireless Services. Oct 27 20:19:34 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:34 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:34 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:34 volumiorpi1 sudo[6541]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:34 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:34 volumiorpi1 volumio[6895]: /usr/lib/startconnect.sh: line 5: 6899 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:35 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand add "https://corn.kvsc.org/radiox" Oct 27 20:19:36 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:36 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:36 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:36 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:36 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand add "https://corn.kvsc.org/radiox" Oct 27 20:19:37 volumiorpi1 volumio[851]: info: Oct 27 20:19:37 volumiorpi1 volumio[851]: ---------------------------- MPD announces system playlist update Oct 27 20:19:37 volumiorpi1 volumio[851]: info: Ignoring MPD Status Update Oct 27 20:19:37 volumiorpi1 volumio[851]: info: Oct 27 20:19:37 volumiorpi1 volumio[851]: ---------------------------- MPD announces system playlist update Oct 27 20:19:37 volumiorpi1 volumio[851]: info: Ignoring MPD Status Update Oct 27 20:19:37 volumiorpi1 volumio[851]: info: sendMpdCommand add "https://corn.kvsc.org/radiox" took 1957 milliseconds Oct 27 20:19:37 volumiorpi1 volumio[851]: info: sendMpdCommand add "https://corn.kvsc.org/radiox" took 72 milliseconds Oct 27 20:19:37 volumiorpi1 volumio[851]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 27 20:19:37 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand play Oct 27 20:19:37 volumiorpi1 volumio[851]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 27 20:19:37 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand play Oct 27 20:19:37 volumiorpi1 volumio[851]: info: ------------------------------ 234ms Oct 27 20:19:37 volumiorpi1 volumio[851]: info: ------------------------------ 218ms Oct 27 20:19:37 volumiorpi1 volumio[851]: info: sendMpdCommand play took 176 milliseconds Oct 27 20:19:37 volumiorpi1 volumio[6918]: /usr/lib/startconnect.sh: line 5: 6919 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:37 volumiorpi1 volumio[851]: info: sendMpdCommand play took 158 milliseconds Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:19:38 volumiorpi1 volumio[851]: info: Discovery: Getting this device information Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioGetState Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:19:38 volumiorpi1 volumio[851]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'indexOf' of undefined Oct 27 20:19:38 volumiorpi1 volumio[851]: at ControllerVolumioDiscovery.getThisDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:436:34) Oct 27 20:19:38 volumiorpi1 volumio[851]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1052:32) Oct 27 20:19:38 volumiorpi1 volumio[851]: at ControllerSystem.getSystemInfo (/volumio/app/plugins/system_controller/system/index.js:422:45) Oct 27 20:19:38 volumiorpi1 volumio[851]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1052:32) Oct 27 20:19:38 volumiorpi1 volumio[851]: at RESTApiSystem.getSystemInfo (/volumio/app/plugins/user_interface/rest_api/system.js:38:41) Oct 27 20:19:38 volumiorpi1 volumio[851]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Oct 27 20:19:38 volumiorpi1 volumio[851]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Oct 27 20:19:38 volumiorpi1 volumio[851]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Oct 27 20:19:38 volumiorpi1 volumio[851]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Oct 27 20:19:38 volumiorpi1 volumio[851]: at /volumio/node_modules/express/lib/router/index.js:281:22 Oct 27 20:19:38 volumiorpi1 volumio[851]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Oct 27 20:19:38 volumiorpi1 volumio[851]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Oct 27 20:19:38 volumiorpi1 volumio[851]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Oct 27 20:19:38 volumiorpi1 volumio[851]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Oct 27 20:19:38 volumiorpi1 volumio[851]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Oct 27 20:19:38 volumiorpi1 volumio[851]: at /volumio/node_modules/express/lib/router/index.js:284:7 Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 20:19:38 volumiorpi1 volumio[851]: info: Discovery: Getting this device information Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioGetState Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:19:38 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getConf Oct 27 20:19:38 volumiorpi1 volumio[851]: An internal error occurred while serving an albumart. Details: TypeError: Cannot read property 'indexOf' of undefined Oct 27 20:19:39 volumiorpi1 volumio[851]: at ControllerVolumioDiscovery.getThisDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:436:34) Oct 27 20:19:39 volumiorpi1 volumio[851]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1052:32) Oct 27 20:19:39 volumiorpi1 volumio[851]: at ControllerSystem.getSystemInfo (/volumio/app/plugins/system_controller/system/index.js:422:45) Oct 27 20:19:39 volumiorpi1 volumio[851]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1052:32) Oct 27 20:19:39 volumiorpi1 volumio[851]: at RESTApiSystem.getSystemInfo (/volumio/app/plugins/user_interface/rest_api/system.js:38:41) Oct 27 20:19:39 volumiorpi1 volumio[851]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Oct 27 20:19:39 volumiorpi1 volumio[851]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Oct 27 20:19:39 volumiorpi1 volumio[851]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Oct 27 20:19:39 volumiorpi1 volumio[851]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Oct 27 20:19:39 volumiorpi1 volumio[851]: at /volumio/node_modules/express/lib/router/index.js:281:22 Oct 27 20:19:39 volumiorpi1 volumio[851]: at Function.process_params (/volumio/node_modules/express/lib/router/index.js:335:12) Oct 27 20:19:39 volumiorpi1 volumio[851]: at next (/volumio/node_modules/express/lib/router/index.js:275:10) Oct 27 20:19:39 volumiorpi1 volumio[851]: at jsonParser (/volumio/node_modules/body-parser/lib/types/json.js:110:7) Oct 27 20:19:39 volumiorpi1 volumio[851]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Oct 27 20:19:39 volumiorpi1 volumio[851]: at trim_prefix (/volumio/node_modules/express/lib/router/index.js:317:13) Oct 27 20:19:39 volumiorpi1 volumio[851]: at /volumio/node_modules/express/lib/router/index.js:284:7 Oct 27 20:19:39 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:39 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:39 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:39 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:39 volumiorpi1 volumio[851]: info: Oct 27 20:19:39 volumiorpi1 volumio[851]: ---------------------------- MPD announces state update: player Oct 27 20:19:39 volumiorpi1 volumio[851]: info: ControllerMpd::getState Oct 27 20:19:39 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:19:39 volumiorpi1 volumio[851]: info: Oct 27 20:19:39 volumiorpi1 volumio[851]: ---------------------------- MPD announces state update: player Oct 27 20:19:39 volumiorpi1 volumio[851]: info: Oct 27 20:19:39 volumiorpi1 volumio[851]: ---------------------------- MPD announces system playlist update Oct 27 20:19:39 volumiorpi1 volumio[851]: info: Ignoring MPD Status Update Oct 27 20:19:39 volumiorpi1 volumio[851]: info: Oct 27 20:19:39 volumiorpi1 volumio[851]: ---------------------------- MPD announces state update: player Oct 27 20:19:39 volumiorpi1 volumio[6925]: /usr/lib/startconnect.sh: line 5: 6926 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:39 volumiorpi1 volumio[851]: info: ControllerMpd::getState Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:19:40 volumiorpi1 volumio[851]: info: sendMpdCommand status took 147 milliseconds Oct 27 20:19:40 volumiorpi1 volumio[851]: info: ControllerMpd::getState Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseState Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:19:40 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Oct 27 20:19:40 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Oct 27 20:19:40 volumiorpi1 volumio[851]: info: Oct 27 20:19:40 volumiorpi1 volumio[851]: ---------------------------- MPD announces system playlist update Oct 27 20:19:40 volumiorpi1 volumio[851]: info: Ignoring MPD Status Update Oct 27 20:19:40 volumiorpi1 volumio[851]: info: Oct 27 20:19:40 volumiorpi1 volumio[851]: ---------------------------- MPD announces state update: player Oct 27 20:19:40 volumiorpi1 volumio[851]: info: ControllerMpd::getState Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand status Oct 27 20:19:40 volumiorpi1 volumio[851]: info: sendMpdCommand status took 652 milliseconds Oct 27 20:19:40 volumiorpi1 volumio[851]: info: ------------------------------ 736ms Oct 27 20:19:40 volumiorpi1 volumio[851]: info: sendMpdCommand status took 635 milliseconds Oct 27 20:19:40 volumiorpi1 volumio[851]: info: sendMpdCommand playlistinfo took 604 milliseconds Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseState Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseState Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:19:40 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:19:40 volumiorpi1 volumio[851]: info: ControllerMpd::pushState Oct 27 20:19:40 volumiorpi1 volumio[851]: info: CoreCommandRouter::servicePushState Oct 27 20:19:40 volumiorpi1 sudo[6929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 27 20:19:41 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:41 volumiorpi1 volumio[851]: verbose: STATE SERVICE {"status":"play","position":0,"seek":232,"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 27 20:19:41 volumiorpi1 volumio[851]: verbose: CURRENT POSITION 0 Oct 27 20:19:41 volumiorpi1 volumio[851]: info: CoreStateMachine::syncState stateService play Oct 27 20:19:41 volumiorpi1 volumio[851]: info: CoreStateMachine::syncState currentStatus stop Oct 27 20:19:41 volumiorpi1 volumio[851]: info: CoreStateMachine::pushState Oct 27 20:19:41 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioPushState Oct 27 20:19:41 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:19:41 volumiorpi1 sudo[6929]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 20:19:41 volumiorpi1 sudo[6929]: pam_unix(sudo:session): session closed for user root Oct 27 20:19:41 volumiorpi1 volumio[851]: info: ------------------------------ 2042ms Oct 27 20:19:41 volumiorpi1 volumio[851]: info: ------------------------------ 1617ms Oct 27 20:19:41 volumiorpi1 volumio[851]: info: sendMpdCommand status took 1492 milliseconds Oct 27 20:19:42 volumiorpi1 volumio[851]: info: sendMpdCommand playlistinfo took 1335 milliseconds Oct 27 20:19:42 volumiorpi1 volumio[851]: info: sendMpdCommand playlistinfo took 1307 milliseconds Oct 27 20:19:42 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseState Oct 27 20:19:42 volumiorpi1 volumio[851]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 20:19:42 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:19:42 volumiorpi1 volumio[851]: verbose: ControllerMpd::parseTrackInfo Oct 27 20:19:42 volumiorpi1 volumio[851]: info: ControllerMpd::pushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::servicePushState Oct 27 20:19:42 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:42 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:42 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:42 volumiorpi1 volumio[851]: verbose: STATE SERVICE {"status":"play","position":0,"seek":502,"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 27 20:19:42 volumiorpi1 volumio[851]: verbose: CURRENT POSITION 0 Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreStateMachine::syncState stateService play Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreStateMachine::syncState currentStatus play Oct 27 20:19:42 volumiorpi1 volumio[851]: info: Received an update from plugin. extracting info from payload Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 27 20:19:42 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreStateMachine::pushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioPushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreStateMachine::pushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioPushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:19:42 volumiorpi1 volumio[851]: info: ControllerMpd::pushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::servicePushState Oct 27 20:19:42 volumiorpi1 volumio[6937]: /usr/lib/startconnect.sh: line 5: 6938 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CorePlayQueue::getTrack 0 Oct 27 20:19:42 volumiorpi1 volumio[851]: verbose: STATE SERVICE {"status":"play","position":0,"seek":618,"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 27 20:19:42 volumiorpi1 volumio[851]: verbose: CURRENT POSITION 0 Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreStateMachine::syncState stateService play Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreStateMachine::syncState currentStatus play Oct 27 20:19:42 volumiorpi1 volumio[851]: info: Received an update from plugin. extracting info from payload Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreStateMachine::pushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioPushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreStateMachine::pushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::volumioPushState Oct 27 20:19:42 volumiorpi1 volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 20:19:43 volumiorpi1 volumio[851]: info: ------------------------------ 3318ms Oct 27 20:19:43 volumiorpi1 volumio[851]: info: ------------------------------ 3286ms Oct 27 20:19:43 volumiorpi1 volumio[851]: info: LedStatus: state = Oct 27 20:19:43 volumiorpi1 volumio[851]: info: LedStatus: stop => switch off led Oct 27 20:19:43 volumiorpi1 volumio[851]: info: LedStatus : remove blinking interval Oct 27 20:19:43 volumiorpi1 volumio[851]: info: LedStatus: state = play Oct 27 20:19:43 volumiorpi1 volumio[851]: info: LedStatus: play => start blinking led Oct 27 20:19:43 volumiorpi1 volumio[851]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 20:19:43 volumiorpi1 volumio[851]: Error: The value undefined is not a number Oct 27 20:19:43 volumiorpi1 volumio[851]: at Config.forceToType (/data/plugins/user_interface/ledstatus/node_modules/v-conf/index.js:322:20) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Config.get (/data/plugins/user_interface/ledstatus/node_modules/v-conf/index.js:137:21) Oct 27 20:19:43 volumiorpi1 volumio[851]: at ledstatus.startBlink (/data/plugins/user_interface/ledstatus/index.js:93:31) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Socket. (/data/plugins/user_interface/ledstatus/index.js:41:26) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Socket.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Socket.onevent (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/socket.js:270:10) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Socket.onpacket (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/socket.js:228:12) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Manager. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Manager.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Manager.ondecoded (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/manager.js:332:8) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Decoder. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Decoder.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Decoder.add (/data/plugins/user_interface/ledstatus/node_modules/socket.io-parser/index.js:246:12) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Manager.ondata (/data/plugins/user_interface/ledstatus/node_modules/socket.io-client/lib/manager.js:322:16) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Socket. (/data/plugins/user_interface/ledstatus/node_modules/component-bind/index.js:21:15) Oct 27 20:19:43 volumiorpi1 volumio[851]: at Socket.Emitter.emit (/data/plugins/user_interface/ledstatus/node_modules/component-emitter/index.js:133:20) Oct 27 20:19:43 volumiorpi1 volumio[851]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 20:19:44 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:44 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:44 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:44 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:45 volumiorpi1 volumio[6946]: /usr/lib/startconnect.sh: line 5: 6947 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:47 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:47 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:47 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:47 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:47 volumiorpi1 volumio[6950]: /usr/lib/startconnect.sh: line 5: 6951 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:49 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:49 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:49 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:49 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:50 volumiorpi1 volumio[6954]: /usr/lib/startconnect.sh: line 5: 6955 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:52 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:52 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:52 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:52 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:52 volumiorpi1 volumio[6957]: /usr/lib/startconnect.sh: line 5: 6958 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:55 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:55 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:55 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:55 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:55 volumiorpi1 volumio[6960]: /usr/lib/startconnect.sh: line 5: 6961 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:57 volumiorpi1 systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 27 20:19:57 volumiorpi1 systemd[1]: Stopping Volspotconnect2 Daemon... Oct 27 20:19:57 volumiorpi1 systemd[1]: Starting Volspotconnect2 Daemon... Oct 27 20:19:57 volumiorpi1 systemd[1]: Started Volspotconnect2 Daemon. Oct 27 20:19:58 volumiorpi1 sudo[6964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-27 20:18 Oct 27 20:19:58 volumiorpi1 volumio[6965]: /usr/lib/startconnect.sh: line 5: 6966 Illegal instruction .$SPOP_PLUGIN_DATA -c /tmp/volspotify.toml Oct 27 20:19:58 volumiorpi1 sudo[6964]: 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"