-- Logs begin at Wed 2024-04-17 23:21:00 CEST, end at Sat 2024-04-20 20:04:23 CEST. -- Apr 20 20:03:00 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 20 20:03:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7. Apr 20 20:03:00 volumio systemd[1]: Stopped go-librespot Daemon. Apr 20 20:03:00 volumio systemd[1]: Started go-librespot Daemon. Apr 20 20:03:00 volumio go-librespot[21614]: Librespot-go daemon starting... Apr 20 20:03:00 volumio go-librespot[21614]: time="2024-04-20T20:03:00+02:00" level=info msg="generated new device id: b8f68f3fdb0976d07fe8f1b02caa71a3167558a8" Apr 20 20:03:00 volumio go-librespot[21614]: time="2024-04-20T20:03:00+02:00" level=debug msg="stored credentials found for 11125970870" Apr 20 20:03:00 volumio go-librespot[21614]: time="2024-04-20T20:03:00+02:00" level=debug msg="obtained new client token: AABCem8w68Y8/PWp90KIayLMySyOHYkJi5P4fofJHw7R2lSClLE0lr1jg0tW0+EZdG78bfG0YcX0+WZWlYxfpC6oD4/QWLhxe/GRVppXbhjyb73taciRESP8/KX7Reg1GGIWSGBd23D13Hju3xQ5YedDreXUbpguH3R3FR/q9GXW9GnET/G2c25UTMYYR2FoZQ+VTb+Lwh75ThPmWfNs/uibR9OVBPM2DMaiJjrj3dd5U9U8JIEiRR5RL73UmKPn" Apr 20 20:03:01 volumio go-librespot[21614]: time="2024-04-20T20:03:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 20 20:03:01 volumio volumio[19209]: info: Initializing connection to go-librespot Websocket Apr 20 20:03:01 volumio go-librespot[21614]: time="2024-04-20T20:03:01+02:00" level=debug msg="new websocket client" Apr 20 20:03:01 volumio volumio[19209]: info: Connection to go-librespot Websocket established Apr 20 20:03:01 volumio go-librespot[21614]: time="2024-04-20T20:03:01+02:00" level=debug msg="completed keyexchange" Apr 20 20:03:02 volumio go-librespot[21614]: time="2024-04-20T20:03:02+02:00" level=debug msg="completed challenge" Apr 20 20:03:02 volumio go-librespot[21614]: time="2024-04-20T20:03:02+02:00" level=debug msg="authenticated as 11125970870" Apr 20 20:03:03 volumio go-librespot[21614]: time="2024-04-20T20:03:03+02:00" level=debug msg="authenticated as 11125970870" Apr 20 20:03:03 volumio go-librespot[21614]: time="2024-04-20T20:03:03+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 20 20:03:04 volumio go-librespot[21614]: time="2024-04-20T20:03:04+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 20 20:03:04 volumio volumio[19209]: info: Getting Spotify volume Apr 20 20:03:04 volumio volumio[19209]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Apr 20 20:03:04 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:04 volumio volumio[19209]: info: CorePlayQueue::getTrack 0 Apr 20 20:03:05 volumio go-librespot[21614]: time="2024-04-20T20:03:05+02:00" level=debug msg="dealer connection opened" Apr 20 20:03:05 volumio go-librespot[21614]: time="2024-04-20T20:03:05+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 20 20:03:05 volumio go-librespot[21614]: time="2024-04-20T20:03:05+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 20 20:03:05 volumio volumio[19209]: info: Spotify volume: 100 Apr 20 20:03:05 volumio go-librespot[21614]: time="2024-04-20T20:03:05+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 20 20:03:05 volumio go-librespot[21614]: time="2024-04-20T20:03:05+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 20 20:03:05 volumio go-librespot[21614]: time="2024-04-20T20:03:05+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Apr 20 20:03:05 volumio go-librespot[21614]: time="2024-04-20T20:03:05+02:00" level=debug msg="received connection id: NzhkZTE2NDUtNzA4ZC00ZTJjLTliYTQtYzMxM2NmMjRhYWI3K2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLXNwMWcuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwK0QyQzMxQjREMEYxMjFEQzk3MzNFOTgwOTg0RjM5OTY4NkMyOTFEMTFEMUNCMjRCMjdGRTM3MUVENUFEMEQzQjM=" Apr 20 20:03:05 volumio go-librespot[21614]: time="2024-04-20T20:03:05+02:00" level=debug msg="put connect state because NEW_DEVICE" Apr 20 20:03:06 volumio volumio[19209]: info: [1713636186156] [80s80s] Pushing the next song state Niko - Am weissen Strand von Helgoland (Neuproduktion 2016) and getting next track. Apr 20 20:03:06 volumio volumio[19209]: info: CorePlayQueue::getTrack 0 Apr 20 20:03:06 volumio volumio[19209]: info: CoreCommandRouter::servicePushState Apr 20 20:03:06 volumio volumio[19209]: info: CorePlayQueue::getTrack 0 Apr 20 20:03:06 volumio volumio[19209]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received 80s80s Apr 20 20:03:06 volumio volumio[19209]: info: [1713636186157] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=156&count=1 Apr 20 20:03:06 volumio volumio[19209]: info: CorePlayQueue::getTrack 0 Apr 20 20:03:06 volumio volumio[19209]: info: CorePlayQueue::getTrack 1 Apr 20 20:03:06 volumio volumio[19209]: info: [1713636186493] [80s80s] received new event containing 1 songs. Apr 20 20:03:06 volumio volumio[19209]: info: [1713636186494] [80s80s] PlayNextTrack API delay: 30 Apr 20 20:03:06 volumio volumio[19209]: info: [1713636186495] [80s80s] Setting timer to: 182000 milliseconds. Apr 20 20:03:14 volumio go-librespot[21614]: time="2024-04-20T20:03:14+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Apr 20 20:03:14 volumio go-librespot[21614]: time="2024-04-20T20:03:14+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 340" Apr 20 20:03:14 volumio go-librespot[21614]: time="2024-04-20T20:03:14+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Apr 20 20:03:14 volumio go-librespot[21614]: time="2024-04-20T20:03:14+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2891" Apr 20 20:03:18 volumio go-librespot[21614]: time="2024-04-20T20:03:18+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Apr 20 20:03:18 volumio go-librespot[21614]: time="2024-04-20T20:03:18+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 340" Apr 20 20:03:18 volumio go-librespot[21614]: time="2024-04-20T20:03:18+02:00" level=debug msg="handling transfer player command from 626cda1d0aa52e2ea78ee840627ae6a8211ea2f8" Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=trace msg="fetched new page 0 with 1631 items (list: 1631)" Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=debug msg="loading track spotify:track:5JjdJK0uGRUk4skRTuQdUZ (paused: false, position: 398986ms)" Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=trace msg="emitting websocket event: will_play" Apr 20 20:03:19 volumio volumio[19209]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:5JjdJK0uGRUk4skRTuQdUZ","play_origin":"driving-jumpstart"}} Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2837" Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=debug msg="selected format OGG_VORBIS_160 for spotify:track:5JjdJK0uGRUk4skRTuQdUZ" Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=debug msg="requested aes key for file 81405069737b79fb17e33737c52ab0ed4e5aae23, gid: 5JjdJK0uGRUk4skRTuQdUZ" Apr 20 20:03:19 volumio go-librespot[21614]: time="2024-04-20T20:03:19+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1971" Apr 20 20:03:23 volumio go-librespot[21614]: time="2024-04-20T20:03:23+02:00" level=debug msg="fetched first chunk of 17, total size is 8891708 bytes" Apr 20 20:03:29 volumio go-librespot[21614]: time="2024-04-20T20:03:29+02:00" level=debug msg="fetched chunk 1/16, size: 524288" Apr 20 20:03:38 volumio go-librespot[21614]: time="2024-04-20T20:03:38+02:00" level=debug msg="fetched chunk 3/16, size: 524288" Apr 20 20:03:39 volumio go-librespot[21614]: time="2024-04-20T20:03:39+02:00" level=debug msg="fetched chunk 2/16, size: 524288" Apr 20 20:03:42 volumio go-librespot[21614]: time="2024-04-20T20:03:42+02:00" level=debug msg="fetched chunk 16/16, size: 503100" Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=debug msg="fetched chunk 15/16, size: 524288" Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=trace msg="seek to 398986ms (diff: 398718ms, samples: 17595282, bytes: 8161674)" Apr 20 20:03:45 volumio volumio[19209]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:03:45 volumio volumio[19209]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:03:45 volumio volumio[19209]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=info msg="loaded track \"Private Dancer - 2015 Remaster\" (uri: spotify:track:5JjdJK0uGRUk4skRTuQdUZ, paused: false, position: 398986ms, duration: 434373ms)" Apr 20 20:03:45 volumio volumio[19209]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=trace msg="emitting websocket event: metadata" Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=trace msg="emitting websocket event: active" Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=debug msg="sending successful reply for delaer request" Apr 20 20:03:45 volumio volumio[19209]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:5JjdJK0uGRUk4skRTuQdUZ","name":"Private Dancer - 2015 Remaster","artist_names":["Tina Turner"],"album_name":"Private Dancer (30th Anniversary Issue)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02f82ae34da3139fbd2a88332b","position":398986,"duration":434373,"release_date":"year:1984 month:5 day:29","track_number":5,"disc_number":1}} Apr 20 20:03:45 volumio volumio[19209]: SPOTIFY: received: {"type":"active","data":null} Apr 20 20:03:45 volumio volumio[19209]: info: Aligning Spotify Volume to Volumio Volume Apr 20 20:03:45 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Apr 20 20:03:45 volumio volumio[19209]: info: CorePlayQueue::getTrack 0 Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 20 20:03:45 volumio go-librespot[21614]: time="2024-04-20T20:03:45+02:00" level=trace msg="emitting websocket event: playing" Apr 20 20:03:45 volumio volumio[19209]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:5JjdJK0uGRUk4skRTuQdUZ","play_origin":"driving-jumpstart"}} Apr 20 20:03:45 volumio volumio[19209]: info: Spotify is playing in volatile mode Apr 20 20:03:45 volumio volumio[19209]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:03:45 volumio volumio[19209]: SPOTIFY: UNSET VOLATILE Apr 20 20:03:45 volumio volumio[19209]: SPOTIFY: {"status":"stop","position":0,"title":"Jump They Say (Radio Edit Remastered)","artist":"David Bowie","album":"Legacy [Deluxe Edition]","albumart":"/albumart?cacheid=392&web=David%20Bowie/Legacy%20%5BDeluxe%20Edition%5D/extralarge&path=%2Fmnt%2FUSB%2FDVR-VIDEO&metadata=false","uri":"music-library/USB/DVR-VIDEO/30. David Bowie - Jump They Say (Radio Edit Remastered).flac","trackType":"flac","seek":100714,"duration":234,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":true,"mute":false,"stream":"flac","updatedb":false,"volatile":false,"service":"mpd"} Apr 20 20:03:45 volumio volumio[19209]: SPOTIFY: PUSH STATE SPOTIFY Apr 20 20:03:45 volumio volumio[19209]: SPOTIFY: {"status":"play","service":"spop","title":"Private Dancer - 2015 Remaster","artist":"Tina Turner","album":"Private Dancer (30th Anniversary Issue)","albumart":"https://i.scdn.co/image/ab67616d00001e02f82ae34da3139fbd2a88332b","uri":"spotify:track:5JjdJK0uGRUk4skRTuQdUZ","trackType":"spotify","seek":399986,"duration":434,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 20 20:03:45 volumio volumio[19209]: info: CoreCommandRouter::servicePushState Apr 20 20:03:45 volumio volumio[19209]: info: CoreStateMachine::pushState Apr 20 20:03:45 volumio volumio[19209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:03:45 volumio volumio[19209]: info: CoreCommandRouter::volumioPushState Apr 20 20:03:46 volumio volumio[19209]: SPOTIFY: PUSH STATE SPOTIFY Apr 20 20:03:46 volumio volumio[19209]: SPOTIFY: {"status":"play","service":"spop","title":"Private Dancer - 2015 Remaster","artist":"Tina Turner","album":"Private Dancer (30th Anniversary Issue)","albumart":"https://i.scdn.co/image/ab67616d00001e02f82ae34da3139fbd2a88332b","uri":"spotify:track:5JjdJK0uGRUk4skRTuQdUZ","trackType":"spotify","seek":399986,"duration":434,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Apr 20 20:03:46 volumio volumio[19209]: info: CoreCommandRouter::servicePushState Apr 20 20:03:46 volumio volumio[19209]: info: CoreStateMachine::pushState Apr 20 20:03:46 volumio volumio[19209]: info: CoreCommandRouter::volumioPushState Apr 20 20:03:46 volumio volumio[21458]: register 5 Apr 20 20:03:46 volumio volumio[21458]: success Apr 20 20:03:46 volumio volumio[21458]: register 6 Apr 20 20:03:46 volumio volumio[21458]: success Apr 20 20:03:46 volumio volumio[21458]: register 16 Apr 20 20:03:46 volumio volumio[21458]: success Apr 20 20:03:46 volumio volumio[21458]: register 20 Apr 20 20:03:46 volumio volumio[21458]: success Apr 20 20:03:46 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:03:46 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:03:46 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:03:46 volumio volumio[21458]: Traceback (most recent call last): Apr 20 20:03:46 volumio volumio[21458]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 721, in Apr 20 20:03:46 volumio volumio[21458]: main() Apr 20 20:03:46 volumio volumio[21458]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 697, in main Apr 20 20:03:46 volumio volumio[21458]: SOCKETIO.wait() Apr 20 20:03:46 volumio volumio[21458]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 251, in wait Apr 20 20:03:46 volumio volumio[21458]: self._process_packets() Apr 20 20:03:46 volumio volumio[21458]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 278, in _process_packets Apr 20 20:03:46 volumio volumio[21458]: self._process_packet(engineIO_packet) Apr 20 20:03:46 volumio volumio[21458]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 491, in _process_packet Apr 20 20:03:46 volumio volumio[21458]: delegate(parse_socketIO_packet_data(socketIO_packet_data), namespace) Apr 20 20:03:46 volumio volumio[21458]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 513, in _on_event Apr 20 20:03:46 volumio volumio[21458]: namespace._find_packet_callback(event)(*args) Apr 20 20:03:46 volumio volumio[21458]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 511, in on_push_state Apr 20 20:03:46 volumio volumio[21458]: sendtodisplay(IMAGE_DICT['IMG']) Apr 20 20:03:46 volumio volumio[21458]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:03:46 volumio volumio[21458]: DISP.display(img4) Apr 20 20:03:46 volumio volumio[21458]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:03:46 volumio volumio[21458]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:03:46 volumio volumio[21458]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:03:46 volumio volumio[21458]: self.send(data, True) Apr 20 20:03:46 volumio volumio[21458]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:03:46 volumio volumio[21458]: self._spi.xfer(data[start:end]) Apr 20 20:03:46 volumio volumio[21458]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:03:46 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:03:46 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:03:47 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:03:47 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 57. Apr 20 20:03:47 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:03:47 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:03:47 volumio ntpd[750]: Soliciting pool server 192.86.14.67 Apr 20 20:03:48 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:48 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:48 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:48 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:48 volumio ntpd[750]: Soliciting pool server 195.46.37.22 Apr 20 20:03:49 volumio volumio[21697]: Traceback (most recent call last): Apr 20 20:03:49 volumio volumio[21697]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 20 20:03:49 volumio volumio[21697]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 20 20:03:49 volumio volumio[21697]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 20 20:03:49 volumio volumio[21697]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 20 20:03:49 volumio volumio[21697]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:03:49 volumio volumio[21697]: DISP.display(img4) Apr 20 20:03:49 volumio volumio[21697]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:03:49 volumio volumio[21697]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:03:49 volumio volumio[21697]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:03:49 volumio volumio[21697]: self.send(data, True) Apr 20 20:03:49 volumio volumio[21697]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:03:49 volumio volumio[21697]: self._spi.xfer(data[start:end]) Apr 20 20:03:49 volumio volumio[21697]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:03:49 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:03:49 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:03:49 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:03:49 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:03:49 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:03:49 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:03:49 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 58. Apr 20 20:03:49 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:03:49 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:03:50 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:50 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:50 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:50 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:51 volumio volumio[19209]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.31.0 Total Clients: 8 Apr 20 20:03:51 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:51 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:51 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:51 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:51 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:51 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:51 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:51 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:52 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:03:52 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:03:52 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:03:52 volumio volumio[21698]: register 5 Apr 20 20:03:52 volumio volumio[21698]: success Apr 20 20:03:52 volumio volumio[21698]: register 6 Apr 20 20:03:52 volumio volumio[21698]: success Apr 20 20:03:52 volumio volumio[21698]: register 16 Apr 20 20:03:52 volumio volumio[21698]: success Apr 20 20:03:52 volumio volumio[21698]: register 20 Apr 20 20:03:52 volumio volumio[21698]: success Apr 20 20:03:52 volumio volumio[21698]: Traceback (most recent call last): Apr 20 20:03:52 volumio volumio[21698]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 721, in Apr 20 20:03:52 volumio volumio[21698]: main() Apr 20 20:03:52 volumio volumio[21698]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 697, in main Apr 20 20:03:52 volumio volumio[21698]: SOCKETIO.wait() Apr 20 20:03:52 volumio volumio[21698]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 251, in wait Apr 20 20:03:52 volumio volumio[21698]: self._process_packets() Apr 20 20:03:52 volumio volumio[21698]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 278, in _process_packets Apr 20 20:03:52 volumio volumio[21698]: self._process_packet(engineIO_packet) Apr 20 20:03:52 volumio volumio[21698]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 491, in _process_packet Apr 20 20:03:52 volumio volumio[21698]: delegate(parse_socketIO_packet_data(socketIO_packet_data), namespace) Apr 20 20:03:52 volumio volumio[21698]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 513, in _on_event Apr 20 20:03:52 volumio volumio[21698]: namespace._find_packet_callback(event)(*args) Apr 20 20:03:52 volumio volumio[21698]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 511, in on_push_state Apr 20 20:03:52 volumio volumio[21698]: sendtodisplay(IMAGE_DICT['IMG']) Apr 20 20:03:52 volumio volumio[21698]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:03:52 volumio volumio[21698]: DISP.display(img4) Apr 20 20:03:52 volumio volumio[21698]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:03:52 volumio volumio[21698]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:03:52 volumio volumio[21698]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:03:52 volumio volumio[21698]: self.send(data, True) Apr 20 20:03:52 volumio volumio[21698]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:03:52 volumio volumio[21698]: self._spi.xfer(data[start:end]) Apr 20 20:03:52 volumio volumio[21698]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:03:52 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:03:52 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:03:53 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:03:53 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 59. Apr 20 20:03:53 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:03:53 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:03:54 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:54 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:54 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:54 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:54 volumio volumio[19209]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.31.0 Total Clients: 8 Apr 20 20:03:55 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:55 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:55 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:55 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:55 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:55 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:55 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:55 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:56 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:56 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:56 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:56 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:57 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:57 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:57 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:57 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:58 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:58 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:58 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:58 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:03:59 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:03:59 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:03:59 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:03:59 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:00 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:00 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:00 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:00 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:01 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:01 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:01 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:01 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:02 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:02 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:02 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:02 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:03 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:03 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:03 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:03 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:04 volumio go-librespot[21614]: time="2024-04-20T20:04:04+02:00" level=debug msg="handling play player command from 626cda1d0aa52e2ea78ee840627ae6a8211ea2f8" Apr 20 20:04:04 volumio go-librespot[21614]: time="2024-04-20T20:04:04+02:00" level=trace msg="fetched new page 0 with 76 items (list: 76)" Apr 20 20:04:04 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:04 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:04 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:04 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:04 volumio go-librespot[21614]: time="2024-04-20T20:04:04+02:00" level=debug msg="loading track spotify:track:4grVkAtmqIipynBu8D9v6G (paused: false, position: 401ms)" Apr 20 20:04:05 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:05 volumio go-librespot[21614]: time="2024-04-20T20:04:05+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 20 20:04:05 volumio go-librespot[21614]: time="2024-04-20T20:04:05+02:00" level=trace msg="emitting websocket event: will_play" Apr 20 20:04:05 volumio volumio[19209]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4grVkAtmqIipynBu8D9v6G","play_origin":"playlist"}} Apr 20 20:04:05 volumio volumio[19209]: info: camilladsp spawned new process with pid 21790, instance 1, run: true Apr 20 20:04:05 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:05 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:05 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:05 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:05 volumio volumio[21745]: register 5 Apr 20 20:04:05 volumio volumio[21745]: success Apr 20 20:04:05 volumio volumio[21745]: register 6 Apr 20 20:04:05 volumio volumio[21745]: success Apr 20 20:04:05 volumio volumio[21745]: register 16 Apr 20 20:04:05 volumio volumio[21745]: success Apr 20 20:04:05 volumio volumio[21745]: register 20 Apr 20 20:04:05 volumio volumio[21745]: success Apr 20 20:04:05 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:04:05 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:04:05 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:04:05 volumio volumio[21745]: Traceback (most recent call last): Apr 20 20:04:05 volumio volumio[21745]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 721, in Apr 20 20:04:05 volumio volumio[21745]: main() Apr 20 20:04:05 volumio volumio[21745]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 697, in main Apr 20 20:04:05 volumio volumio[21745]: SOCKETIO.wait() Apr 20 20:04:05 volumio volumio[21745]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 251, in wait Apr 20 20:04:05 volumio volumio[21745]: self._process_packets() Apr 20 20:04:05 volumio volumio[21745]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 278, in _process_packets Apr 20 20:04:05 volumio volumio[21745]: self._process_packet(engineIO_packet) Apr 20 20:04:05 volumio volumio[21745]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 491, in _process_packet Apr 20 20:04:05 volumio volumio[21745]: delegate(parse_socketIO_packet_data(socketIO_packet_data), namespace) Apr 20 20:04:05 volumio volumio[21745]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 513, in _on_event Apr 20 20:04:05 volumio volumio[21745]: namespace._find_packet_callback(event)(*args) Apr 20 20:04:05 volumio volumio[21745]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 511, in on_push_state Apr 20 20:04:05 volumio volumio[21745]: sendtodisplay(IMAGE_DICT['IMG']) Apr 20 20:04:05 volumio volumio[21745]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:04:05 volumio volumio[21745]: DISP.display(img4) Apr 20 20:04:05 volumio volumio[21745]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:04:05 volumio volumio[21745]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:04:05 volumio volumio[21745]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:04:05 volumio volumio[21745]: self.send(data, True) Apr 20 20:04:05 volumio volumio[21745]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:04:05 volumio volumio[21745]: self._spi.xfer(data[start:end]) Apr 20 20:04:05 volumio volumio[21745]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:04:05 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:04:05 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:04:05 volumio go-librespot[21614]: time="2024-04-20T20:04:05+02:00" level=debug msg="selected format OGG_VORBIS_160 for spotify:track:4grVkAtmqIipynBu8D9v6G" Apr 20 20:04:05 volumio go-librespot[21614]: time="2024-04-20T20:04:05+02:00" level=debug msg="requested aes key for file 4c3b359b7d9c3da5fc189e07c3ba96296a8468aa, gid: 4grVkAtmqIipynBu8D9v6G" Apr 20 20:04:06 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:04:06 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 60. Apr 20 20:04:06 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:04:06 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:04:06 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:06 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:06 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:06 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:07 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:07 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:07 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:07 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:07 volumio volumio[21803]: Traceback (most recent call last): Apr 20 20:04:07 volumio volumio[21803]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 20 20:04:07 volumio volumio[21803]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 20 20:04:07 volumio volumio[21803]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 20 20:04:07 volumio volumio[21803]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 20 20:04:07 volumio volumio[21803]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:04:07 volumio volumio[21803]: DISP.display(img4) Apr 20 20:04:07 volumio volumio[21803]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:04:07 volumio volumio[21803]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:04:07 volumio volumio[21803]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:04:07 volumio volumio[21803]: self.send(data, True) Apr 20 20:04:07 volumio volumio[21803]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:04:07 volumio volumio[21803]: self._spi.xfer(data[start:end]) Apr 20 20:04:07 volumio volumio[21803]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:04:07 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:04:07 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:04:07 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:04:08 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:04:08 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:04:08 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:04:08 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 61. Apr 20 20:04:08 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:04:08 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:04:09 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:09 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:09 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:09 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=debug msg="fetched first chunk of 8, total size is 4010204 bytes" Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=trace msg="seek to 401ms (diff: 255ms, samples: 17684, bytes: 3753)" Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=info msg="loaded track \"Hypnotized\" (uri: spotify:track:4grVkAtmqIipynBu8D9v6G, paused: false, position: 401ms, duration: 195704ms)" Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=debug msg="vorbis: corrupt or missing data in bitstream" Apr 20 20:04:10 volumio volumio[19209]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:04:10 volumio volumio[19209]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:04:10 volumio volumio[19209]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:04:10 volumio volumio[19209]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:04:10 volumio volumio[21804]: Traceback (most recent call last): Apr 20 20:04:10 volumio volumio[21804]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 20 20:04:10 volumio volumio[21804]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 20 20:04:10 volumio volumio[21804]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 20 20:04:10 volumio volumio[21804]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 20 20:04:10 volumio volumio[21804]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:04:10 volumio volumio[21804]: DISP.display(img4) Apr 20 20:04:10 volumio volumio[21804]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:04:10 volumio volumio[21804]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:04:10 volumio volumio[21804]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:04:10 volumio volumio[21804]: self.send(data, True) Apr 20 20:04:10 volumio volumio[21804]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:04:10 volumio volumio[21804]: self._spi.xfer(data[start:end]) Apr 20 20:04:10 volumio volumio[21804]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:04:10 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:04:10 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:04:10 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=trace msg="emitting websocket event: metadata" Apr 20 20:04:10 volumio volumio[19209]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4grVkAtmqIipynBu8D9v6G","name":"Hypnotized","artist_names":["Purple Disco Machine","Sophie and the Giants"],"album_name":"Hypnotized","album_cover_url":"https://i.scdn.co/image/ab67616d00001e027fa99447c174db9f22409e1c","position":401,"duration":195704,"release_date":"year:2020 month:4 day:8","track_number":1,"disc_number":1}} Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=debug msg="sending successful reply for delaer request" Apr 20 20:04:10 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:04:10 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:04:10 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:04:10 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 62. Apr 20 20:04:10 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:04:10 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 20 20:04:10 volumio go-librespot[21614]: time="2024-04-20T20:04:10+02:00" level=trace msg="emitting websocket event: playing" Apr 20 20:04:10 volumio volumio[19209]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:4grVkAtmqIipynBu8D9v6G","play_origin":"playlist"}} Apr 20 20:04:10 volumio volumio[19209]: SPOTIFY: PUSH STATE SPOTIFY Apr 20 20:04:10 volumio volumio[19209]: SPOTIFY: {"status":"play","service":"spop","title":"Hypnotized","artist":"Purple Disco Machine, Sophie and the Giants","album":"Hypnotized","albumart":"https://i.scdn.co/image/ab67616d00001e027fa99447c174db9f22409e1c","uri":"spotify:track:4grVkAtmqIipynBu8D9v6G","trackType":"spotify","seek":1401,"duration":195,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Apr 20 20:04:10 volumio volumio[19209]: info: CoreCommandRouter::servicePushState Apr 20 20:04:10 volumio volumio[19209]: info: CoreStateMachine::pushState Apr 20 20:04:10 volumio volumio[19209]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:04:10 volumio volumio[19209]: info: CoreCommandRouter::volumioPushState Apr 20 20:04:11 volumio volumio[19209]: SPOTIFY: PUSH STATE SPOTIFY Apr 20 20:04:11 volumio volumio[19209]: SPOTIFY: {"status":"play","service":"spop","title":"Hypnotized","artist":"Purple Disco Machine, Sophie and the Giants","album":"Hypnotized","albumart":"https://i.scdn.co/image/ab67616d00001e027fa99447c174db9f22409e1c","uri":"spotify:track:4grVkAtmqIipynBu8D9v6G","trackType":"spotify","seek":1401,"duration":195,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"160 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Apr 20 20:04:11 volumio volumio[19209]: info: CoreCommandRouter::servicePushState Apr 20 20:04:11 volumio volumio[19209]: info: CoreStateMachine::pushState Apr 20 20:04:11 volumio volumio[19209]: info: CoreCommandRouter::volumioPushState Apr 20 20:04:11 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:11 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:11 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:11 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:12 volumio volumio[21808]: Traceback (most recent call last): Apr 20 20:04:12 volumio volumio[21808]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 20 20:04:12 volumio volumio[21808]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 20 20:04:12 volumio volumio[21808]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 20 20:04:12 volumio volumio[21808]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 20 20:04:12 volumio volumio[21808]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:04:12 volumio volumio[21808]: DISP.display(img4) Apr 20 20:04:12 volumio volumio[21808]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:04:12 volumio volumio[21808]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:04:12 volumio volumio[21808]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:04:12 volumio volumio[21808]: self.send(data, True) Apr 20 20:04:12 volumio volumio[21808]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:04:12 volumio volumio[21808]: self._spi.xfer(data[start:end]) Apr 20 20:04:12 volumio volumio[21808]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:04:12 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:04:12 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:04:12 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:04:12 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:04:12 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:04:12 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:12 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:12 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:12 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:13 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:04:13 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 63. Apr 20 20:04:13 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:04:13 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:04:13 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:13 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:13 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:13 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:14 volumio volumio[21809]: Traceback (most recent call last): Apr 20 20:04:14 volumio volumio[21809]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 20 20:04:14 volumio volumio[21809]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 20 20:04:14 volumio volumio[21809]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 20 20:04:14 volumio volumio[21809]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 20 20:04:14 volumio volumio[21809]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:04:14 volumio volumio[21809]: DISP.display(img4) Apr 20 20:04:14 volumio volumio[21809]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:04:14 volumio volumio[21809]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:04:14 volumio volumio[21809]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:04:14 volumio volumio[21809]: self.send(data, True) Apr 20 20:04:14 volumio volumio[21809]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:04:14 volumio volumio[21809]: self._spi.xfer(data[start:end]) Apr 20 20:04:14 volumio volumio[21809]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:04:14 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:04:14 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:04:14 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:04:15 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:04:15 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:04:15 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:04:15 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 64. Apr 20 20:04:15 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:04:15 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:04:16 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:16 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:16 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:16 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:17 volumio volumio[21811]: Traceback (most recent call last): Apr 20 20:04:17 volumio volumio[21811]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 309, in Apr 20 20:04:17 volumio volumio[21811]: display_stuff(IMAGE_DICT['BG_DEFAULT'], OBJ_TRANS['DISPLAY']['WAIT'], 0, 0, 'info') Apr 20 20:04:17 volumio volumio[21811]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 304, in display_stuff Apr 20 20:04:17 volumio volumio[21811]: sendtodisplay(IMAGE_DICT['IMG3']) Apr 20 20:04:17 volumio volumio[21811]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:04:17 volumio volumio[21811]: DISP.display(img4) Apr 20 20:04:17 volumio volumio[21811]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:04:17 volumio volumio[21811]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:04:17 volumio volumio[21811]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:04:17 volumio volumio[21811]: self.send(data, True) Apr 20 20:04:17 volumio volumio[21811]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:04:17 volumio volumio[21811]: self._spi.xfer(data[start:end]) Apr 20 20:04:17 volumio volumio[21811]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:04:17 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:04:17 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:04:17 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:04:17 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:04:17 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:04:17 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:04:17 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 65. Apr 20 20:04:17 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:04:17 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:04:19 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:19 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:19 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:19 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:19 volumio volumio[19209]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.31.0 Total Clients: 8 Apr 20 20:04:20 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:20 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:20 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:20 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:20 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:20 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:20 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:20 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:20 volumio go-librespot[21614]: time="2024-04-20T20:04:20+02:00" level=debug msg="fetched chunk 2/7, size: 524288" Apr 20 20:04:20 volumio go-librespot[21614]: time="2024-04-20T20:04:20+02:00" level=debug msg="fetched chunk 1/7, size: 524288" Apr 20 20:04:21 volumio volumio[19209]: info: CoreCommandRouter::volumioGetState Apr 20 20:04:21 volumio volumio[19209]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:04:21 volumio volumio[19209]: info: CoreStateMachine::getQueue Apr 20 20:04:21 volumio volumio[19209]: info: CorePlayQueue::getQueue Apr 20 20:04:21 volumio go-librespot[21614]: time="2024-04-20T20:04:21+02:00" level=debug msg="handling play player command from 626cda1d0aa52e2ea78ee840627ae6a8211ea2f8" Apr 20 20:04:21 volumio go-librespot[21614]: time="2024-04-20T20:04:21+02:00" level=trace msg="fetched new page 0 with 76 items (list: 76)" Apr 20 20:04:21 volumio volumio[21812]: register 5 Apr 20 20:04:21 volumio volumio[21812]: success Apr 20 20:04:21 volumio volumio[21812]: register 6 Apr 20 20:04:21 volumio volumio[21812]: success Apr 20 20:04:21 volumio volumio[21812]: register 16 Apr 20 20:04:21 volumio volumio[21812]: success Apr 20 20:04:21 volumio volumio[21812]: register 20 Apr 20 20:04:21 volumio volumio[21812]: success Apr 20 20:04:21 volumio kernel: spidev spi0.1: SPI transfer timed out Apr 20 20:04:21 volumio kernel: spi_master spi0: failed to transfer one message from queue Apr 20 20:04:21 volumio kernel: spi_master spi0: noqueue transfer failed Apr 20 20:04:21 volumio volumio[21812]: Traceback (most recent call last): Apr 20 20:04:21 volumio volumio[21812]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 721, in Apr 20 20:04:21 volumio volumio[21812]: main() Apr 20 20:04:21 volumio volumio[21812]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 697, in main Apr 20 20:04:21 volumio volumio[21812]: SOCKETIO.wait() Apr 20 20:04:21 volumio volumio[21812]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 251, in wait Apr 20 20:04:21 volumio volumio[21812]: self._process_packets() Apr 20 20:04:21 volumio volumio[21812]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 278, in _process_packets Apr 20 20:04:21 volumio volumio[21812]: self._process_packet(engineIO_packet) Apr 20 20:04:21 volumio volumio[21812]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 491, in _process_packet Apr 20 20:04:21 volumio volumio[21812]: delegate(parse_socketIO_packet_data(socketIO_packet_data), namespace) Apr 20 20:04:21 volumio volumio[21812]: File "/usr/local/lib/python3.7/dist-packages/socketIO_client/__init__.py", line 513, in _on_event Apr 20 20:04:21 volumio volumio[21812]: namespace._find_packet_callback(event)(*args) Apr 20 20:04:21 volumio volumio[21812]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 511, in on_push_state Apr 20 20:04:21 volumio volumio[21812]: sendtodisplay(IMAGE_DICT['IMG']) Apr 20 20:04:21 volumio volumio[21812]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 210, in sendtodisplay Apr 20 20:04:21 volumio volumio[21812]: DISP.display(img4) Apr 20 20:04:21 volumio volumio[21812]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 343, in display Apr 20 20:04:21 volumio volumio[21812]: self.data(pixelbytes[i:i + 4096]) Apr 20 20:04:21 volumio volumio[21812]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 191, in data Apr 20 20:04:21 volumio volumio[21812]: self.send(data, True) Apr 20 20:04:21 volumio volumio[21812]: File "/usr/local/lib/python3.7/dist-packages/ST7789/__init__.py", line 170, in send Apr 20 20:04:21 volumio volumio[21812]: self._spi.xfer(data[start:end]) Apr 20 20:04:21 volumio volumio[21812]: TimeoutError: [Errno 110] Connection timed out Apr 20 20:04:21 volumio go-librespot[21614]: time="2024-04-20T20:04:21+02:00" level=debug msg="loading track spotify:track:4grVkAtmqIipynBu8D9v6G (paused: false, position: 200ms)" Apr 20 20:04:21 volumio go-librespot[21614]: time="2024-04-20T20:04:21+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 20 20:04:21 volumio go-librespot[21614]: time="2024-04-20T20:04:21+02:00" level=trace msg="emitting websocket event: will_play" Apr 20 20:04:21 volumio volumio[19209]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4grVkAtmqIipynBu8D9v6G","play_origin":"playlist"}} Apr 20 20:04:21 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Apr 20 20:04:21 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Apr 20 20:04:21 volumio go-librespot[21614]: time="2024-04-20T20:04:21+02:00" level=debug msg="selected format OGG_VORBIS_160 for spotify:track:4grVkAtmqIipynBu8D9v6G" Apr 20 20:04:21 volumio go-librespot[21614]: time="2024-04-20T20:04:21+02:00" level=debug msg="requested aes key for file 4c3b359b7d9c3da5fc189e07c3ba96296a8468aa, gid: 4grVkAtmqIipynBu8D9v6G" Apr 20 20:04:21 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Apr 20 20:04:21 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 66. Apr 20 20:04:21 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. Apr 20 20:04:21 volumio systemd[1]: Started Service for using pirate audio display in volumio. Apr 20 20:04:22 volumio volumio[19209]: info: camilladsp spawned new process with pid 21898, instance 1, run: true Apr 20 20:04:22 volumio go-librespot[21614]: time="2024-04-20T20:04:22+02:00" level=debug msg="fetched chunk 3/7, size: 524288" Apr 20 20:04:23 volumio volumio[19209]: info: [1713636263039] [80s80s] Pushing the next song state Madonna - Papa Don't Preach and getting next track. Apr 20 20:04:23 volumio volumio[19209]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 20:04:23 volumio volumio[19209]: TypeError: Cannot set property 'name' of undefined Apr 20 20:04:23 volumio volumio[19209]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Apr 20 20:04:23 volumio volumio[19209]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Apr 20 20:04:23 volumio volumio[19209]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Apr 20 20:04:23 volumio volumio[19209]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Apr 20 20:04:23 volumio volumio[19209]: at processImmediate (internal/timers.js:461:21) Apr 20 20:04:23 volumio volumio[19209]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 20:04:23 volumio sudo[21915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-20 20:03 Apr 20 20:04:23 volumio sudo[21915]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"