-- Logs begin at Sun 2024-07-21 11:27:33 CEST, end at Thu 2024-11-21 16:08:32 CET. -- Nov 21 16:07:04 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:04 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:04 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:04 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:04 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:04 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:04 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:04 volumio kernel: spidev spi0.1: SPI transfer timed out Nov 21 16:07:04 volumio kernel: spi_master spi0: failed to transfer one message from queue Nov 21 16:07:04 volumio kernel: spi_master spi0: noqueue transfer failed Nov 21 16:07:09 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:09 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:09 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:09 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:09 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:09 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:09 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:10 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:10 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:10 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:10 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:10 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:11 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:11 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:11 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:11 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:11 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:12 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:12 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:12 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:12 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:12 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:13 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:13 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:13 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:13 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:13 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:14 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:14 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:14 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:14 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:14 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:14 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:14 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:14 volumio kernel: spidev spi0.1: SPI transfer timed out Nov 21 16:07:14 volumio kernel: spi_master spi0: failed to transfer one message from queue Nov 21 16:07:14 volumio kernel: spi_master spi0: noqueue transfer failed Nov 21 16:07:17 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Nov 21 16:07:17 volumio volumio[1119]: info: [1732201637019] [80s80s] handleBrowseUri curUri: 80s80s Nov 21 16:07:17 volumio volumio[1119]: info: Preload queue cleared Nov 21 16:07:18 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Nov 21 16:07:18 volumio volumio[1119]: info: [1732201638779] [80s80s] handleBrowseUri curUri: 80s80s/eighties Nov 21 16:07:18 volumio volumio[1119]: info: [1732201638779] [80s80s] getRadioContent url: eighties Nov 21 16:07:18 volumio volumio[1119]: info: Preload queue cleared Nov 21 16:07:19 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:19 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:19 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:19 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:19 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:19 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:19 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:19 volumio kernel: spidev spi0.1: SPI transfer timed out Nov 21 16:07:19 volumio kernel: spi_master spi0: failed to transfer one message from queue Nov 21 16:07:19 volumio kernel: spi_master spi0: noqueue transfer failed Nov 21 16:07:20 volumio volumio[1119]: info: Preload queue cleared Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::ClearQueue Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::stop Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::stPlaybackTimer Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::serviceStop Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::serviceStop Nov 21 16:07:20 volumio volumio[1119]: info: ControllerMpd::stop Nov 21 16:07:20 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::clearPlayQueue Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::saveQueue Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::volumioPushQueue Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::addQueueItems Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::addQueueItems Nov 21 16:07:20 volumio volumio[1119]: info: Preload queue cleared Nov 21 16:07:20 volumio volumio[1119]: info: Adding Item to queue: webeighties/3 Nov 21 16:07:20 volumio volumio[1119]: info: Exploding uri webeighties/3 in service 80s80s Nov 21 16:07:20 volumio volumio[1119]: info: [1732201640504] [80s80s] explodeUri: webeighties/3 Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::volumioPushQueue Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::saveQueue Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::volumioPlay Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::play index 0 Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::stop Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::play index undefined Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::startPlaybackTimer Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:20 volumio volumio[1119]: info: [1732201640528] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio Nov 21 16:07:20 volumio volumio[1119]: info: [1732201640529] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 Nov 21 16:07:20 volumio volumio[1119]: info: [GPIO_Control] Status changed: stop Nov 21 16:07:20 volumio volumio[1119]: info: [GPIO_Control] Handling event: musicStop Nov 21 16:07:20 volumio volumio[1119]: info: sendMpdCommand stop took 64 milliseconds Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:20 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:20 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:20 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:20 volumio volumio[1119]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received radio_paradise Nov 21 16:07:20 volumio volumio[1119]: info: [GPIO_Control] Status changed: stop Nov 21 16:07:20 volumio volumio[1119]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 21 16:07:20 volumio volumio[1516]: Exception in thread Thread-50: Nov 21 16:07:20 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:20 volumio volumio[1516]: self.run() Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:20 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:20 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:20 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:20 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Nov 21 16:07:20 volumio volumio[1516]: sendtodisplay(IMAGE_DICT['IMG']) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Nov 21 16:07:20 volumio volumio[1516]: DISP.display(img4) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Nov 21 16:07:20 volumio volumio[1516]: self.data(pixelbytes[i:i + 4096]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Nov 21 16:07:20 volumio volumio[1516]: self.send(data, True) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Nov 21 16:07:20 volumio volumio[1516]: self._spi.xfer(data[start:end]) Nov 21 16:07:20 volumio volumio[1516]: TimeoutError: [Errno 110] Connection timed out Nov 21 16:07:20 volumio volumio[1516]: Exception in thread Thread-52: Nov 21 16:07:20 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:20 volumio volumio[1516]: self.run() Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:20 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:20 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:20 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:20 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Nov 21 16:07:20 volumio volumio[1516]: sendtodisplay(IMAGE_DICT['IMG']) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Nov 21 16:07:20 volumio volumio[1516]: DISP.display(img4) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Nov 21 16:07:20 volumio volumio[1516]: self.data(pixelbytes[i:i + 4096]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Nov 21 16:07:20 volumio volumio[1516]: self.send(data, True) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Nov 21 16:07:20 volumio volumio[1516]: self._spi.xfer(data[start:end]) Nov 21 16:07:20 volumio volumio[1516]: TimeoutError: [Errno 110] Connection timed out Nov 21 16:07:20 volumio volumio[1516]: Exception in thread Thread-56: Nov 21 16:07:20 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:20 volumio volumio[1516]: self.run() Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:20 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:20 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:20 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:20 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Nov 21 16:07:20 volumio volumio[1516]: sendtodisplay(IMAGE_DICT['IMG']) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Nov 21 16:07:20 volumio volumio[1516]: DISP.display(img4) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Nov 21 16:07:20 volumio volumio[1516]: self.data(pixelbytes[i:i + 4096]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Nov 21 16:07:20 volumio volumio[1516]: self.send(data, True) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Nov 21 16:07:20 volumio volumio[1516]: self._spi.xfer(data[start:end]) Nov 21 16:07:20 volumio volumio[1516]: TimeoutError: [Errno 110] Connection timed out Nov 21 16:07:20 volumio volumio[1516]: Exception in thread Thread-60: Nov 21 16:07:20 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:20 volumio volumio[1516]: self.run() Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:20 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:20 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:20 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:20 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Nov 21 16:07:20 volumio volumio[1516]: sendtodisplay(IMAGE_DICT['IMG']) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Nov 21 16:07:20 volumio volumio[1516]: DISP.display(img4) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Nov 21 16:07:20 volumio volumio[1516]: self.data(pixelbytes[i:i + 4096]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Nov 21 16:07:20 volumio volumio[1516]: self.send(data, True) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Nov 21 16:07:20 volumio volumio[1516]: self._spi.xfer(data[start:end]) Nov 21 16:07:20 volumio volumio[1516]: TimeoutError: [Errno 110] Connection timed out Nov 21 16:07:20 volumio volumio[1516]: Exception in thread Thread-64: Nov 21 16:07:20 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:20 volumio volumio[1516]: self.run() Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:20 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:20 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:20 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:20 volumio kernel: spidev spi0.1: SPI transfer timed out Nov 21 16:07:20 volumio kernel: spi_master spi0: failed to transfer one message from queue Nov 21 16:07:20 volumio kernel: spi_master spi0: noqueue transfer failed Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:20 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Nov 21 16:07:20 volumio volumio[1516]: sendtodisplay(IMAGE_DICT['IMG']) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Nov 21 16:07:20 volumio volumio[1516]: DISP.display(img4) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Nov 21 16:07:20 volumio volumio[1516]: self.data(pixelbytes[i:i + 4096]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Nov 21 16:07:20 volumio volumio[1516]: self.send(data, True) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Nov 21 16:07:20 volumio volumio[1516]: self._spi.xfer(data[start:end]) Nov 21 16:07:20 volumio volumio[1516]: TimeoutError: [Errno 110] Connection timed out Nov 21 16:07:20 volumio volumio[1516]: Exception in thread Thread-66: Nov 21 16:07:20 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:20 volumio volumio[1516]: self.run() Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:20 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:20 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:20 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:20 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Nov 21 16:07:20 volumio volumio[1516]: sendtodisplay(IMAGE_DICT['IMG']) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Nov 21 16:07:20 volumio volumio[1516]: DISP.display(img4) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Nov 21 16:07:20 volumio volumio[1516]: self.data(pixelbytes[i:i + 4096]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Nov 21 16:07:20 volumio volumio[1516]: self.send(data, True) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Nov 21 16:07:20 volumio volumio[1516]: self._spi.xfer(data[start:end]) Nov 21 16:07:20 volumio volumio[1516]: TimeoutError: [Errno 110] Connection timed out Nov 21 16:07:20 volumio volumio[1516]: Exception in thread Thread-68: Nov 21 16:07:20 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:20 volumio volumio[1516]: self.run() Nov 21 16:07:20 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:20 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:20 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:20 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:20 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 514, in on_push_state Nov 21 16:07:20 volumio volumio[1516]: sendtodisplay(IMAGE_DICT['IMG']) Nov 21 16:07:20 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 212, in sendtodisplay Nov 21 16:07:20 volumio volumio[1516]: DISP.display(img4) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Nov 21 16:07:20 volumio volumio[1516]: self.data(pixelbytes[i:i + 4096]) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Nov 21 16:07:20 volumio volumio[1516]: self.send(data, True) Nov 21 16:07:20 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Nov 21 16:07:20 volumio volumio[1516]: self._spi.xfer(data[start:end]) Nov 21 16:07:20 volumio volumio[1516]: TimeoutError: [Errno 110] Connection timed out Nov 21 16:07:20 volumio volumio[1119]: info: [1732201640991] [80s80s] received new event containing 2 songs. Nov 21 16:07:20 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 16:07:20 volumio volumio[1119]: info: sendMpdCommand stop took 2 milliseconds Nov 21 16:07:20 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand clear Nov 21 16:07:20 volumio volumio[1119]: info: Nov 21 16:07:20 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Nov 21 16:07:20 volumio volumio[1119]: info: Ignoring MPD Status Update Nov 21 16:07:20 volumio volumio[1119]: info: sendMpdCommand clear took 2 milliseconds Nov 21 16:07:20 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand consume 1 Nov 21 16:07:20 volumio volumio[1119]: error: updateQueue error: null Nov 21 16:07:20 volumio volumio[1119]: info: Nov 21 16:07:20 volumio volumio[1119]: ---------------------------- MPD announces state update: options Nov 21 16:07:20 volumio volumio[1119]: info: ------------------------------ 2ms Nov 21 16:07:21 volumio volumio[1119]: info: sendMpdCommand consume 1 took 2 milliseconds Nov 21 16:07:21 volumio volumio[1119]: info: ControllerMpd::getState Nov 21 16:07:21 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:07:21 volumio volumio[1119]: info: [1732201641000] [80s80s] adding url: http://streams.80s80s.de/party/mp3-192/volumio Nov 21 16:07:21 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" Nov 21 16:07:21 volumio volumio[1119]: info: Nov 21 16:07:21 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Nov 21 16:07:21 volumio volumio[1119]: info: Ignoring MPD Status Update Nov 21 16:07:21 volumio volumio[1119]: info: sendMpdCommand status took 2 milliseconds Nov 21 16:07:21 volumio volumio[1119]: info: sendMpdCommand add "http://streams.80s80s.de/party/mp3-192/volumio" took 2 milliseconds Nov 21 16:07:21 volumio volumio[1119]: verbose: ControllerMpd::parseState Nov 21 16:07:21 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand play Nov 21 16:07:21 volumio volumio[1119]: info: ControllerMpd::pushState Nov 21 16:07:21 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:21 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:21 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:21 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:21 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:21 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:21 volumio volumio[1119]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Nov 21 16:07:21 volumio volumio[1119]: info: ------------------------------ 25ms Nov 21 16:07:21 volumio volumio[1119]: info: ------------------------------ 27ms Nov 21 16:07:21 volumio volumio[1119]: info: sendMpdCommand play took 21 milliseconds Nov 21 16:07:21 volumio volumio[1119]: info: [1732201641029] [80s80s] Pushing the next song state: Sydney Youngblood - Sit and Wait Nov 21 16:07:21 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:21 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:21 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:21 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/5f/19/4e/5f194e03-80a6-bc9d-27a7-cb475c0b742c/source/600x600bb.jpg","name":"Sydney Youngblood - Sit and Wait","title":"Sit and Wait","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"223","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 21 16:07:21 volumio volumio[1119]: verbose: CURRENT POSITION 0 Nov 21 16:07:21 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Nov 21 16:07:21 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus stop Nov 21 16:07:21 volumio volumio[1119]: info: [1732201641042] [80s80s] PlayNextTrack API delay: 30 Nov 21 16:07:21 volumio volumio[1119]: info: [1732201641058] [80s80s] Setting timer to: 223000 milliseconds. Nov 21 16:07:21 volumio volumio[1119]: info: [GPIO_Control] Status changed: stop Nov 21 16:07:21 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:21 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Nov 21 16:07:23 volumio volumio[1119]: info: Nov 21 16:07:23 volumio volumio[1119]: ---------------------------- MPD announces state update: player Nov 21 16:07:23 volumio volumio[1119]: info: ControllerMpd::getState Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:07:23 volumio volumio[1119]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 21 16:07:23 volumio volumio[1119]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 21 16:07:23 volumio volumio[1119]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 16:07:23 volumio volumio[1119]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 21 16:07:23 volumio volumio[1119]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 21 16:07:23 volumio volumio[1119]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 21 16:07:23 volumio volumio[1119]: info: Nov 21 16:07:23 volumio volumio[1119]: ---------------------------- MPD announces state update: player Nov 21 16:07:23 volumio volumio[1119]: info: sendMpdCommand status took 28 milliseconds Nov 21 16:07:23 volumio volumio[1119]: info: ControllerMpd::getState Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::parseState Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:07:23 volumio volumio[1119]: info: Nov 21 16:07:23 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Nov 21 16:07:23 volumio volumio[1119]: info: Ignoring MPD Status Update Nov 21 16:07:23 volumio volumio[1119]: info: Nov 21 16:07:23 volumio volumio[1119]: ---------------------------- MPD announces state update: player Nov 21 16:07:23 volumio volumio[1119]: info: Nov 21 16:07:23 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Nov 21 16:07:23 volumio volumio[1119]: info: Ignoring MPD Status Update Nov 21 16:07:23 volumio volumio[1119]: info: Nov 21 16:07:23 volumio volumio[1119]: ---------------------------- MPD announces state update: player Nov 21 16:07:23 volumio volumio[1119]: info: ControllerMpd::getState Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:07:23 volumio volumio[1119]: info: sendMpdCommand status took 13 milliseconds Nov 21 16:07:23 volumio volumio[1119]: info: ControllerMpd::getState Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:07:23 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::parseState Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:07:23 volumio volumio[1119]: info: ControllerMpd::pushState Nov 21 16:07:23 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:23 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:23 volumio volumio[1119]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Nov 21 16:07:23 volumio volumio[1119]: info: ------------------------------ 47ms Nov 21 16:07:23 volumio volumio[1119]: info: ------------------------------ 12ms Nov 21 16:07:23 volumio volumio[1119]: info: sendMpdCommand status took 6 milliseconds Nov 21 16:07:23 volumio volumio[1119]: info: ------------------------------ 7ms Nov 21 16:07:23 volumio volumio[1119]: info: sendMpdCommand status took 5 milliseconds Nov 21 16:07:23 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::parseState Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::parseState Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:07:23 volumio volumio[1119]: info: ControllerMpd::pushState Nov 21 16:07:23 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:23 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:23 volumio volumio[1119]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Nov 21 16:07:23 volumio volumio[1119]: info: ------------------------------ 30ms Nov 21 16:07:23 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 21 16:07:23 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:07:23 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:07:23 volumio volumio[1119]: info: ControllerMpd::pushState Nov 21 16:07:23 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:23 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:23 volumio volumio[1119]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Nov 21 16:07:23 volumio volumio[1119]: info: ControllerMpd::pushState Nov 21 16:07:23 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:23 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:23 volumio volumio[1119]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Nov 21 16:07:23 volumio volumio[1119]: info: ------------------------------ 23ms Nov 21 16:07:23 volumio volumio[1119]: info: ------------------------------ 23ms Nov 21 16:07:23 volumio volumio[1119]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 21 16:07:23 volumio volumio[1119]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 21 16:07:24 volumio volumio[1119]: info: Nov 21 16:07:24 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Nov 21 16:07:24 volumio volumio[1119]: info: Ignoring MPD Status Update Nov 21 16:07:24 volumio volumio[1119]: info: Nov 21 16:07:24 volumio volumio[1119]: ---------------------------- MPD announces state update: player Nov 21 16:07:24 volumio volumio[1119]: info: ControllerMpd::getState Nov 21 16:07:24 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:07:24 volumio volumio[1119]: info: ------------------------------ 7ms Nov 21 16:07:24 volumio volumio[1119]: info: sendMpdCommand status took 6 milliseconds Nov 21 16:07:24 volumio volumio[1119]: verbose: ControllerMpd::parseState Nov 21 16:07:24 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:07:24 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 21 16:07:24 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:07:24 volumio volumio[1119]: info: ControllerMpd::pushState Nov 21 16:07:24 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:24 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:24 volumio volumio[1119]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Nov 21 16:07:24 volumio volumio[1119]: info: ------------------------------ 9ms Nov 21 16:07:33 volumio volumio[1119]: info: CoreCommandRouter::volumioSeek Nov 21 16:07:33 volumio volumio[1119]: info: CoreStateMachine::seek Nov 21 16:07:33 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:33 volumio volumio[1119]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/5f/19/4e/5f194e03-80a6-bc9d-27a7-cb475c0b742c/source/600x600bb.jpg","uri":"http://streams.80s80s.de/party/mp3-192/volumio","name":"Sydney Youngblood - Sit and Wait","duration":"223","artist":"80s80s Party","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 21 16:07:33 volumio volumio[1119]: info: CoreStateMachine::startPlaybackTimer Nov 21 16:07:33 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:33 volumio volumio[1119]: info: [1732201653913] [80s80s] seek to 20000 Nov 21 16:07:33 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:33 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:33 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:33 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:33 volumio volumio[1119]: info: [GPIO_Control] Status changed: play Nov 21 16:07:33 volumio volumio[1119]: info: [GPIO_Control] Handling event: musicPlay Nov 21 16:07:33 volumio volumio[1119]: info: [LastFM] Current track has sufficient metadata: title (Sydney Youngblood - Sit and Wait) and artist (80s80s Party) passed on explicitly Nov 21 16:07:33 volumio volumio[1119]: error: [LastFM] plugin is not authenticated, please retry, or track info could not be determined (very rare) Nov 21 16:07:34 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:34 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:34 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:34 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:34 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:34 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:34 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:34 volumio volumio[1119]: info: CoreCommandRouter::volumioSeek Nov 21 16:07:34 volumio volumio[1119]: info: CoreStateMachine::seek Nov 21 16:07:34 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:34 volumio volumio[1119]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/5f/19/4e/5f194e03-80a6-bc9d-27a7-cb475c0b742c/source/600x600bb.jpg","uri":"http://streams.80s80s.de/party/mp3-192/volumio","name":"Sydney Youngblood - Sit and Wait","duration":"223","artist":"80s80s Party","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 21 16:07:34 volumio volumio[1119]: info: CoreStateMachine::startPlaybackTimer Nov 21 16:07:34 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:34 volumio volumio[1119]: info: [1732201654909] [80s80s] seek to 21000 Nov 21 16:07:34 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:34 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:34 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:34 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:34 volumio volumio[1119]: info: [GPIO_Control] Status changed: play Nov 21 16:07:35 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:35 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:35 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:35 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:35 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:36 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:36 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:36 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:36 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:36 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:37 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:37 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:37 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:37 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:37 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:38 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:38 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:38 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:38 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:38 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:39 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:39 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:39 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:39 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:39 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:39 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:39 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:39 volumio volumio[1119]: info: CoreCommandRouter::volumioSeek Nov 21 16:07:39 volumio volumio[1119]: info: CoreStateMachine::seek Nov 21 16:07:39 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:39 volumio volumio[1119]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/5f/19/4e/5f194e03-80a6-bc9d-27a7-cb475c0b742c/source/600x600bb.jpg","uri":"http://streams.80s80s.de/party/mp3-192/volumio","name":"Sydney Youngblood - Sit and Wait","duration":"223","artist":"80s80s Party","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 21 16:07:39 volumio volumio[1119]: info: CoreStateMachine::startPlaybackTimer Nov 21 16:07:39 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:39 volumio volumio[1119]: info: [1732201659905] [80s80s] seek to 216000 Nov 21 16:07:39 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:39 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:39 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:39 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:39 volumio volumio[1119]: info: [GPIO_Control] Status changed: play Nov 21 16:07:40 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:40 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:40 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:40 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:40 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:40 volumio volumio[1119]: info: CoreCommandRouter::volumioSeek Nov 21 16:07:40 volumio volumio[1119]: info: CoreStateMachine::seek Nov 21 16:07:40 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:40 volumio volumio[1119]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/5f/19/4e/5f194e03-80a6-bc9d-27a7-cb475c0b742c/source/600x600bb.jpg","uri":"http://streams.80s80s.de/party/mp3-192/volumio","name":"Sydney Youngblood - Sit and Wait","duration":"223","artist":"80s80s Party","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 21 16:07:40 volumio volumio[1119]: info: CoreStateMachine::startPlaybackTimer Nov 21 16:07:40 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:40 volumio volumio[1119]: info: [1732201660994] [80s80s] seek to 5000 Nov 21 16:07:40 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:40 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:40 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:40 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:41 volumio volumio[1119]: info: [GPIO_Control] Status changed: play Nov 21 16:07:41 volumio volumio[1119]: info: CoreCommandRouter::volumioSeek Nov 21 16:07:41 volumio volumio[1119]: info: CoreStateMachine::seek Nov 21 16:07:41 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:41 volumio volumio[1119]: info: TRACKBLOCK {"service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"eighties","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/5f/19/4e/5f194e03-80a6-bc9d-27a7-cb475c0b742c/source/600x600bb.jpg","uri":"http://streams.80s80s.de/party/mp3-192/volumio","name":"Sydney Youngblood - Sit and Wait","duration":"223","artist":"80s80s Party","album":"","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 21 16:07:41 volumio volumio[1119]: info: CoreStateMachine::startPlaybackTimer Nov 21 16:07:41 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:41 volumio volumio[1119]: info: [1732201661795] [80s80s] seek to 223000 Nov 21 16:07:41 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:41 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:41 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:41 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:41 volumio volumio[1119]: info: [GPIO_Control] Status changed: play Nov 21 16:07:41 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:41 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:41 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:41 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:41 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:42 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:42 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:42 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:42 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:42 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:43 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:43 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:43 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:43 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:43 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:44 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:44 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:44 volumio volumio[1516]: Exception in thread Thread-78: Nov 21 16:07:44 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:44 volumio volumio[1516]: self.run() Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:44 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:44 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:44 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:44 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 509, in on_push_state Nov 21 16:07:44 volumio volumio[1516]: f_timebar(args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 485, in f_timebar Nov 21 16:07:44 volumio volumio[1516]: hour = strftime("%-H", gmtime(VOLUMIO_DICT['DURATION'] - int(float(VOLUMIO_DICT['SEEK'])/1000))) Nov 21 16:07:44 volumio volumio[1516]: TypeError: unsupported operand type(s) for -: 'str' and 'int' Nov 21 16:07:44 volumio volumio[1516]: Exception in thread Thread-80: Nov 21 16:07:44 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:44 volumio volumio[1516]: self.run() Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:44 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:44 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:44 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:44 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 509, in on_push_state Nov 21 16:07:44 volumio volumio[1516]: f_timebar(args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 485, in f_timebar Nov 21 16:07:44 volumio volumio[1516]: hour = strftime("%-H", gmtime(VOLUMIO_DICT['DURATION'] - int(float(VOLUMIO_DICT['SEEK'])/1000))) Nov 21 16:07:44 volumio volumio[1516]: TypeError: unsupported operand type(s) for -: 'str' and 'int' Nov 21 16:07:44 volumio volumio[1516]: Exception in thread Thread-82: Nov 21 16:07:44 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:44 volumio volumio[1516]: self.run() Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:44 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:44 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:44 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:44 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 509, in on_push_state Nov 21 16:07:44 volumio volumio[1516]: f_timebar(args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 485, in f_timebar Nov 21 16:07:44 volumio volumio[1516]: hour = strftime("%-H", gmtime(VOLUMIO_DICT['DURATION'] - int(float(VOLUMIO_DICT['SEEK'])/1000))) Nov 21 16:07:44 volumio volumio[1516]: TypeError: unsupported operand type(s) for -: 'str' and 'int' Nov 21 16:07:44 volumio volumio[1516]: Exception in thread Thread-84: Nov 21 16:07:44 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:44 volumio volumio[1516]: self.run() Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:44 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:44 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:44 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:44 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 509, in on_push_state Nov 21 16:07:44 volumio volumio[1516]: f_timebar(args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 485, in f_timebar Nov 21 16:07:44 volumio volumio[1516]: hour = strftime("%-H", gmtime(VOLUMIO_DICT['DURATION'] - int(float(VOLUMIO_DICT['SEEK'])/1000))) Nov 21 16:07:44 volumio volumio[1516]: TypeError: unsupported operand type(s) for -: 'str' and 'int' Nov 21 16:07:44 volumio volumio[1516]: Exception in thread Thread-86: Nov 21 16:07:44 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:44 volumio volumio[1516]: self.run() Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:44 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:44 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:44 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:44 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 509, in on_push_state Nov 21 16:07:44 volumio volumio[1516]: f_timebar(args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 485, in f_timebar Nov 21 16:07:44 volumio volumio[1516]: hour = strftime("%-H", gmtime(VOLUMIO_DICT['DURATION'] - int(float(VOLUMIO_DICT['SEEK'])/1000))) Nov 21 16:07:44 volumio volumio[1516]: TypeError: unsupported operand type(s) for -: 'str' and 'int' Nov 21 16:07:44 volumio volumio[1516]: Exception in thread Thread-88: Nov 21 16:07:44 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:44 volumio volumio[1516]: self.run() Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:44 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:44 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:44 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:44 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 509, in on_push_state Nov 21 16:07:44 volumio volumio[1516]: f_timebar(args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 485, in f_timebar Nov 21 16:07:44 volumio volumio[1516]: hour = strftime("%-H", gmtime(VOLUMIO_DICT['DURATION'] - int(float(VOLUMIO_DICT['SEEK'])/1000))) Nov 21 16:07:44 volumio volumio[1516]: TypeError: unsupported operand type(s) for -: 'str' and 'int' Nov 21 16:07:44 volumio volumio[1516]: Exception in thread Thread-90: Nov 21 16:07:44 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:44 volumio volumio[1516]: self.run() Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:44 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:44 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:44 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:44 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 509, in on_push_state Nov 21 16:07:44 volumio volumio[1516]: f_timebar(args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 485, in f_timebar Nov 21 16:07:44 volumio volumio[1516]: hour = strftime("%-H", gmtime(VOLUMIO_DICT['DURATION'] - int(float(VOLUMIO_DICT['SEEK'])/1000))) Nov 21 16:07:44 volumio volumio[1516]: TypeError: unsupported operand type(s) for -: 'str' and 'int' Nov 21 16:07:44 volumio volumio[1516]: Exception in thread Thread-92: Nov 21 16:07:44 volumio volumio[1516]: Traceback (most recent call last): Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 917, in _bootstrap_inner Nov 21 16:07:44 volumio volumio[1516]: self.run() Nov 21 16:07:44 volumio volumio[1516]: File "/usr/lib/python3.7/threading.py", line 865, in run Nov 21 16:07:44 volumio volumio[1516]: self._target(*self._args, **self._kwargs) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 621, in _handle_eio_message Nov 21 16:07:44 volumio volumio[1516]: self._handle_event(pkt.namespace, pkt.id, pkt.data) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 505, in _handle_event Nov 21 16:07:44 volumio volumio[1516]: r = self._trigger_event(data[0], namespace, *data[1:]) Nov 21 16:07:44 volumio volumio[1516]: File "/usr/local/lib/python3.7/dist-packages/socketio/client.py", line 555, in _trigger_event Nov 21 16:07:44 volumio volumio[1516]: return self.handlers[namespace][event](*args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 509, in on_push_state Nov 21 16:07:44 volumio volumio[1516]: f_timebar(args) Nov 21 16:07:44 volumio volumio[1516]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 485, in f_timebar Nov 21 16:07:44 volumio volumio[1516]: hour = strftime("%-H", gmtime(VOLUMIO_DICT['DURATION'] - int(float(VOLUMIO_DICT['SEEK'])/1000))) Nov 21 16:07:44 volumio volumio[1516]: TypeError: unsupported operand type(s) for -: 'str' and 'int' Nov 21 16:07:44 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:44 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:44 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:44 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:44 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:45 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:45 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:45 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:45 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:45 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:46 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:46 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:46 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:46 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:46 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:47 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:47 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:47 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:47 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:47 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:48 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:48 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:48 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:48 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:48 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:49 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:49 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:49 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:49 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:49 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:49 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:49 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:50 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:50 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:50 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:50 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:50 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:51 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:51 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:51 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:51 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:51 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:52 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:52 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:52 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:52 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:52 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:53 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:53 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:53 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:53 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:53 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:54 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:54 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:54 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:54 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:54 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:54 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:54 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:55 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Nov 21 16:07:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:55 volumio volumio[1119]: info: CoreCommandRouter::volumioGetQueue Nov 21 16:07:55 volumio volumio[1119]: info: CoreStateMachine::getQueue Nov 21 16:07:55 volumio volumio[1119]: info: CorePlayQueue::getQueue Nov 21 16:07:55 volumio volumio[1119]: info: CoreCommandRouter::volumioNext Nov 21 16:07:55 volumio volumio[1119]: info: CoreStateMachine::next Nov 21 16:07:55 volumio volumio[1119]: info: CoreStateMachine::stop Nov 21 16:07:55 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:07:55 volumio volumio[1119]: info: CoreStateMachine::stPlaybackTimer Nov 21 16:07:55 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Nov 21 16:07:55 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Nov 21 16:07:55 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:55 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:55 volumio volumio[1119]: info: CoreStateMachine::serviceStop Nov 21 16:07:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:55 volumio volumio[1119]: info: CoreCommandRouter::serviceStop Nov 21 16:07:55 volumio volumio[1119]: info: ControllerMpd::stop Nov 21 16:07:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 16:07:55 volumio volumio[1119]: info: [GPIO_Control] Status changed: stop Nov 21 16:07:55 volumio volumio[1119]: info: [GPIO_Control] Handling event: musicStop Nov 21 16:07:56 volumio volumio[1119]: info: Nov 21 16:07:56 volumio volumio[1119]: ---------------------------- MPD announces state update: player Nov 21 16:07:56 volumio volumio[1119]: info: sendMpdCommand stop took 20 milliseconds Nov 21 16:07:56 volumio volumio[1119]: info: ControllerMpd::getState Nov 21 16:07:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Nov 21 16:07:56 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:56 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:56 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:56 volumio volumio[1119]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/5f/19/4e/5f194e03-80a6-bc9d-27a7-cb475c0b742c/source/600x600bb.jpg","name":"Sydney Youngblood - Sit and Wait","title":"Sit and Wait","artist":"80s80s Party","album":"","streaming":true,"disableUiControls":true,"duration":"223","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 21 16:07:56 volumio volumio[1119]: verbose: CURRENT POSITION 0 Nov 21 16:07:56 volumio volumio[1119]: info: CoreStateMachine::syncState stateService stop Nov 21 16:07:56 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus stop Nov 21 16:07:56 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:56 volumio volumio[1119]: info: No code Nov 21 16:07:56 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:56 volumio volumio[1119]: info: CoreStateMachine::play index undefined Nov 21 16:07:56 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:07:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Nov 21 16:07:56 volumio volumio[1119]: info: [GPIO_Control] Status changed: stop Nov 21 16:07:56 volumio volumio[1119]: info: [GPIO_Control] Status changed: stop Nov 21 16:07:56 volumio volumio[1119]: info: sendMpdCommand status took 42 milliseconds Nov 21 16:07:56 volumio volumio[1119]: verbose: ControllerMpd::parseState Nov 21 16:07:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 16:07:56 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 33 milliseconds Nov 21 16:07:56 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Nov 21 16:07:56 volumio volumio[1119]: info: ControllerMpd::pushState Nov 21 16:07:56 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Nov 21 16:07:56 volumio volumio[1119]: info: CoreStateMachine::pushState Nov 21 16:07:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:56 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 16:07:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Nov 21 16:07:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Nov 21 16:07:56 volumio volumio[1119]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Nov 21 16:07:56 volumio volumio[1119]: info: ------------------------------ 103ms Nov 21 16:07:56 volumio volumio[1119]: info: [GPIO_Control] Status changed: stop Nov 21 16:07:56 volumio volumio[1119]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 21 16:07:56 volumio volumio[1119]: info: camilladsp spawned new process with pid 3399, instance 1, run: true Nov 21 16:08:04 volumio volumio[1119]: info: CoreCommandRouter::volumioPrevious Nov 21 16:08:04 volumio volumio[1119]: info: CoreStateMachine::previous Nov 21 16:08:04 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Nov 21 16:08:04 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Nov 21 16:08:04 volumio volumio[1119]: info: CoreStateMachine::serviceClearAddPlay Nov 21 16:08:04 volumio volumio[1119]: info: CoreCommandRouter::serviceClearAddPlayTracks Nov 21 16:08:04 volumio volumio[1119]: error: WARNING: No clearAddPlayTracks method for service 80s80s Nov 21 16:08:06 volumio volumio[1119]: info: CoreCommandRouter::volumioPrevious Nov 21 16:08:06 volumio volumio[1119]: info: CoreStateMachine::previous Nov 21 16:08:06 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Nov 21 16:08:06 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Nov 21 16:08:06 volumio volumio[1119]: info: CoreStateMachine::serviceClearAddPlay Nov 21 16:08:06 volumio volumio[1119]: info: CoreCommandRouter::serviceClearAddPlayTracks Nov 21 16:08:06 volumio volumio[1119]: error: WARNING: No clearAddPlayTracks method for service 80s80s Nov 21 16:08:07 volumio volumio[1119]: info: CoreCommandRouter::volumioPrevious Nov 21 16:08:07 volumio volumio[1119]: info: CoreStateMachine::previous Nov 21 16:08:07 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Nov 21 16:08:07 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Nov 21 16:08:07 volumio volumio[1119]: info: CoreStateMachine::serviceClearAddPlay Nov 21 16:08:07 volumio volumio[1119]: info: CoreCommandRouter::serviceClearAddPlayTracks Nov 21 16:08:07 volumio volumio[1119]: error: WARNING: No clearAddPlayTracks method for service 80s80s Nov 21 16:08:08 volumio volumio[1119]: info: CoreCommandRouter::volumioNext Nov 21 16:08:08 volumio volumio[1119]: info: CoreStateMachine::next Nov 21 16:08:08 volumio volumio[1119]: info: CoreStateMachine::stop Nov 21 16:08:08 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:08:08 volumio volumio[1119]: info: CoreStateMachine::play index undefined Nov 21 16:08:08 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:08:08 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Nov 21 16:08:09 volumio volumio[1119]: info: CoreCommandRouter::volumioNext Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::next Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::stop Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::play index undefined Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:08:09 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Nov 21 16:08:09 volumio volumio[1119]: info: CoreCommandRouter::volumioNext Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::next Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::stop Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::play index undefined Nov 21 16:08:09 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 16:08:09 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Nov 21 16:08:31 volumio volumio[1119]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Nov 21 16:08:31 volumio volumio[1119]: info: PLUGIN onReboot : networkfs Nov 21 16:08:31 volumio volumio[1119]: info: PLUGIN onReboot : audiophonicsonoff Nov 21 16:08:31 volumio volumio[1119]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 16:08:31 volumio volumio[1119]: TypeError: Cannot read property 'writeSync' of undefined Nov 21 16:08:31 volumio volumio[1119]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Nov 21 16:08:31 volumio volumio[1119]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Nov 21 16:08:31 volumio volumio[1119]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Nov 21 16:08:31 volumio volumio[1119]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Nov 21 16:08:31 volumio volumio[1119]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Nov 21 16:08:31 volumio volumio[1119]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Nov 21 16:08:31 volumio volumio[1119]: at CoreCommandRouter.reboot (/volumio/app/index.js:1345:22) Nov 21 16:08:31 volumio volumio[1119]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Nov 21 16:08:31 volumio volumio[1119]: at Socket.emit (events.js:315:20) Nov 21 16:08:31 volumio volumio[1119]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 21 16:08:31 volumio volumio[1119]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 21 16:08:31 volumio volumio[1119]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 16:08:32 volumio sudo[3488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-21 16:07 Nov 21 16:08:32 volumio sudo[3488]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"