-- Logs begin at Sun 2024-03-31 21:48:11 JST, end at Mon 2024-04-01 17:57:47 JST. -- Apr 01 17:56:10 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Apr 01 17:56:10 volumio-nec2 volumio[736]: info: In handleBrowseUri, curUri=spotify Apr 01 17:56:11 volumio-nec2 volumio[736]: info: New access token = BQDUUsWbWN68rOlQ9x6wntYe7Y0As6eA2SMe6Z89fCKXXqHAcxLNDqgvk0KyqrkNqqrPfspqp0IDcp_tQcDHDqMnUrtSBS7Mr2oVrEfjLtxVBc9a65IoO4E-aVoPEIdwYu_L3B3srmpVHkK20XjJID-YQIiK5cos1tfBux57ihOedMw7gDfZAqJEvokJ-nmVxC27yU2tq2MSrw-sBWbuZKe4nPplanBootMF2NgpNGfHqZXNmQ Apr 01 17:56:11 volumio-nec2 volumio[736]: info: New access token = BQAhjxwCYYHeq_lUFLFRoiwftgLoL-ThhpFUUWhAnuxHLwXhEaSR0ii9O7t3JsdNjsRHfAePT4sQ0AeyIqnMlIJrmikeyrCeLc5d18yhV2wNSC5uJKFico2k0v7zD_ta7nczm2mlMzdrlZgPPldCZW1xEmyT7OeikMuIdxKM1tSDZF6aCrTDwSnOA2XJoH72NNZrTXQox_QIHrGnsc3_FdIyXtSrXF4bYMIq0t0kmBxK6qxGxA Apr 01 17:56:11 volumio-nec2 volumio[736]: info: New access token = BQBGBnHivdC4AwHGLIp6fJJSYcNOCoGRG4r-Tb0cthxLF0JFqmDyiEVMGww1B4yKKyY8eFbZsq-EAXtC9c8BigZw5QEa1wk7ZOVk-qZYd9Ln4rru11eCxFaFQaBOQOWHdsmnOXp2izhnHknm6sNYtlFMDvBMmqRZqX6iM28f67OINnC4wkq93OQoUgGTPekmsPRS9eGVotwIaNg_qOS0rGq-VcjUvBxPHKuGhGxGhARdnpyP7g Apr 01 17:56:12 volumio-nec2 volumio[736]: info: Preload queue cleared Apr 01 17:56:12 volumio-nec2 volumio[736]: info: Preload queue cleared Apr 01 17:56:12 volumio-nec2 volumio[736]: info: Preload queue cleared Apr 01 17:56:34 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 1 Apr 01 17:56:34 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:34 volumio-nec2 volumio[736]: info: Prefetching next song Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=trace msg="emitting websocket event: not_playing" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="loading track spotify:track:4w968FSquXlt8YcLz0KmOI (paused: true, position: 0ms)" Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: error: Failed to decode event: not_playing Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: error: Failed to decode event: not_playing Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: error: Failed to decode event: not_playing Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: error: Failed to decode event: not_playing Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: error: Failed to decode event: not_playing Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=trace msg="emitting websocket event: will_play" Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:4w968FSquXlt8YcLz0KmOI" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="requested aes key for file 0bbf6458c5737949832c971985a44bd6f15046e8, gid: 4w968FSquXlt8YcLz0KmOI" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="fetched first chunk of 15, total size is 7826860 bytes" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=info msg="loaded track \"Without You\" (uri: spotify:track:4w968FSquXlt8YcLz0KmOI, paused: true, position: 0ms, duration: 202066ms)" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="fetched chunk 1/14, size: 524288" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=trace msg="emitting websocket event: metadata" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=trace msg="emitting websocket event: stopped" Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","name":"Without You","artist_names":["Harry Nilsson"],"album_name":"The Essential Nilsson","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","position":0,"duration":202066,"release_date":"year:2013 month:4 day:30","track_number":2,"disc_number":2}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 1 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 1 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 1 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::play index undefined Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::startPlaybackTimer Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: [1711961798724] ControllerSpotify::clearAddPlayTrack Apr 01 17:56:38 volumio-nec2 volumio[736]: info: Sending Spotify command with payload to local API: /player/play Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","name":"Without You","artist_names":["Harry Nilsson"],"album_name":"The Essential Nilsson","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","position":0,"duration":202066,"release_date":"year:2013 month:4 day:30","track_number":2,"disc_number":2}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: No code Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","name":"Without You","artist_names":["Harry Nilsson"],"album_name":"The Essential Nilsson","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","position":0,"duration":202066,"release_date":"year:2013 month:4 day:30","track_number":2,"disc_number":2}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: No code Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","name":"Without You","artist_names":["Harry Nilsson"],"album_name":"The Essential Nilsson","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","position":0,"duration":202066,"release_date":"year:2013 month:4 day:30","track_number":2,"disc_number":2}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: No code Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: No code Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=trace msg="emitting websocket event: paused" Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService pause Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:38+09:00" level=debug msg="fetched chunk 3/14, size: 524288" Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService pause Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService pause Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService pause Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","play_origin":"go-librespot"}} Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Without You","artist":"Harry Nilsson","album":"The Essential Nilsson","albumart":"https://i.scdn.co/image/ab67616d00001e0267098b1bc6c319a2e92cf9ed","uri":"spotify:track:4w968FSquXlt8YcLz0KmOI","trackType":"spotify","seek":0,"duration":202,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:38 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService pause Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:38 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:38 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=trace msg="fetched new page 0 with 1 items (list: 1)" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="loading track spotify:track:0pQskrTITgmCMyr85tb9qq (paused: false, position: 0ms)" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="fetched chunk 2/14, size: 524288" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=trace msg="emitting websocket event: will_play" Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","play_origin":"go-librespot"}} Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:0pQskrTITgmCMyr85tb9qq" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="requested aes key for file 1121f05b00e11eb2b55f536a19eb1bdaa44b0906, gid: 0pQskrTITgmCMyr85tb9qq" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="fetched first chunk of 22, total size is 11137660 bytes" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=info msg="loaded track \"Starman - 2012 Remaster\" (uri: spotify:track:0pQskrTITgmCMyr85tb9qq, paused: false, position: 0ms, duration: 254293ms)" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="fetched chunk 1/21, size: 524288" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=trace msg="emitting websocket event: metadata" Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","name":"Starman - 2012 Remaster","artist_names":["David Bowie"],"album_name":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","position":0,"duration":254293,"release_date":"year:1972 month:6 day:6","track_number":4,"disc_number":1}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","name":"Starman - 2012 Remaster","artist_names":["David Bowie"],"album_name":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","position":0,"duration":254293,"release_date":"year:1972 month:6 day:6","track_number":4,"disc_number":1}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","name":"Starman - 2012 Remaster","artist_names":["David Bowie"],"album_name":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","position":0,"duration":254293,"release_date":"year:1972 month:6 day:6","track_number":4,"disc_number":1}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","name":"Starman - 2012 Remaster","artist_names":["David Bowie"],"album_name":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","position":0,"duration":254293,"release_date":"year:1972 month:6 day:6","track_number":4,"disc_number":1}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","name":"Starman - 2012 Remaster","artist_names":["David Bowie"],"album_name":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","position":0,"duration":254293,"release_date":"year:1972 month:6 day:6","track_number":4,"disc_number":1}} Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="fetched chunk 2/21, size: 524288" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=trace msg="emitting websocket event: playing" Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","play_origin":"go-librespot"}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus stop Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","play_origin":"go-librespot"}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","play_origin":"go-librespot"}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","play_origin":"go-librespot"}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","play_origin":"go-librespot"}} Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:39 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:39 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:39 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:39 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:39+09:00" level=debug msg="fetched chunk 3/21, size: 524288" Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: PUSH STATE SPOTIFY Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::servicePushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Starman - 2012 Remaster","artist":"David Bowie","album":"The Rise and Fall of Ziggy Stardust and the Spiders from Mars (2012 Remaster)","albumart":"https://i.scdn.co/image/ab67616d00001e02c41f4e1133b0e6c5fcf58680","uri":"spotify:track:0pQskrTITgmCMyr85tb9qq","trackType":"spotify","seek":0,"duration":254,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Apr 01 17:56:40 volumio-nec2 volumio[736]: verbose: CURRENT POSITION 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState stateService play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::syncState currentStatus play Apr 01 17:56:40 volumio-nec2 volumio[736]: info: Received an update from plugin. extracting info from payload Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreStateMachine::pushState Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CorePlayQueue::getTrack 9 Apr 01 17:56:40 volumio-nec2 volumio[736]: info: CoreCommandRouter::volumioPushState Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: SPOTIFY VOLUME 95 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: VOLUMIO VOLUME 94 Apr 01 17:56:40 volumio-nec2 volumio[736]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 01 17:56:48 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:56:48+09:00" level=debug msg="fetched chunk 4/21, size: 524288" Apr 01 17:56:57 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Apr 01 17:56:57 volumio-nec2 volumio[736]: info: In handleBrowseUri, curUri=spotify/myrecentlyplayedtracks Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preload queue cleared Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:1BxfuPKGuaTgP7aM0Bbdwr Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:214nt20w5wOxJnY462klLw Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:1BxfuPKGuaTgP7aM0Bbdwr Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:7KokYm8cMIXCsGVmUvKtqf Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:0V3wPSX9ygBnCm8psDIegu Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:07dut38KBuz2lYDyym4VPU Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:6uM4SaDYG8Fjc4d6DChQeV Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:16LChLU4hz7wFSzfVStG7r Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:54wtOsJzO3ZfbX60vWmbX8 Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:5Kxt2UYC2JIlcAQwMPgYpB Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:1k9O82DQH96aFUrMr1BjYN Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:3Vkuujcxs4XiqJTP81L24D Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:31Hr4qk9qRCUWsMmK2Ni5F Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:1JfC3yCZY2FqcvThDadJeP Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:7BuxfPbJjtI8juuM3h18yA Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:15tMFCvZxzi01VlIzQ3jM1 Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:0VkF6gTO6BUr289xgX7KqH Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:0dLmIlajXTIk5vfyU3ArMB Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:4MpIgtozqPyjH2BJEa05yO Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:4MSauDmuhCUv1jYzlBiFUr Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:3eBGQbYMSbXFyUnzjeLERf Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:1fVf23RO21Nw9rUQTM7N9P Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:08vpJLMyKhYe5RZa5TVgRe Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:1U06PhP5wL6xLA5eg0ZiFt Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:0i0JuzUCKCTd2DAdk1yTed Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:18kGOfLsyx9YhSa6X8nfQi Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:40riOy7x9W7GXjyGp4pjAv Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:323T2HbSmP5c3S8IdFSa6H Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:3cWgx99QRojPkXD6tHKW0r Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:29yuNhj7SOW6XmOIMJDLZ8 Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:59kcIJpn03CfqFyZRuiRrm Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:4WWno8ycBsLjLpwDkP5veS Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:5G994fn8VNNtY0e54KmV03 Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:0L8LzQeQiSboAiv7ewqRkL Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:28GTEwX8zdRyIdctjlzwuy Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:7DRPtopaIdPelkB1fNB7Dy Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:51U43w7UpqKkOK95PWn2pB Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Preloading song: spotify:track:2fnnbne12pt1I7wsTVcKY1 Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:1BxfuPKGuaTgP7aM0Bbdwr in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:1BxfuPKGuaTgP7aM0Bbdwr Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:214nt20w5wOxJnY462klLw in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:214nt20w5wOxJnY462klLw Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:1BxfuPKGuaTgP7aM0Bbdwr in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:1BxfuPKGuaTgP7aM0Bbdwr Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:1BxfuPKGuaTgP7aM0Bbdwr in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:1BxfuPKGuaTgP7aM0Bbdwr Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:7KokYm8cMIXCsGVmUvKtqf in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:7KokYm8cMIXCsGVmUvKtqf Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:0V3wPSX9ygBnCm8psDIegu in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:0V3wPSX9ygBnCm8psDIegu Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1BxfuPKGuaTgP7aM0Bbdwr","service":"spop","name":"Cruel Summer","artist":"Taylor Swift","album":"Lover","type":"song","duration":178,"albumart":"https://i.scdn.co/image/ab67616d0000b273e787cffec20aa2a396a61647","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:214nt20w5wOxJnY462klLw","service":"spop","name":"Miss Americana & The Heartbreak Prince","artist":"Taylor Swift","album":"Lover","type":"song","duration":234,"albumart":"https://i.scdn.co/image/ab67616d0000b273e787cffec20aa2a396a61647","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:07dut38KBuz2lYDyym4VPU in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:07dut38KBuz2lYDyym4VPU Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:6uM4SaDYG8Fjc4d6DChQeV in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:6uM4SaDYG8Fjc4d6DChQeV Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1BxfuPKGuaTgP7aM0Bbdwr","service":"spop","name":"Cruel Summer","artist":"Taylor Swift","album":"Lover","type":"song","duration":178,"albumart":"https://i.scdn.co/image/ab67616d0000b273e787cffec20aa2a396a61647","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1BxfuPKGuaTgP7aM0Bbdwr","service":"spop","name":"Cruel Summer","artist":"Taylor Swift","album":"Lover","type":"song","duration":178,"albumart":"https://i.scdn.co/image/ab67616d0000b273e787cffec20aa2a396a61647","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:16LChLU4hz7wFSzfVStG7r in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:16LChLU4hz7wFSzfVStG7r Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7KokYm8cMIXCsGVmUvKtqf","service":"spop","name":"Karma","artist":"Taylor Swift","album":"Midnights","type":"song","duration":204,"albumart":"https://i.scdn.co/image/ab67616d0000b273bb54dde68cd23e2a268ae0f5","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:54wtOsJzO3ZfbX60vWmbX8 in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:54wtOsJzO3ZfbX60vWmbX8 Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0V3wPSX9ygBnCm8psDIegu","service":"spop","name":"Anti-Hero","artist":"Taylor Swift","album":"Midnights","type":"song","duration":200,"albumart":"https://i.scdn.co/image/ab67616d0000b273bb54dde68cd23e2a268ae0f5","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:5Kxt2UYC2JIlcAQwMPgYpB in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:5Kxt2UYC2JIlcAQwMPgYpB Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:07dut38KBuz2lYDyym4VPU","service":"spop","name":"贈る言葉","artist":"Kaientai","album":"倭人傳","type":"song","duration":244,"albumart":"https://i.scdn.co/image/ab67616d0000b273746eaf61b8fd680517e6b297","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:1k9O82DQH96aFUrMr1BjYN in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:1k9O82DQH96aFUrMr1BjYN Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:16LChLU4hz7wFSzfVStG7r","service":"spop","name":"カサブランカ・ダンディ","artist":"Kenji Sawada","album":"ROYAL STRAIGHT FLUSH","type":"song","duration":269,"albumart":"https://i.scdn.co/image/ab67616d0000b273e5689250390f66506f5b7f10","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:6uM4SaDYG8Fjc4d6DChQeV","service":"spop","name":"渚のシンドバッド","artist":"Pink Lady","album":"ベスト・ヒット・アルバム","type":"song","duration":155,"albumart":"https://i.scdn.co/image/ab67616d0000b2736869717283503e5031e8006a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:3Vkuujcxs4XiqJTP81L24D in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:3Vkuujcxs4XiqJTP81L24D Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:54wtOsJzO3ZfbX60vWmbX8","service":"spop","name":"迷い道","artist":"Machiko Watanabe","album":"2000 BEST　渡辺真知子","type":"song","duration":181,"albumart":"https://i.scdn.co/image/ab67616d0000b273ac8d97a75cdbe021e1952a62","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5Kxt2UYC2JIlcAQwMPgYpB","service":"spop","name":"大空と大地の中で","artist":"Chiharu Matsuyama","album":"松山千春ベスト32","type":"song","duration":241,"albumart":"https://i.scdn.co/image/ab67616d0000b273a33935ceee1434bf2e2cd113","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:31Hr4qk9qRCUWsMmK2Ni5F in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:31Hr4qk9qRCUWsMmK2Ni5F Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:1JfC3yCZY2FqcvThDadJeP in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:1JfC3yCZY2FqcvThDadJeP Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:7BuxfPbJjtI8juuM3h18yA in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:7BuxfPbJjtI8juuM3h18yA Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1k9O82DQH96aFUrMr1BjYN","service":"spop","name":"ガンダーラ","artist":"Godiego","album":"ガンダーラ","type":"song","duration":247,"albumart":"https://i.scdn.co/image/ab67616d0000b27300dc36cea0d18bf701b23fa1","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:15tMFCvZxzi01VlIzQ3jM1 in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:15tMFCvZxzi01VlIzQ3jM1 Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3Vkuujcxs4XiqJTP81L24D","service":"spop","name":"よろしく哀愁","artist":"Hiromi Go","album":"ALL THE SINGLES 1972-1997","type":"song","duration":174,"albumart":"https://i.scdn.co/image/ab67616d0000b273adae62e0ae1c4554e2aad27d","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:31Hr4qk9qRCUWsMmK2Ni5F","service":"spop","name":"シクラメンのかほり","artist":"Akira Fuse","album":"エッセンシャル・ベスト 布施明","type":"song","duration":284,"albumart":"https://i.scdn.co/image/ab67616d0000b273caab4a52795c3348e377275f","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:58 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:0VkF6gTO6BUr289xgX7KqH in service spop Apr 01 17:56:58 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:0VkF6gTO6BUr289xgX7KqH Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:0dLmIlajXTIk5vfyU3ArMB in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:0dLmIlajXTIk5vfyU3ArMB Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1JfC3yCZY2FqcvThDadJeP","service":"spop","name":"春一番","artist":"キャンディーズ","album":"キャンディーズ1676日","type":"song","duration":200,"albumart":"https://i.scdn.co/image/ab67616d0000b2739024c8c1917ab3ceade3c505","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:4MpIgtozqPyjH2BJEa05yO in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:4MpIgtozqPyjH2BJEa05yO Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7BuxfPbJjtI8juuM3h18yA","service":"spop","name":"September","artist":"Mariya Takeuchi","album":"Expressions","type":"song","duration":272,"albumart":"https://i.scdn.co/image/ab67616d0000b273a2ba2561e0d133a958a53fca","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0VkF6gTO6BUr289xgX7KqH","service":"spop","name":"秋桜","artist":"Momoe Yamaguchi","album":"花ざかり","type":"song","duration":216,"albumart":"https://i.scdn.co/image/ab67616d0000b2736e308a42a3ef9b759f3cd42d","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:4MSauDmuhCUv1jYzlBiFUr in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:4MSauDmuhCUv1jYzlBiFUr Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:3eBGQbYMSbXFyUnzjeLERf in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:3eBGQbYMSbXFyUnzjeLERf Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:15tMFCvZxzi01VlIzQ3jM1","service":"spop","name":"勝手にしやがれ","artist":"Kenji Sawada","album":"思いきり気障な人生","type":"song","duration":210,"albumart":"https://i.scdn.co/image/ab67616d0000b2730413176f98227453fae08d6a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0dLmIlajXTIk5vfyU3ArMB","service":"spop","name":"かもめが翔んだ日","artist":"Machiko Watanabe","album":"2000 BEST　渡辺真知子","type":"song","duration":194,"albumart":"https://i.scdn.co/image/ab67616d0000b273ac8d97a75cdbe021e1952a62","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:1fVf23RO21Nw9rUQTM7N9P in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:1fVf23RO21Nw9rUQTM7N9P Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4MpIgtozqPyjH2BJEa05yO","service":"spop","name":"時間よ止まれ - Remastered 2022","artist":"Eikichi Yazawa","album":"ゴールドラッシュ (50th Anniversary Remastered)","type":"song","duration":267,"albumart":"https://i.scdn.co/image/ab67616d0000b273e211d5df5e28b3b012f3d5bc","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4MSauDmuhCUv1jYzlBiFUr","service":"spop","name":"チャンピオン","artist":"Alice","album":"アリス VII","type":"song","duration":250,"albumart":"https://i.scdn.co/image/ab67616d0000b2737a9c579fc04845c23216a311","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:08vpJLMyKhYe5RZa5TVgRe in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:08vpJLMyKhYe5RZa5TVgRe Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:1U06PhP5wL6xLA5eg0ZiFt in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:1U06PhP5wL6xLA5eg0ZiFt Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3eBGQbYMSbXFyUnzjeLERf","service":"spop","name":"あの素晴しい愛をもう一度","artist":"Kazuhiko Kato","album":"フォーク・ベスト　～あの素晴らしい愛をもう一度","type":"song","duration":192,"albumart":"https://i.scdn.co/image/ab67616d0000b2736dd5eee582dac12a94eeca1b","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:0i0JuzUCKCTd2DAdk1yTed in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:0i0JuzUCKCTd2DAdk1yTed Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1fVf23RO21Nw9rUQTM7N9P","service":"spop","name":"愛のメモリー","artist":"Shigeru Matsuzaki","album":"エッセンシャル・ベスト　松崎しげる","type":"song","duration":239,"albumart":"https://i.scdn.co/image/ab67616d0000b2735460a108888e7901b43a7408","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:18kGOfLsyx9YhSa6X8nfQi in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:18kGOfLsyx9YhSa6X8nfQi Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1U06PhP5wL6xLA5eg0ZiFt","service":"spop","name":"ガンダーラ","artist":"Godiego","album":"GODIEGO GREAT BEST VOL.1 -Japanese Version-","type":"song","duration":246,"albumart":"https://i.scdn.co/image/ab67616d0000b273fa20f00129606afcd3778c14","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:40riOy7x9W7GXjyGp4pjAv in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:40riOy7x9W7GXjyGp4pjAv Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:08vpJLMyKhYe5RZa5TVgRe","service":"spop","name":"まちぶせ","artist":"Hitomi Ishikawa","album":"40th 石川ひとみアンソロジー","type":"song","duration":219,"albumart":"https://i.scdn.co/image/ab67616d0000b273b8edd04e2094466573f0a7f1","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:323T2HbSmP5c3S8IdFSa6H in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:323T2HbSmP5c3S8IdFSa6H Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0i0JuzUCKCTd2DAdk1yTed","service":"spop","name":"関白宣言","artist":"Masashi Sada","album":"昨日達…","type":"song","duration":354,"albumart":"https://i.scdn.co/image/ab67616d0000b27354dbd6a4d46af19499de25f4","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:3cWgx99QRojPkXD6tHKW0r in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:3cWgx99QRojPkXD6tHKW0r Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:18kGOfLsyx9YhSa6X8nfQi","service":"spop","name":"あの鐘を鳴らすのはあなた","artist":"Akiko Wada","album":"あの鐘を鳴らすのはあなた","type":"song","duration":215,"albumart":"https://i.scdn.co/image/ab67616d0000b273ebb6d0aea4bc1a18d7ae9fc6","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:40riOy7x9W7GXjyGp4pjAv","service":"spop","name":"Hotel California - 2013 Remaster","artist":"Eagles","album":"Hotel California (2013 Remaster)","type":"song","duration":391,"albumart":"https://i.scdn.co/image/ab67616d0000b2734637341b9f507521afa9a778","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:29yuNhj7SOW6XmOIMJDLZ8 in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:29yuNhj7SOW6XmOIMJDLZ8 Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:323T2HbSmP5c3S8IdFSa6H","service":"spop","name":"また逢う日まで","artist":"Kiyohiko Ozaki","album":"ゴールデン☆ベスト 尾崎紀世彦","type":"song","duration":174,"albumart":"https://i.scdn.co/image/ab67616d0000b273bef3db73be137a3b21939718","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:59kcIJpn03CfqFyZRuiRrm in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:59kcIJpn03CfqFyZRuiRrm Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:3cWgx99QRojPkXD6tHKW0r","service":"spop","name":"アメリカン・フィーリング","artist":"CIRCUS","album":"サーカス アルファミュージック編 1978～1980","type":"song","duration":206,"albumart":"https://i.scdn.co/image/ab67616d0000b2734fa0f1c2e25d7e0f64501dc6","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:4WWno8ycBsLjLpwDkP5veS in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:4WWno8ycBsLjLpwDkP5veS Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:5G994fn8VNNtY0e54KmV03 in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:5G994fn8VNNtY0e54KmV03 Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:59kcIJpn03CfqFyZRuiRrm","service":"spop","name":"異邦人","artist":"Saki Kubota","album":"GOLDEN☆BEST / 久保田早紀","type":"song","duration":225,"albumart":"https://i.scdn.co/image/ab67616d0000b273cd8241b11928aaf663a92644","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:29yuNhj7SOW6XmOIMJDLZ8","service":"spop","name":"渚のシンドバッド","artist":"Pink Lady","album":"渚のシンドバッド","type":"song","duration":152,"albumart":"https://i.scdn.co/image/ab67616d0000b273bd28575730a27639da78e6e9","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:0L8LzQeQiSboAiv7ewqRkL in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:0L8LzQeQiSboAiv7ewqRkL Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4WWno8ycBsLjLpwDkP5veS","service":"spop","name":"愛を止めないで","artist":"Off Course","album":"Three and Two","type":"song","duration":233,"albumart":"https://i.scdn.co/image/ab67616d0000b273f3b75fbf990985942b89f6bd","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:28GTEwX8zdRyIdctjlzwuy in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:28GTEwX8zdRyIdctjlzwuy Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:7DRPtopaIdPelkB1fNB7Dy in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:7DRPtopaIdPelkB1fNB7Dy Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5G994fn8VNNtY0e54KmV03","service":"spop","name":"みずいろの雨","artist":"Junko Yagami","album":"みずいろの雨","type":"song","duration":204,"albumart":"https://i.scdn.co/image/ab67616d0000b2733ed4c3205a3bfd1df18668e0","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:51U43w7UpqKkOK95PWn2pB in service spop Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:51U43w7UpqKkOK95PWn2pB Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0L8LzQeQiSboAiv7ewqRkL","service":"spop","name":"魅せられて","artist":"Judy Ongg","album":"白の幻想","type":"song","duration":219,"albumart":"https://i.scdn.co/image/ab67616d0000b27317fc6fa76d9827d3c6d0803d","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:56:59 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:28GTEwX8zdRyIdctjlzwuy","service":"spop","name":"わかれうた","artist":"中島みゆき","album":"わかれうた","type":"song","duration":239,"albumart":"https://i.scdn.co/image/ab67616d0000b273182ed84dd960df09b5e102e7","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:57:00 volumio-nec2 volumio[736]: info: Exploding uri spotify:track:2fnnbne12pt1I7wsTVcKY1 in service spop Apr 01 17:57:00 volumio-nec2 volumio[736]: SPOTIFY: EXPLODING URI:spotify:track:2fnnbne12pt1I7wsTVcKY1 Apr 01 17:57:00 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7DRPtopaIdPelkB1fNB7Dy","service":"spop","name":"夢想花","artist":"Cherish","album":"夢想花","type":"song","duration":293,"albumart":"https://i.scdn.co/image/ab67616d0000b273d342f639926fed3343fe9dd1","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:57:00 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2fnnbne12pt1I7wsTVcKY1","service":"spop","name":"唇よ、熱く君を語れ","artist":"Machiko Watanabe","album":"Libra","type":"song","duration":233,"albumart":"https://i.scdn.co/image/ab67616d0000b2738f58582e1ac40ec44462283a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:57:00 volumio-nec2 volumio[736]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:51U43w7UpqKkOK95PWn2pB","service":"spop","name":"虹とスニーカーの頃","artist":"TULIP","album":"虹とスニーカーの頃","type":"song","duration":271,"albumart":"https://i.scdn.co/image/ab67616d0000b2736e68a9132454e3ca8c948a26","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Apr 01 17:57:00 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:57:00+09:00" level=debug msg="fetched chunk 5/21, size: 524288" Apr 01 17:57:11 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:57:11+09:00" level=debug msg="fetched chunk 6/21, size: 524288" Apr 01 17:57:24 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:57:24+09:00" level=debug msg="fetched chunk 7/21, size: 524288" Apr 01 17:57:31 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 01 17:57:31 volumio-nec2 volumio[736]: info: CURURI: genres:// Apr 01 17:57:31 volumio-nec2 volumio[736]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Apr 01 17:57:32 volumio-nec2 volumio[736]: info: Preload queue cleared Apr 01 17:57:35 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:57:35+09:00" level=debug msg="fetched chunk 8/21, size: 524288" Apr 01 17:57:39 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 01 17:57:39 volumio-nec2 volumio[736]: info: Preload queue cleared Apr 01 17:57:46 volumio-nec2 volumio[736]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 01 17:57:46 volumio-nec2 volumio[736]: error: Error browsing0:Error: Unexpected close tag Apr 01 17:57:46 volumio-nec2 volumio[736]: Line: 2 Apr 01 17:57:46 volumio-nec2 volumio[736]: Column: 7 Apr 01 17:57:46 volumio-nec2 volumio[736]: Char: > Apr 01 17:57:46 volumio-nec2 volumio[736]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 01 17:57:46 volumio-nec2 volumio[736]: Error: Text data outside of root node. Apr 01 17:57:46 volumio-nec2 volumio[736]: Line: 4 Apr 01 17:57:46 volumio-nec2 volumio[736]: Column: 1 Apr 01 17:57:46 volumio-nec2 volumio[736]: Char: A Apr 01 17:57:46 volumio-nec2 volumio[736]: at error (/volumio/node_modules/sax/lib/sax.js:651:10) Apr 01 17:57:46 volumio-nec2 volumio[736]: at strictFail (/volumio/node_modules/sax/lib/sax.js:677:7) Apr 01 17:57:46 volumio-nec2 volumio[736]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1035:15) Apr 01 17:57:46 volumio-nec2 volumio[736]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 01 17:57:46 volumio-nec2 volumio[736]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 01 17:57:46 volumio-nec2 volumio[736]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 01 17:57:46 volumio-nec2 volumio[736]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 01 17:57:46 volumio-nec2 volumio[736]: at IncomingMessage.emit (events.js:412:35) Apr 01 17:57:46 volumio-nec2 volumio[736]: at endReadableNT (internal/streams/readable.js:1333:12) Apr 01 17:57:46 volumio-nec2 volumio[736]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Apr 01 17:57:46 volumio-nec2 volumio[736]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 01 17:57:47 volumio-nec2 sudo[14927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-01 17:56 Apr 01 17:57:47 volumio-nec2 sudo[14927]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 01 17:57:47 volumio-nec2 go-librespot[11528]: time="2024-04-01T17:57:47+09:00" level=debug msg="fetched chunk 9/21, size: 524288" PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7b9cb4a8b52fb7148a38d6ac651c1c29e09bb92c" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="b1dcc17f6d31bf91f0abd3c3fa57506d1e0d2b6b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 01 Mar 2024 08:52:33 PM CET" VOLUMIO_VERSION="3.634" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="93edfc70711724967af109c0a39fa069"