-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2025-07-09 08:16:47 CEST. --
Jul 09 08:15:08 arjans-audio-walhalla volumio[998]: verbose: New Socket.io Connection to 192.168.68.51:3000 from 192.168.68.52 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Jul 09 08:15:09 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:09+02:00" level=debug msg="fetched chunk 16/20, size: 524288" uri="spotify:track:21ZTkAe7nw4kAR1aHyZXSx"
Jul 09 08:15:19 arjans-audio-walhalla volumiologrotate[631]: ls: cannot access "/var/log/samba/log.wb-ARJAN'S": No such file or directory
Jul 09 08:15:19 arjans-audio-walhalla volumiologrotate[631]: ls: cannot access 'AUDIO': No such file or directory
Jul 09 08:15:19 arjans-audio-walhalla volumiologrotate[631]: ls: cannot access 'WALHALLA': No such file or directory
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: verbose: New Socket.io Connection to 192.168.68.51 from 192.168.68.52 UA: Mozilla/5.0 (Linux; Android 14; SM-A528B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetQueue
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::getQueue
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CorePlayQueue::getQueue
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: Listing playlists
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: Received Get System Info
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: Discovery: Getting this device information
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:15:22 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 09 08:15:23 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:23+02:00" level=debug msg="fetched chunk 17/20, size: 524288" uri="spotify:track:21ZTkAe7nw4kAR1aHyZXSx"
Jul 09 08:15:28 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:28+02:00" level=trace msg="sent dealer ping"
Jul 09 08:15:28 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:28+02:00" level=trace msg="received dealer pong"
Jul 09 08:15:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:36+02:00" level=debug msg="fetched chunk 18/20, size: 524288" uri="spotify:track:21ZTkAe7nw4kAR1aHyZXSx"
Jul 09 08:15:38 arjans-audio-walhalla volumio[998]: verbose: New Socket.io Connection to 192.168.68.51:3000 from 192.168.68.52 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Jul 09 08:15:38 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 08:15:38 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 08:15:38 arjans-audio-walhalla volumio[998]: info: Discovery: Getting this device information
Jul 09 08:15:38 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:15:38 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 08:15:39 arjans-audio-walhalla volumio[998]: verbose: New Socket.io Connection to 192.168.68.51:3000 from 192.168.68.52 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Jul 09 08:15:50 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:50+02:00" level=debug msg="fetched chunk 19/20, size: 524288" uri="spotify:track:21ZTkAe7nw4kAR1aHyZXSx"
Jul 09 08:15:58 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:58+02:00" level=trace msg="received accesspoint ping"
Jul 09 08:15:58 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:58+02:00" level=trace msg="received accesspoint pong ack"
Jul 09 08:15:58 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:58+02:00" level=trace msg="sent dealer ping"
Jul 09 08:15:58 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:15:58+02:00" level=trace msg="received dealer pong"
Jul 09 08:16:03 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:03+02:00" level=debug msg="fetched chunk 20/20, size: 372428" uri="spotify:track:21ZTkAe7nw4kAR1aHyZXSx"
Jul 09 08:16:09 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 08:16:09 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 08:16:09 arjans-audio-walhalla volumio[998]: info: Discovery: Getting this device information
Jul 09 08:16:09 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:09 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 08:16:19 arjans-audio-walhalla volumiologrotate[631]: ls: cannot access "/var/log/samba/log.wb-ARJAN'S": No such file or directory
Jul 09 08:16:19 arjans-audio-walhalla volumiologrotate[631]: ls: cannot access 'AUDIO': No such file or directory
Jul 09 08:16:19 arjans-audio-walhalla volumiologrotate[631]: ls: cannot access 'WALHALLA': No such file or directory
Jul 09 08:16:26 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:26+02:00" level=debug msg="prefetching next track" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:26 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:26+02:00" level=debug msg="selected format OGG_VORBIS_320 (87f4a69ca667e20afb31160c654a603055f6f430)" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:26 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:26+02:00" level=debug msg="requested aes key for file 87f4a69ca667e20afb31160c654a603055f6f430, gid: 2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:26 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:26+02:00" level=debug msg="fetched first chunk of 18, total size is 9124880 bytes" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:26 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:26+02:00" level=info msg="prefetched track \"Multicolor\" (duration: 208680ms)" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:26 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:26+02:00" level=debug msg="fetched chunk 1/17, size: 524288" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:26 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:26+02:00" level=debug msg="fetched chunk 3/17, size: 524288" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:26 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:26+02:00" level=debug msg="fetched chunk 2/17, size: 524288" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:28 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:28+02:00" level=trace msg="sent dealer ping"
Jul 09 08:16:28 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:28+02:00" level=trace msg="received dealer pong"
Jul 09 08:16:30 arjans-audio-walhalla volumio[998]: verbose: New Socket.io Connection to 192.168.68.51:3000 from 192.168.68.52 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
Jul 09 08:16:33 arjans-audio-walhalla volumio[998]: verbose: New Socket.io Connection to 192.168.68.51:3000 from 192.168.68.52 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: verbose: New Socket.io Connection to 192.168.68.51 from 192.168.68.52 UA: Mozilla/5.0 (Linux; Android 14; SM-A528B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetQueue
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::getQueue
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CorePlayQueue::getQueue
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: Listing playlists
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: Received Get System Info
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: Discovery: Getting this device information
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:34 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=debug msg="handling skip_next player command from c425999b4be3dc698a9f7474537fa5026e5c9a3d"
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=debug msg="loading track (paused: false, position: 1ms)" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=trace msg="emitting websocket event: will_play"
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:2ExdbieQffMXpY7ygN2YN9","play_origin":"playlist"}}
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=info msg="loaded track \"Multicolor\" (paused: false, position: 1ms, duration: 208680ms, prefetched: true)" uri="spotify:track:2ExdbieQffMXpY7ygN2YN9"
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=trace msg="scheduling prefetch in 179s"
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=trace msg="emitting websocket event: metadata"
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=debug msg="sending successful reply for dealer request"
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:2ExdbieQffMXpY7ygN2YN9","name":"Multicolor","artist_names":["Son Mieux"],"album_name":"Multicolor","album_cover_url":"https://i.scdn.co/image/ab67616d00001e022f153316c9dcce738cb8510f","position":1,"duration":208680,"release_date":"year:2022 month:4 day:15","track_number":1,"disc_number":1}}
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 08:16:36 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:36+02:00" level=trace msg="emitting websocket event: playing"
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:2ExdbieQffMXpY7ygN2YN9","play_origin":"playlist"}}
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: SPOTIFY: PUSH STATE SPOTIFY
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: SPOTIFY: {"status":"play","service":"spop","title":"Multicolor","artist":"Son Mieux","album":"Multicolor","albumart":"https://i.scdn.co/image/ab67616d00001e022f153316c9dcce738cb8510f","uri":"spotify:track:2ExdbieQffMXpY7ygN2YN9","trackType":"spotify","seek":1,"duration":208,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::servicePushState
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::pushState
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioPushState
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: MRS: Pushing multiroomSync output update for this device
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: MRS: Pushing multiroomSync output
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: SPOTIFY: PUSH STATE SPOTIFY
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: SPOTIFY: {"status":"play","service":"spop","title":"Multicolor","artist":"Son Mieux","album":"Multicolor","albumart":"https://i.scdn.co/image/ab67616d00001e022f153316c9dcce738cb8510f","uri":"spotify:track:2ExdbieQffMXpY7ygN2YN9","trackType":"spotify","seek":1001,"duration":208,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::servicePushState
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::pushState
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioPushState
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: MRS: Pushing multiroomSync output update for this device
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: MRS: Pushing multiroomSync output
Jul 09 08:16:36 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:39 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioNext
Jul 09 08:16:39 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::next
Jul 09 08:16:39 arjans-audio-walhalla volumio[998]: info: Spotify next
Jul 09 08:16:39 arjans-audio-walhalla volumio[998]: info: Sending Spotify command to local API: /player/next
Jul 09 08:16:39 arjans-audio-walhalla volumio[998]: error: Failed to send command to Spotify local API: /player/next: Error: Bad Request
Jul 09 08:16:41 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioNext
Jul 09 08:16:41 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::next
Jul 09 08:16:41 arjans-audio-walhalla volumio[998]: info: Spotify next
Jul 09 08:16:41 arjans-audio-walhalla volumio[998]: info: Sending Spotify command to local API: /player/next
Jul 09 08:16:41 arjans-audio-walhalla volumio[998]: error: Failed to send command to Spotify local API: /player/next: Error: Bad Request
Jul 09 08:16:44 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioNext
Jul 09 08:16:44 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::next
Jul 09 08:16:44 arjans-audio-walhalla volumio[998]: info: Spotify next
Jul 09 08:16:44 arjans-audio-walhalla volumio[998]: info: Sending Spotify command to local API: /player/next
Jul 09 08:16:44 arjans-audio-walhalla volumio[998]: error: Failed to send command to Spotify local API: /player/next: Error: Bad Request
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: Discovery: Getting this device information
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioPause
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::pause
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::servicePause
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::servicePause
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: Spotify Received pause
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: SPOTIFY: SPOTIFY PAUSE
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: SPOTIFY: {"status":"play","title":"Multicolor","artist":"Son Mieux","album":"Multicolor","albumart":"https://i.scdn.co/image/ab67616d00001e022f153316c9dcce738cb8510f","uri":"spotify:track:2ExdbieQffMXpY7ygN2YN9","trackType":"spotify","codec":"ogg","seek":1001,"duration":208,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":100,"dbVolume":null,"mute":false,"disableVolumeControl":true,"stream":false,"updatedb":false,"volatile":true,"service":"spop"}
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: Sending Spotify command to local API: /player/pause
Jul 09 08:16:46 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:46+02:00" level=debug msg="pause track at 10032ms"
Jul 09 08:16:46 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:46+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 08:16:46 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:46+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Jul 09 08:16:46 arjans-audio-walhalla go-librespot[1194]: time="2025-07-09T08:16:46+02:00" level=trace msg="emitting websocket event: paused"
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:2ExdbieQffMXpY7ygN2YN9","play_origin":"playlist"}}
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: SPOTIFY: PUSH STATE SPOTIFY
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: SPOTIFY: {"status":"pause","service":"spop","title":"Multicolor","artist":"Son Mieux","album":"Multicolor","albumart":"https://i.scdn.co/image/ab67616d00001e022f153316c9dcce738cb8510f","uri":"spotify:track:2ExdbieQffMXpY7ygN2YN9","trackType":"spotify","seek":11001,"duration":208,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::servicePushState
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::pushState
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioPushState
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: MRS: Pushing multiroomSync output update for this device
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: MRS: Pushing multiroomSync output
Jul 09 08:16:46 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioPlay
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::play index undefined
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CorePlayQueue::getTrack 0
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::startPlaybackTimer
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CorePlayQueue::getTrack 0
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: verbose: ControllerMpd::sendMpdCommand play
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: sendMpdCommand play took 1 milliseconds
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::servicePushState
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CorePlayQueue::getTrack 0
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: verbose: STATE SERVICE {"status":"play"}
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: verbose: CURRENT POSITION 0
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::syncState stateService play
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreStateMachine::pushState
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CorePlayQueue::getTrack 0
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioPushState
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: MRS: Pushing multiroomSync output update for this device
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: MRS: Pushing multiroomSync output
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CoreCommandRouter::volumioGetState
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: CorePlayQueue::getTrack 0
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: [1752041807601] [RadioParadise] getMetadata started with url undefined
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: info: [1752041807620] [RadioParadise] Error: connect ECONNREFUSED 127.0.0.1:443
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: TypeError: Cannot read property 'toUpperCase' of undefined
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: at ControllerRadioParadise.errorToast (/data/plugins/music_service/radio_paradise/index.js:481:41)
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: at ClientRequest. (/data/plugins/music_service/radio_paradise/index.js:452:14)
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: at ClientRequest.emit (events.js:315:20)
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: at TLSSocket.socketErrorListener (_http_client.js:469:9)
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: at TLSSocket.emit (events.js:315:20)
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: at emitErrorNT (internal/streams/destroy.js:106:8)
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: at emitErrorCloseNT (internal/streams/destroy.js:74:3)
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Jul 09 08:16:47 arjans-audio-walhalla volumio[998]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 09 08:16:47 arjans-audio-walhalla sudo[4143]: volumio : unable to resolve host arjans-audio-walhalla
Jul 09 08:16:47 arjans-audio-walhalla sudo[4143]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Jul 09 08:16:47 arjans-audio-walhalla sudo[4143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 08:15
Jul 09 08:16:47 arjans-audio-walhalla sudo[4143]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST"
VOLUMIO_VERSION="3.816"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"