-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Fri 2024-10-04 08:27:04 EDT. -- Oct 04 08:26:00 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:00 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:00 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:00 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:00 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:01 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:01 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:01 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:02 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:02 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:02 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:02 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:02 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:03 volumio volumio[1147]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/789E-70CF Oct 04 08:26:03 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:03 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:03 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:03 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:03 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:04 volumio volumio[1147]: info: Scanning removed location : "USB/789E-70CF" Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: update Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: update Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: update Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 13 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 8 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 8 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 8 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 7 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 6 milliseconds Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: info: Command Router : Notfying DB Updatetrue Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: info: Command Router : Notfying DB Updatetrue Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::Close All Modals sent Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: info: Command Router : Notfying DB Updatetrue Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::Close All Modals sent Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: info: MPD Database updated - AlbumList cache refreshed Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: database Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: update Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 149 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 76 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 31 milliseconds Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 282ms Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 278ms Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 277ms Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:04 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:04 volumio volumio[1147]: info: MPD Database updated - AlbumList cache refreshed Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: database Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: update Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: MPD Database updated - AlbumList cache refreshed Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: database Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: Oct 04 08:26:04 volumio volumio[1147]: ---------------------------- MPD announces state update: update Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::getState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand status Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 78 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 76 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 75 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 18 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 18 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 17 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 16 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 15 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand status took 15 milliseconds Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: info: Command Router : Notfying DB Updatefalse Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::Close All Modals sent Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: info: Command Router : Notfying DB Updatefalse Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::Close All Modals sent Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: info: Command Router : Notfying DB Updatefalse Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::Close All Modals sent Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseState Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 113 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 114 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 62 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 61 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 16 milliseconds Oct 04 08:26:04 volumio volumio[1147]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: verbose: ControllerMpd::parseTrackInfo Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ControllerMpd::pushState Oct 04 08:26:04 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:26:04 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:04 volumio volumio[1147]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 299ms Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 298ms Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 237ms Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 237ms Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 234ms Oct 04 08:26:04 volumio volumio[1147]: info: ------------------------------ 233ms Oct 04 08:26:05 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:05 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:05 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:05 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:05 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:06 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:06 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:06 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:06 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:06 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:07 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:07 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:07 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:07 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:07 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:08 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:08 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:08 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:08 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:08 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:08 volumio volumio[3903]: libpng warning: iCCP: known incorrect sRGB profile Oct 04 08:26:08 volumio volumio[3903]: libpng warning: iCCP: known incorrect sRGB profile Oct 04 08:26:09 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:09 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:09 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:09 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:09 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:09 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:09 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:10 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:10 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:10 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:10 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:10 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:11 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:11 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:11 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:11 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:11 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:12 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:12 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:12 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:12 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:12 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:13 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:13 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:13 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:13 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:13 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:13 volumio volumio[1147]: error: [LastFM] plugin is not authenticated, please retry Oct 04 08:26:14 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:14 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:14 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:14 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:14 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:14 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:14 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:14 volumio kernel: spidev spi0.1: SPI transfer timed out Oct 04 08:26:14 volumio kernel: spi_master spi0: failed to transfer one message from queue Oct 04 08:26:14 volumio kernel: spi_master spi0: noqueue transfer failed Oct 04 08:26:19 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:19 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:19 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:19 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:19 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:19 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:19 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:19 volumio kernel: spidev spi0.1: SPI transfer timed out Oct 04 08:26:19 volumio kernel: spi_master spi0: failed to transfer one message from queue Oct 04 08:26:19 volumio kernel: spi_master spi0: noqueue transfer failed Oct 04 08:26:24 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:24 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:24 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:24 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:24 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:24 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:24 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:25 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:25 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:25 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:25 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:25 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:26 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:26 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:26 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:26 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:26 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:27 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:27 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:27 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:27 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:27 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:28 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:28 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:28 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:28 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:28 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:28 volumio volumio[3903]: libpng warning: iCCP: known incorrect sRGB profile Oct 04 08:26:29 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:29 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:29 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:29 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:29 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:29 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:29 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:29 volumio kernel: spidev spi0.1: SPI transfer timed out Oct 04 08:26:29 volumio kernel: spi_master spi0: failed to transfer one message from queue Oct 04 08:26:29 volumio kernel: spi_master spi0: noqueue transfer failed Oct 04 08:26:34 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:34 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:34 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:34 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:34 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:34 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:34 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:34 volumio kernel: spidev spi0.1: SPI transfer timed out Oct 04 08:26:34 volumio kernel: spi_master spi0: failed to transfer one message from queue Oct 04 08:26:34 volumio kernel: spi_master spi0: noqueue transfer failed Oct 04 08:26:39 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:39 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:39 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:39 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:39 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:39 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:39 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:40 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:40 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:40 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:40 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:40 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:41 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:41 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:41 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:41 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:41 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:42 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:42 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:42 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:42 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:42 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:43 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:43 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:43 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:43 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:43 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:44 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:44 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:44 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:44 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:44 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:44 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:44 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:44 volumio volumio[1352]: Exception in thread Thread-151: Oct 04 08:26:44 volumio volumio[1352]: Traceback (most recent call last): Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Oct 04 08:26:44 volumio volumio[1352]: self.run() Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 865, in run Oct 04 08:26:44 volumio volumio[1352]: self._target(*self._args, **self._kwargs) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Oct 04 08:26:44 volumio volumio[1352]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Oct 04 08:26:44 volumio volumio[1352]: r = self._trigger_event(data[0], namespace, *data[1:]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Oct 04 08:26:44 volumio volumio[1352]: return self.handlers[namespace][event](*args) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Oct 04 08:26:44 volumio volumio[1352]: sendtodisplay(IMAGE_DICT['IMG']) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Oct 04 08:26:44 volumio volumio[1352]: DISP.display(img4) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Oct 04 08:26:44 volumio volumio[1352]: self.data(pixelbytes[i:i + 4096]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Oct 04 08:26:44 volumio volumio[1352]: self.send(data, True) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Oct 04 08:26:44 volumio volumio[1352]: self._spi.xfer(data[start:end]) Oct 04 08:26:44 volumio volumio[1352]: TimeoutError: [Errno 110] Connection timed out Oct 04 08:26:44 volumio volumio[1352]: Exception in thread Thread-153: Oct 04 08:26:44 volumio volumio[1352]: Traceback (most recent call last): Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Oct 04 08:26:44 volumio volumio[1352]: self.run() Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 865, in run Oct 04 08:26:44 volumio volumio[1352]: self._target(*self._args, **self._kwargs) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Oct 04 08:26:44 volumio volumio[1352]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Oct 04 08:26:44 volumio volumio[1352]: r = self._trigger_event(data[0], namespace, *data[1:]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Oct 04 08:26:44 volumio volumio[1352]: return self.handlers[namespace][event](*args) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Oct 04 08:26:44 volumio volumio[1352]: sendtodisplay(IMAGE_DICT['IMG']) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Oct 04 08:26:44 volumio volumio[1352]: DISP.display(img4) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Oct 04 08:26:44 volumio volumio[1352]: self.data(pixelbytes[i:i + 4096]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Oct 04 08:26:44 volumio volumio[1352]: self.send(data, True) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Oct 04 08:26:44 volumio volumio[1352]: self._spi.xfer(data[start:end]) Oct 04 08:26:44 volumio volumio[1352]: TimeoutError: [Errno 110] Connection timed out Oct 04 08:26:44 volumio volumio[1352]: Exception in thread Thread-172: Oct 04 08:26:44 volumio volumio[1352]: Traceback (most recent call last): Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Oct 04 08:26:44 volumio volumio[1352]: self.run() Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 865, in run Oct 04 08:26:44 volumio volumio[1352]: self._target(*self._args, **self._kwargs) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Oct 04 08:26:44 volumio volumio[1352]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Oct 04 08:26:44 volumio volumio[1352]: r = self._trigger_event(data[0], namespace, *data[1:]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Oct 04 08:26:44 volumio volumio[1352]: return self.handlers[namespace][event](*args) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Oct 04 08:26:44 volumio volumio[1352]: sendtodisplay(IMAGE_DICT['IMG']) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Oct 04 08:26:44 volumio volumio[1352]: DISP.display(img4) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Oct 04 08:26:44 volumio volumio[1352]: self.data(pixelbytes[i:i + 4096]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Oct 04 08:26:44 volumio volumio[1352]: self.send(data, True) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Oct 04 08:26:44 volumio volumio[1352]: self._spi.xfer(data[start:end]) Oct 04 08:26:44 volumio volumio[1352]: TimeoutError: [Errno 110] Connection timed out Oct 04 08:26:44 volumio volumio[1352]: Exception in thread Thread-174: Oct 04 08:26:44 volumio volumio[1352]: Traceback (most recent call last): Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Oct 04 08:26:44 volumio volumio[1352]: self.run() Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 865, in run Oct 04 08:26:44 volumio volumio[1352]: self._target(*self._args, **self._kwargs) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Oct 04 08:26:44 volumio volumio[1352]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Oct 04 08:26:44 volumio volumio[1352]: r = self._trigger_event(data[0], namespace, *data[1:]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Oct 04 08:26:44 volumio volumio[1352]: return self.handlers[namespace][event](*args) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Oct 04 08:26:44 volumio volumio[1352]: sendtodisplay(IMAGE_DICT['IMG']) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Oct 04 08:26:44 volumio volumio[1352]: DISP.display(img4) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Oct 04 08:26:44 volumio volumio[1352]: self.data(pixelbytes[i:i + 4096]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Oct 04 08:26:44 volumio volumio[1352]: self.send(data, True) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Oct 04 08:26:44 volumio volumio[1352]: self._spi.xfer(data[start:end]) Oct 04 08:26:44 volumio volumio[1352]: TimeoutError: [Errno 110] Connection timed out Oct 04 08:26:44 volumio volumio[1352]: Exception in thread Thread-178: Oct 04 08:26:44 volumio volumio[1352]: Traceback (most recent call last): Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Oct 04 08:26:44 volumio volumio[1352]: self.run() Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 865, in run Oct 04 08:26:44 volumio volumio[1352]: self._target(*self._args, **self._kwargs) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Oct 04 08:26:44 volumio volumio[1352]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Oct 04 08:26:44 volumio volumio[1352]: r = self._trigger_event(data[0], namespace, *data[1:]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Oct 04 08:26:44 volumio volumio[1352]: return self.handlers[namespace][event](*args) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Oct 04 08:26:44 volumio volumio[1352]: sendtodisplay(IMAGE_DICT['IMG']) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Oct 04 08:26:44 volumio volumio[1352]: DISP.display(img4) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Oct 04 08:26:44 volumio volumio[1352]: self.data(pixelbytes[i:i + 4096]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Oct 04 08:26:44 volumio volumio[1352]: self.send(data, True) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Oct 04 08:26:44 volumio volumio[1352]: self._spi.xfer(data[start:end]) Oct 04 08:26:44 volumio volumio[1352]: TimeoutError: [Errno 110] Connection timed out Oct 04 08:26:44 volumio volumio[1352]: Exception in thread Thread-180: Oct 04 08:26:44 volumio volumio[1352]: Traceback (most recent call last): Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Oct 04 08:26:44 volumio volumio[1352]: self.run() Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 865, in run Oct 04 08:26:44 volumio volumio[1352]: self._target(*self._args, **self._kwargs) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Oct 04 08:26:44 volumio volumio[1352]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Oct 04 08:26:44 volumio volumio[1352]: r = self._trigger_event(data[0], namespace, *data[1:]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Oct 04 08:26:44 volumio volumio[1352]: return self.handlers[namespace][event](*args) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Oct 04 08:26:44 volumio volumio[1352]: sendtodisplay(IMAGE_DICT['IMG']) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Oct 04 08:26:44 volumio volumio[1352]: DISP.display(img4) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Oct 04 08:26:44 volumio volumio[1352]: self.data(pixelbytes[i:i + 4096]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Oct 04 08:26:44 volumio volumio[1352]: self.send(data, True) Oct 04 08:26:44 volumio kernel: spidev spi0.1: SPI transfer timed out Oct 04 08:26:44 volumio kernel: spi_master spi0: failed to transfer one message from queue Oct 04 08:26:44 volumio kernel: spi_master spi0: noqueue transfer failed Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Oct 04 08:26:44 volumio volumio[1352]: self._spi.xfer(data[start:end]) Oct 04 08:26:44 volumio volumio[1352]: TimeoutError: [Errno 110] Connection timed out Oct 04 08:26:44 volumio volumio[1352]: Exception in thread Thread-184: Oct 04 08:26:44 volumio volumio[1352]: Traceback (most recent call last): Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Oct 04 08:26:44 volumio volumio[1352]: self.run() Oct 04 08:26:44 volumio volumio[1352]: File "/usr/lib/python3.7/threading.py", line 865, in run Oct 04 08:26:44 volumio volumio[1352]: self._target(*self._args, **self._kwargs) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Oct 04 08:26:44 volumio volumio[1352]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Oct 04 08:26:44 volumio volumio[1352]: r = self._trigger_event(data[0], namespace, *data[1:]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Oct 04 08:26:44 volumio volumio[1352]: return self.handlers[namespace][event](*args) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Oct 04 08:26:44 volumio volumio[1352]: sendtodisplay(IMAGE_DICT['IMG']) Oct 04 08:26:44 volumio volumio[1352]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Oct 04 08:26:44 volumio volumio[1352]: DISP.display(img4) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Oct 04 08:26:44 volumio volumio[1352]: self.data(pixelbytes[i:i + 4096]) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Oct 04 08:26:44 volumio volumio[1352]: self.send(data, True) Oct 04 08:26:44 volumio volumio[1352]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Oct 04 08:26:44 volumio volumio[1352]: self._spi.xfer(data[start:end]) Oct 04 08:26:44 volumio volumio[1352]: TimeoutError: [Errno 110] Connection timed out Oct 04 08:26:49 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:49 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:49 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:49 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:49 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:49 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:49 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:49 volumio kernel: spidev spi0.1: SPI transfer timed out Oct 04 08:26:49 volumio kernel: spi_master spi0: failed to transfer one message from queue Oct 04 08:26:49 volumio kernel: spi_master spi0: noqueue transfer failed Oct 04 08:26:50 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:50 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:50 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:50 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:50 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:51 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:51 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:51 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:51 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:51 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:52 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:52 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:52 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:52 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:52 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:53 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:53 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:53 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:53 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:53 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:54 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:54 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:54 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:54 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:54 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:54 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:54 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:54 volumio kernel: spidev spi0.1: SPI transfer timed out Oct 04 08:26:54 volumio kernel: spi_master spi0: failed to transfer one message from queue Oct 04 08:26:54 volumio kernel: spi_master spi0: noqueue transfer failed Oct 04 08:26:59 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:59 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:59 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:26:59 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:26:59 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:26:59 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:26:59 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:26:59 volumio kernel: spidev spi0.1: SPI transfer timed out Oct 04 08:26:59 volumio kernel: spi_master spi0: failed to transfer one message from queue Oct 04 08:26:59 volumio kernel: spi_master spi0: noqueue transfer failed Oct 04 08:27:00 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:27:00 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:27:00 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:27:00 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:27:00 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:27:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:27:01 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:27:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:27:01 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:27:01 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:27:02 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:27:02 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:27:02 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:27:02 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:27:02 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:27:03 volumio volumio[1147]: info: [1728044823037] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Oct 04 08:27:03 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 04 08:27:03 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:27:03 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 04 08:27:03 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 04 08:27:03 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 04 08:27:03 volumio volumio[1147]: info: [1728044823571] [RadioParadise] received new metadata: {"time":30,"artist":"","title":null,"album":null,"year":null,"cover":"https://img.radioparadise.com/covers/l/.jpg","cover_med":"https://img.radioparadise.com/covers/m/.jpg","cover_small":"https://img.radioparadise.com/covers/s/.jpg"} Oct 04 08:27:03 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:27:03 volumio volumio[1147]: info: CoreCommandRouter::servicePushState Oct 04 08:27:03 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:27:03 volumio volumio[1147]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/.jpg","uri":"https://stream.radioparadise.com/flac","name":null,"title":null,"artist":"","album":null,"streaming":true,"disableUiControls":true,"duration":35,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 04 08:27:03 volumio volumio[1147]: verbose: CURRENT POSITION 0 Oct 04 08:27:03 volumio volumio[1147]: info: CoreStateMachine::syncState stateService play Oct 04 08:27:03 volumio volumio[1147]: info: CoreStateMachine::syncState currentStatus play Oct 04 08:27:03 volumio volumio[1147]: info: Received an update from plugin. extracting info from payload Oct 04 08:27:03 volumio volumio[1147]: info: CoreStateMachine::pushState Oct 04 08:27:03 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:27:03 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 04 08:27:03 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Oct 04 08:27:03 volumio volumio[1147]: info: CoreStateMachine::pushState Oct 04 08:27:03 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 04 08:27:03 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Oct 04 08:27:03 volumio volumio[1147]: info: [1728044823585] [RadioParadise] setting new timer with duration of 35000 seconds. Oct 04 08:27:03 volumio volumio[1147]: info: [LastFM] Current track does not have sufficient metadata: Missing artist. Not a composite title! Oct 04 08:27:03 volumio volumio[1147]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 04 08:27:03 volumio volumio[1147]: TypeError: Cannot read property 'indexOf' of null Oct 04 08:27:03 volumio volumio[1147]: at ControllerLastFM.formatScrobbleData (/data/plugins/user_interface/lastfm/index.js:873:25) Oct 04 08:27:03 volumio volumio[1147]: at ControllerLastFM.checkStateUpdate (/data/plugins/user_interface/lastfm/index.js:825:26) Oct 04 08:27:03 volumio volumio[1147]: at Socket. (/data/plugins/user_interface/lastfm/index.js:110:52) Oct 04 08:27:03 volumio volumio[1147]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 04 08:27:03 volumio volumio[1147]: at Socket.onevent (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:270:10) Oct 04 08:27:03 volumio volumio[1147]: at Socket.onpacket (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/socket.js:228:12) Oct 04 08:27:03 volumio volumio[1147]: at Manager. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 04 08:27:03 volumio volumio[1147]: at Manager.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 04 08:27:03 volumio volumio[1147]: at Manager.ondecoded (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:332:8) Oct 04 08:27:03 volumio volumio[1147]: at Decoder. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 04 08:27:03 volumio volumio[1147]: at Decoder.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/node_modules/component-emitter/index.js:134:20) Oct 04 08:27:03 volumio volumio[1147]: at Decoder.add (/data/plugins/user_interface/lastfm/node_modules/socket.io-parser/index.js:246:12) Oct 04 08:27:03 volumio volumio[1147]: at Manager.ondata (/data/plugins/user_interface/lastfm/node_modules/socket.io-client/lib/manager.js:322:16) Oct 04 08:27:03 volumio volumio[1147]: at Socket. (/data/plugins/user_interface/lastfm/node_modules/component-bind/index.js:21:15) Oct 04 08:27:03 volumio volumio[1147]: at Socket.Emitter.emit (/data/plugins/user_interface/lastfm/node_modules/component-emitter/index.js:133:20) Oct 04 08:27:03 volumio volumio[1147]: at Socket.onPacket (/data/plugins/user_interface/lastfm/node_modules/engine.io-client/lib/socket.js:451:14) Oct 04 08:27:03 volumio volumio[1147]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 04 08:27:04 volumio sudo[4246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-04 08:26 Oct 04 08:27:04 volumio sudo[4246]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"