-- Logs begin at Sun 2024-12-01 16:43:17 CET, end at Sun 2024-12-01 16:51:09 CET. -- Dec 01 16:50:04 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:04+01:00" level=debug msg="handling pause player command from fd112cc0910f8fd90d522168bb7cd8398b40f8e0" Dec 01 16:50:05 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:05+01:00" level=debug msg="pause track at 149076ms" Dec 01 16:50:05 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:05+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:05 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:05+01:00" level=debug msg="sending successful reply for delaer request" Dec 01 16:50:05 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:05+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:05 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:05+01:00" level=trace msg="emitting websocket event: paused" Dec 01 16:50:05 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:05 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:05 kcs-radio volumio[1174]: SPOTIFY: {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":145000,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:05 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:05 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":145000,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:05 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService pause Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:05 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:05 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:05 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:05 kcs-radio volumio[1174]: SPOTIFY: {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":145000,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:05 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:05 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":145000,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:05 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService pause Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:05 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:05 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:05 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:05 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="handling skip_next player command from fd112cc0910f8fd90d522168bb7cd8398b40f8e0" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="skip next track" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="loading track spotify:track:7d4Z68eO6swRqacMckcii8 (paused: true, position: 0ms)" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=trace msg="emitting websocket event: will_play" Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:7d4Z68eO6swRqacMckcii8" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="requested aes key for file aa7952690d4e042baaf4318725e7173aca0ab32c, gid: 7d4Z68eO6swRqacMckcii8" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="fetched first chunk of 17, total size is 8513456 bytes" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=info msg="loaded track \"Nasty\" (uri: spotify:track:7d4Z68eO6swRqacMckcii8, paused: true, position: 0ms, duration: 177312ms)" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="fetched chunk 3/16, size: 524288" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=trace msg="emitting websocket event: metadata" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="sending successful reply for delaer request" Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","name":"Nasty","artist_names":["S3RL","5H4RK80Y","Thylie"],"album_name":"Nasty","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","position":0,"duration":177312,"release_date":"year:2020 month:3 day:4","track_number":1,"disc_number":1}} Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","name":"Nasty","artist_names":["S3RL","5H4RK80Y","Thylie"],"album_name":"Nasty","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","position":0,"duration":177312,"release_date":"year:2020 month:3 day:4","track_number":1,"disc_number":1}} Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="fetched chunk 1/16, size: 524288" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:07 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:07+01:00" level=trace msg="emitting websocket event: paused" Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:07 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:07 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:07 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService pause Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:07 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:07 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:07 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:07 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService pause Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:07 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:07 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:07 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:08 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:08+01:00" level=debug msg="fetched chunk 2/16, size: 524288" Dec 01 16:50:08 kcs-radio volumio[1174]: info: + geo-tz@8.1.2 Dec 01 16:50:08 kcs-radio volumio[1174]: info: added 29 packages from 33 contributors and audited 353 packages in 54.113s Dec 01 16:50:09 kcs-radio volumio[1174]: info: Dec 01 16:50:09 kcs-radio volumio[1174]: info: 21 packages are looking for funding Dec 01 16:50:09 kcs-radio volumio[1174]: info: run `npm fund` for details Dec 01 16:50:09 kcs-radio volumio[1174]: info: Dec 01 16:50:09 kcs-radio volumio[1174]: info: found 11 vulnerabilities (5 low, 3 moderate, 3 high) Dec 01 16:50:09 kcs-radio volumio[1174]: info: run `npm audit fix` to fix them, or `npm audit` for details Dec 01 16:50:09 kcs-radio volumio[1174]: info: Creating user directories (if not exist) Dec 01 16:50:09 kcs-radio sudo[3899]: pam_unix(sudo:session): session closed for user root Dec 01 16:50:09 kcs-radio volumio[1174]: info: Now Playing plugin installed Dec 01 16:50:09 kcs-radio volumio[1174]: Plugin install end detected on script Dec 01 16:50:09 kcs-radio volumio[1174]: info: Install script completed Dec 01 16:50:09 kcs-radio volumio[1174]: info: Adding reference to registry Dec 01 16:50:09 kcs-radio volumio[1174]: info: Done installing plugin. Dec 01 16:50:09 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 01 16:50:09 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 01 16:50:09 kcs-radio volumio[1174]: info: Folder /tmp/plugins removed Dec 01 16:50:09 kcs-radio volumio[1174]: info: Folder /tmp/downloaded_plugin.zip removed Dec 01 16:50:09 kcs-radio volumio[1174]: info: Folder /data/temp removed Dec 01 16:50:12 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:12+01:00" level=debug msg="handling resume player command from fd112cc0910f8fd90d522168bb7cd8398b40f8e0" Dec 01 16:50:12 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:12+01:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" Dec 01 16:50:12 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:12+01:00" level=debug msg="resume track at -371ms" Dec 01 16:50:12 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:12+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:12 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:12+01:00" level=debug msg="sending successful reply for delaer request" Dec 01 16:50:12 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:12+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:12 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:12+01:00" level=trace msg="emitting websocket event: playing" Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:12 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService play Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:12 kcs-radio volumio[1174]: info: Received an update from plugin. extracting info from payload Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:12 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService play Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:12 kcs-radio volumio[1174]: info: Received an update from plugin. extracting info from payload Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:12 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService play Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:12 kcs-radio volumio[1174]: info: Received an update from plugin. extracting info from payload Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":0,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:12 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService play Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:12 kcs-radio volumio[1174]: info: Received an update from plugin. extracting info from payload Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:12 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:12 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:12 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:16 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:16+01:00" level=debug msg="handling pause player command from fd112cc0910f8fd90d522168bb7cd8398b40f8e0" Dec 01 16:50:16 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:16+01:00" level=debug msg="pause track at 4109ms" Dec 01 16:50:16 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:16+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:16 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:16+01:00" level=debug msg="sending successful reply for delaer request" Dec 01 16:50:16 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:16+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:16 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:16+01:00" level=trace msg="emitting websocket event: paused" Dec 01 16:50:16 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:16 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:16 kcs-radio volumio[1174]: SPOTIFY: {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":4000,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:16 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:16 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":4000,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:16 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService pause Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:16 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:16 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7d4Z68eO6swRqacMckcii8","play_origin":"go-librespot"}} Dec 01 16:50:16 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:16 kcs-radio volumio[1174]: SPOTIFY: {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":4000,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:16 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:16 kcs-radio volumio[1174]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Nasty","artist":"S3RL, 5H4RK80Y, Thylie","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d00001e02fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","seek":4000,"duration":177,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:16 kcs-radio volumio[1174]: verbose: CURRENT POSITION 9 Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreStateMachine::syncState stateService pause Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreStateMachine::syncState currentStatus play Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:16 kcs-radio volumio[1174]: info: CorePlayQueue::getTrack 9 Dec 01 16:50:16 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:16 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:16 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:19 kcs-radio volumiologrotate[758]: ls: cannot access '/var/log/samba/log.wb-KCS': No such file or directory Dec 01 16:50:19 kcs-radio volumiologrotate[758]: ls: cannot access 'RADIO': No such file or directory Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="handling play player command from fd112cc0910f8fd90d522168bb7cd8398b40f8e0" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=trace msg="fetched new page 0 with 34 items (list: 34)" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="loading track spotify:track:7q63yCksfLtOYFC6LoXR7n (paused: false, position: 1ms)" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=trace msg="emitting websocket event: will_play" Dec 01 16:50:20 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","play_origin":"playlist"}} Dec 01 16:50:20 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","play_origin":"playlist"}} Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:7q63yCksfLtOYFC6LoXR7n" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="requested aes key for file 89d4ca9635795f2b81f2fef47ced1f60e4574a0c, gid: 7q63yCksfLtOYFC6LoXR7n" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="fetched first chunk of 13, total size is 6441980 bytes" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=trace msg="seek to 1ms (diff: 1ms, samples: 44, bytes: 0)" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=info msg="loaded track \"T.N.T - REMIX\" (uri: spotify:track:7q63yCksfLtOYFC6LoXR7n, paused: false, position: 1ms, duration: 133118ms)" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="fetched chunk 3/12, size: 524288" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="fetched chunk 2/12, size: 524288" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=trace msg="emitting websocket event: metadata" Dec 01 16:50:20 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:20+01:00" level=debug msg="sending successful reply for delaer request" Dec 01 16:50:20 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","name":"T.N.T - REMIX","artist_names":["Audenmatic"],"album_name":"T.N.T (REMIX)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","position":1,"duration":133118,"release_date":"year:2022 month:7 day:6","track_number":1,"disc_number":1}} Dec 01 16:50:21 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:21+01:00" level=debug msg="fetched chunk 1/12, size: 524288" Dec 01 16:50:21 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:21+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:21 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:21+01:00" level=trace msg="emitting websocket event: playing" Dec 01 16:50:21 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:21+01:00" level=debug msg="handling update_context player command from fd112cc0910f8fd90d522168bb7cd8398b40f8e0" Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","play_origin":"playlist"}} Dec 01 16:50:21 kcs-radio volumio[1174]: info: Spotify is playing in volatile mode Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: UNSET VOLATILE Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","position":9,"title":"Nasty","artist":"S3RL","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d0000b273fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","codec":"ogg","seek":4006,"duration":177,"samplerate":"320 kbps","bitdepth":"16 bit","channels":2,"random":false,"repeat":null,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Dec 01 16:50:21 kcs-radio volumio[1174]: info: Setting Spotify stop after unset volatile call Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","seek":1,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","play_origin":"playlist"}} Dec 01 16:50:21 kcs-radio volumio[1174]: info: Spotify is playing in volatile mode Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: UNSET VOLATILE Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","position":9,"title":"Nasty","artist":"S3RL","album":"Nasty","albumart":"https://i.scdn.co/image/ab67616d0000b273fea06a176fc4a1fc0504f0cd","uri":"spotify:track:7d4Z68eO6swRqacMckcii8","trackType":"spotify","codec":"ogg","seek":4006,"duration":177,"samplerate":"320 kbps","bitdepth":"16 bit","channels":2,"random":false,"repeat":null,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"spotify","volatile":false,"service":"spop"} Dec 01 16:50:21 kcs-radio volumio[1174]: info: Setting Spotify stop after unset volatile call Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","seek":1,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:21 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:21+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:21 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:21+01:00" level=debug msg="sending successful reply for delaer request" Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","seek":1,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","seek":1,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:21 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:21 kcs-radio volumio[1174]: info: Spotify Stop Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: SPOTIFY STOP Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","codec":"ogg","seek":1,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":100,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"volatile":true,"service":"spop"} Dec 01 16:50:21 kcs-radio volumio[1174]: info: Spotify Stop Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: SPOTIFY STOP Dec 01 16:50:21 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","codec":"ogg","seek":1,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":100,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"volatile":true,"service":"spop"} Dec 01 16:50:31 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:31+01:00" level=debug msg="handling pause player command from fd112cc0910f8fd90d522168bb7cd8398b40f8e0" Dec 01 16:50:31 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:31+01:00" level=debug msg="pause track at 10775ms" Dec 01 16:50:31 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:31+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:31 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:31+01:00" level=debug msg="sending successful reply for delaer request" Dec 01 16:50:31 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:31+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:50:31 kcs-radio go-librespot[2201]: time="2024-12-01T16:50:31+01:00" level=trace msg="emitting websocket event: paused" Dec 01 16:50:31 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","play_origin":"playlist"}} Dec 01 16:50:31 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:31 kcs-radio volumio[1174]: SPOTIFY: {"status":"pause","service":"spop","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","seek":10001,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Dec 01 16:50:31 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:31 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:31 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:50:31 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:31 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","play_origin":"playlist"}} Dec 01 16:50:31 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:50:31 kcs-radio volumio[1174]: SPOTIFY: {"status":"pause","service":"spop","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","seek":10001,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Dec 01 16:50:31 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:50:31 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:50:31 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:50:31 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:31 kcs-radio volumio[1174]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 01 16:50:31 kcs-radio volumio[1174]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 01 16:50:41 kcs-radio volumio[1174]: info: Enabling plugin now_playing Dec 01 16:50:41 kcs-radio volumio[1174]: info: Loading plugin "now_playing"... Dec 01 16:50:41 kcs-radio volumio[1174]: error: !!!! WARNING !!!! Dec 01 16:50:41 kcs-radio volumio[1174]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error [ERR_REQUIRE_ESM]: Must use import to load ES Module: /data/plugins/user_interface/now_playing/node_modules/point-in-polygon-hao/dist/pointInPolygon.mjs Dec 01 16:50:41 kcs-radio volumio[1174]: error: Stack trace: Error [ERR_REQUIRE_ESM]: Must use import to load ES Module: /data/plugins/user_interface/now_playing/node_modules/point-in-polygon-hao/dist/pointInPolygon.mjs Dec 01 16:50:41 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:926:11) Dec 01 16:50:41 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:41 kcs-radio volumio[1174]: at Module.require (internal/modules/cjs/loader.js:952:19) Dec 01 16:50:41 kcs-radio volumio[1174]: at require (internal/modules/cjs/helpers.js:88:18) Dec 01 16:50:41 kcs-radio volumio[1174]: at Object. (/data/plugins/user_interface/now_playing/node_modules/@turf/boolean-point-in-polygon/dist/cjs/index.cjs:2:26) Dec 01 16:50:41 kcs-radio volumio[1174]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Dec 01 16:50:41 kcs-radio volumio[1174]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Dec 01 16:50:41 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:928:32) Dec 01 16:50:41 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:41 kcs-radio volumio[1174]: at Module.require (internal/modules/cjs/loader.js:952:19) Dec 01 16:50:41 kcs-radio volumio[1174]: at require (internal/modules/cjs/helpers.js:88:18) Dec 01 16:50:41 kcs-radio volumio[1174]: at Object. (/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/find-1970.js:1:61) Dec 01 16:50:41 kcs-radio volumio[1174]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Dec 01 16:50:41 kcs-radio volumio[1174]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Dec 01 16:50:41 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:928:32) Dec 01 16:50:41 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:41 kcs-radio volumio[1174]: error: !!!! WARNING !!!! Dec 01 16:50:41 kcs-radio volumio[1174]: info: Done. Dec 01 16:50:43 kcs-radio volumio[1174]: info: Enabling plugin now_playing Dec 01 16:50:43 kcs-radio volumio[1174]: info: Loading plugin "now_playing"... Dec 01 16:50:43 kcs-radio volumio[1174]: error: !!!! WARNING !!!! Dec 01 16:50:43 kcs-radio volumio[1174]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error [ERR_REQUIRE_ESM]: Must use import to load ES Module: /data/plugins/user_interface/now_playing/node_modules/point-in-polygon-hao/dist/pointInPolygon.mjs Dec 01 16:50:43 kcs-radio volumio[1174]: error: Stack trace: Error [ERR_REQUIRE_ESM]: Must use import to load ES Module: /data/plugins/user_interface/now_playing/node_modules/point-in-polygon-hao/dist/pointInPolygon.mjs Dec 01 16:50:43 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:926:11) Dec 01 16:50:43 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:43 kcs-radio volumio[1174]: at Module.require (internal/modules/cjs/loader.js:952:19) Dec 01 16:50:43 kcs-radio volumio[1174]: at require (internal/modules/cjs/helpers.js:88:18) Dec 01 16:50:43 kcs-radio volumio[1174]: at Object. (/data/plugins/user_interface/now_playing/node_modules/@turf/boolean-point-in-polygon/dist/cjs/index.cjs:2:26) Dec 01 16:50:43 kcs-radio volumio[1174]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Dec 01 16:50:43 kcs-radio volumio[1174]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Dec 01 16:50:43 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:928:32) Dec 01 16:50:43 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:43 kcs-radio volumio[1174]: at Module.require (internal/modules/cjs/loader.js:952:19) Dec 01 16:50:43 kcs-radio volumio[1174]: at require (internal/modules/cjs/helpers.js:88:18) Dec 01 16:50:43 kcs-radio volumio[1174]: at Object. (/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/find-1970.js:1:61) Dec 01 16:50:43 kcs-radio volumio[1174]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Dec 01 16:50:43 kcs-radio volumio[1174]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Dec 01 16:50:43 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:928:32) Dec 01 16:50:43 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:43 kcs-radio volumio[1174]: error: !!!! WARNING !!!! Dec 01 16:50:43 kcs-radio volumio[1174]: info: Error: TypeError: Cannot read property 'printToastMessage' of null Dec 01 16:50:44 kcs-radio volumio[1174]: info: Enabling plugin now_playing Dec 01 16:50:44 kcs-radio volumio[1174]: info: Loading plugin "now_playing"... Dec 01 16:50:44 kcs-radio volumio[1174]: error: !!!! WARNING !!!! Dec 01 16:50:44 kcs-radio volumio[1174]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error [ERR_REQUIRE_ESM]: Must use import to load ES Module: /data/plugins/user_interface/now_playing/node_modules/point-in-polygon-hao/dist/pointInPolygon.mjs Dec 01 16:50:44 kcs-radio volumio[1174]: error: Stack trace: Error [ERR_REQUIRE_ESM]: Must use import to load ES Module: /data/plugins/user_interface/now_playing/node_modules/point-in-polygon-hao/dist/pointInPolygon.mjs Dec 01 16:50:44 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:926:11) Dec 01 16:50:44 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:44 kcs-radio volumio[1174]: at Module.require (internal/modules/cjs/loader.js:952:19) Dec 01 16:50:44 kcs-radio volumio[1174]: at require (internal/modules/cjs/helpers.js:88:18) Dec 01 16:50:44 kcs-radio volumio[1174]: at Object. (/data/plugins/user_interface/now_playing/node_modules/@turf/boolean-point-in-polygon/dist/cjs/index.cjs:2:26) Dec 01 16:50:44 kcs-radio volumio[1174]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Dec 01 16:50:44 kcs-radio volumio[1174]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Dec 01 16:50:44 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:928:32) Dec 01 16:50:44 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:44 kcs-radio volumio[1174]: at Module.require (internal/modules/cjs/loader.js:952:19) Dec 01 16:50:44 kcs-radio volumio[1174]: at require (internal/modules/cjs/helpers.js:88:18) Dec 01 16:50:44 kcs-radio volumio[1174]: at Object. (/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/find-1970.js:1:61) Dec 01 16:50:44 kcs-radio volumio[1174]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Dec 01 16:50:44 kcs-radio volumio[1174]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Dec 01 16:50:44 kcs-radio volumio[1174]: at Module.load (internal/modules/cjs/loader.js:928:32) Dec 01 16:50:44 kcs-radio volumio[1174]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Dec 01 16:50:44 kcs-radio volumio[1174]: error: !!!! WARNING !!!! Dec 01 16:50:44 kcs-radio volumio[1174]: info: Error: TypeError: Cannot read property 'printToastMessage' of null Dec 01 16:50:53 kcs-radio volumio[1174]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 01 16:50:54 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 01 16:50:54 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 01 16:51:03 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 01 16:51:08 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioVolatilePlay Dec 01 16:51:08 kcs-radio volumio[1174]: info: CoreStateMachine::volatilePlay Dec 01 16:51:08 kcs-radio volumio[1174]: info: Spotify Play Dec 01 16:51:08 kcs-radio volumio[1174]: info: Sending Spotify command to local API: /player/resume Dec 01 16:51:08 kcs-radio go-librespot[2201]: time="2024-12-01T16:51:08+01:00" level=trace msg="seek to 10775ms (diff: 59ms, samples: 475177, bytes: 400037)" Dec 01 16:51:08 kcs-radio go-librespot[2201]: time="2024-12-01T16:51:08+01:00" level=debug msg="resume track at 10716ms" Dec 01 16:51:08 kcs-radio go-librespot[2201]: time="2024-12-01T16:51:08+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:51:08 kcs-radio go-librespot[2201]: time="2024-12-01T16:51:08+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 01 16:51:08 kcs-radio go-librespot[2201]: time="2024-12-01T16:51:08+01:00" level=trace msg="emitting websocket event: playing" Dec 01 16:51:08 kcs-radio volumio[1174]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","play_origin":"playlist"}} Dec 01 16:51:08 kcs-radio volumio[1174]: SPOTIFY: PUSH STATE SPOTIFY Dec 01 16:51:08 kcs-radio volumio[1174]: SPOTIFY: {"status":"play","service":"spop","title":"T.N.T - REMIX","artist":"Audenmatic","album":"T.N.T (REMIX)","albumart":"https://i.scdn.co/image/ab67616d00001e024f62ed077a2212e6a9ebc875","uri":"spotify:track:7q63yCksfLtOYFC6LoXR7n","trackType":"spotify","seek":10001,"duration":133,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Dec 01 16:51:08 kcs-radio volumio[1174]: info: CoreCommandRouter::servicePushState Dec 01 16:51:08 kcs-radio volumio[1174]: info: CoreStateMachine::pushState Dec 01 16:51:08 kcs-radio volumio[1174]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 16:51:08 kcs-radio volumio[1174]: info: CoreCommandRouter::volumioPushState Dec 01 16:51:08 kcs-radio volumio[1174]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 16:51:08 kcs-radio volumio[1174]: TypeError: Cannot read property 'pushState' of null Dec 01 16:51:08 kcs-radio volumio[1174]: at /volumio/app/index.js:327:32 Dec 01 16:51:08 kcs-radio volumio[1174]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Dec 01 16:51:08 kcs-radio volumio[1174]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Dec 01 16:51:08 kcs-radio volumio[1174]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:325:13) Dec 01 16:51:08 kcs-radio volumio[1174]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:530:22) Dec 01 16:51:08 kcs-radio volumio[1174]: at CoreStateMachine.syncState (/volumio/app/statemachine.js:591:10) Dec 01 16:51:08 kcs-radio volumio[1174]: at CoreCommandRouter.servicePushState (/volumio/app/index.js:415:28) Dec 01 16:51:08 kcs-radio volumio[1174]: at ControllerSpotify.pushState (/data/plugins/music_service/spop/index.js:429:31) Dec 01 16:51:08 kcs-radio volumio[1174]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:319:14) Dec 01 16:51:08 kcs-radio volumio[1174]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) Dec 01 16:51:08 kcs-radio volumio[1174]: at WebSocket.emit (events.js:315:20) Dec 01 16:51:08 kcs-radio volumio[1174]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1203:20) Dec 01 16:51:08 kcs-radio volumio[1174]: at Receiver.emit (events.js:315:20) Dec 01 16:51:08 kcs-radio volumio[1174]: at /data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:608:16 Dec 01 16:51:08 kcs-radio volumio[1174]: at internal/process/task_queues.js:149:7 Dec 01 16:51:08 kcs-radio volumio[1174]: at AsyncResource.runInAsyncScope (async_hooks.js:197:9) Dec 01 16:51:08 kcs-radio volumio[1174]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 16:51:09 kcs-radio sudo[4215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 16:50 Dec 01 16:51:09 kcs-radio sudo[4215]: 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"