-- Logs begin at Mon 2024-08-26 21:12:53 CEST, end at Mon 2024-08-26 21:37:27 CEST. --
Aug 26 21:36:42 volumio go-librespot[1645]: time="2024-08-26T21:36:42+02:00" level=debug msg="handling skip_next player command from 51c819875d0010c112d05cc2fec9e46981b3aa40"
Aug 26 21:36:42 volumio go-librespot[1645]: time="2024-08-26T21:36:42+02:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:42 volumio go-librespot[1645]: time="2024-08-26T21:36:42+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Aug 26 21:36:42 volumio go-librespot[1645]: time="2024-08-26T21:36:42+02:00" level=trace msg="emitting websocket event: will_play"
Aug 26 21:36:42 volumio volumio[902]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:1v5Qz44gB35Expy7nZkV3h","play_origin":"collection-songs"}}
Aug 26 21:36:42 volumio go-librespot[1645]: time="2024-08-26T21:36:42+02:00" level=debug msg="selected format OGG_VORBIS_320 (387fd4fa60104cc0f9efffa6a74e1a86d35092da)" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:42 volumio go-librespot[1645]: time="2024-08-26T21:36:42+02:00" level=debug msg="requested aes key for file 387fd4fa60104cc0f9efffa6a74e1a86d35092da, gid: 1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=debug msg="fetched first chunk of 17, total size is 8858091 bytes" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=info msg="loaded track \"Bass & Drum Intro\" (paused: false, position: 0ms, duration: 209800ms, prefetched: false)" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=debug msg="fetched chunk 1/16, size: 524288" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=debug msg="fetched chunk 2/16, size: 524288" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=trace msg="scheduling prefetch in 180s"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=trace msg="emitting websocket event: metadata"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=debug msg="sending successful reply for dealer request"
Aug 26 21:36:43 volumio volumio[902]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:1v5Qz44gB35Expy7nZkV3h","name":"Bass \u0026 Drum Intro","artist_names":["Nils Lofgren"],"album_name":"Live","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0261e7ba3225665aa962d675fb","position":0,"duration":209800,"release_date":"year:2002","track_number":9,"disc_number":2}}
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=trace msg="emitting websocket event: playing"
Aug 26 21:36:43 volumio volumio[902]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:1v5Qz44gB35Expy7nZkV3h","play_origin":"collection-songs"}}
Aug 26 21:36:43 volumio volumio[902]: SPOTIFY: PUSH STATE SPOTIFY
Aug 26 21:36:43 volumio volumio[902]: SPOTIFY: {"status":"play","service":"spop","title":"Bass & Drum Intro","artist":"Nils Lofgren","album":"Live","albumart":"https://i.scdn.co/image/ab67616d00001e0261e7ba3225665aa962d675fb","uri":"spotify:track:1v5Qz44gB35Expy7nZkV3h","trackType":"spotify","seek":0,"duration":209,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Aug 26 21:36:43 volumio volumio[902]: info: CoreCommandRouter::servicePushState
Aug 26 21:36:43 volumio volumio[902]: info: CoreStateMachine::pushState
Aug 26 21:36:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 26 21:36:43 volumio volumio[902]: info: CoreCommandRouter::volumioPushState
Aug 26 21:36:43 volumio volumio[902]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79
Aug 26 21:36:43 volumio go-librespot[1645]: time="2024-08-26T21:36:43+02:00" level=debug msg="fetched chunk 3/16, size: 524288" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:43 volumio volumio[902]: SPOTIFY: PUSH STATE SPOTIFY
Aug 26 21:36:43 volumio volumio[902]: SPOTIFY: {"status":"play","service":"spop","title":"Bass & Drum Intro","artist":"Nils Lofgren","album":"Live","albumart":"https://i.scdn.co/image/ab67616d00001e0261e7ba3225665aa962d675fb","uri":"spotify:track:1v5Qz44gB35Expy7nZkV3h","trackType":"spotify","seek":1000,"duration":209,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Aug 26 21:36:43 volumio volumio[902]: info: CoreCommandRouter::servicePushState
Aug 26 21:36:43 volumio volumio[902]: info: CoreStateMachine::pushState
Aug 26 21:36:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 26 21:36:43 volumio volumio[902]: info: CoreCommandRouter::volumioPushState
Aug 26 21:36:43 volumio volumio[902]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79
Aug 26 21:36:51 volumio go-librespot[1645]: time="2024-08-26T21:36:51+02:00" level=debug msg="fetched chunk 4/16, size: 524288" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:36:51 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:36:51 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:36:51 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:36:51 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:51 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:36:51 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.143:3000 from 192.168.1.20 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
Aug 26 21:36:51 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:51 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 26 21:36:51 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 26 21:36:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:36:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:36:56 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:36:56 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:36:56 volumio sudo[3219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 26 21:36:56 volumio sudo[3219]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:36:56 volumio sudo[3219]: pam_unix(sudo:session): session closed for user root
Aug 26 21:36:56 volumio sudo[3222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 26 21:36:56 volumio sudo[3222]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:36:56 volumio sudo[3222]: pam_unix(sudo:session): session closed for user root
Aug 26 21:36:56 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.143 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Aug 26 21:36:58 volumio sudo[3227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 26 21:36:58 volumio sudo[3227]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:36:58 volumio sudo[3227]: pam_unix(sudo:session): session closed for user root
Aug 26 21:36:58 volumio sudo[3230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 26 21:36:58 volumio sudo[3230]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:36:58 volumio sudo[3230]: pam_unix(sudo:session): session closed for user root
Aug 26 21:36:58 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.143 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Aug 26 21:36:59 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.143 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 26 21:36:59 volumio volumio[902]: info: Received Get System Info
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:36:59 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:59 volumio volumio[902]: info: Listing playlists
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 26 21:36:59 volumio volumio[902]: info: Received Get System Info
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:36:59 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:36:59 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:36:59 volumio volumio[902]: info: Listing playlists
Aug 26 21:37:00 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Aug 26 21:37:00 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Aug 26 21:37:00 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 26 21:37:00 volumio volumio[902]: info: Received Get System Info
Aug 26 21:37:00 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:37:00 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:37:00 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:37:00 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:00 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:37:01 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Aug 26 21:37:02 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 26 21:37:02 volumio volumio[902]: info: Received Get System Info
Aug 26 21:37:02 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:37:02 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:37:02 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:37:02 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:02 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:37:02 volumio volumio[902]: info: CoreCommandRouter::volumioGetQueue
Aug 26 21:37:02 volumio volumio[902]: info: CoreStateMachine::getQueue
Aug 26 21:37:02 volumio volumio[902]: info: CorePlayQueue::getQueue
Aug 26 21:37:03 volumio go-librespot[1645]: time="2024-08-26T21:37:03+02:00" level=debug msg="fetched chunk 5/16, size: 524288" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:37:08 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Aug 26 21:37:09 volumio sudo[3241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 26 21:37:09 volumio sudo[3241]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:37:09 volumio sudo[3241]: pam_unix(sudo:session): session closed for user root
Aug 26 21:37:09 volumio sudo[3244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 26 21:37:09 volumio sudo[3244]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:37:09 volumio sudo[3244]: pam_unix(sudo:session): session closed for user root
Aug 26 21:37:10 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.143 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Aug 26 21:37:10 volumio sudo[3249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 26 21:37:10 volumio sudo[3249]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:37:10 volumio sudo[3249]: pam_unix(sudo:session): session closed for user root
Aug 26 21:37:10 volumio sudo[3252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 26 21:37:10 volumio sudo[3252]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:37:10 volumio sudo[3252]: pam_unix(sudo:session): session closed for user root
Aug 26 21:37:10 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.143 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::volumioGetQueue
Aug 26 21:37:10 volumio volumio[902]: info: CoreStateMachine::getQueue
Aug 26 21:37:10 volumio volumio[902]: info: CorePlayQueue::getQueue
Aug 26 21:37:10 volumio volumio[902]: info: Listing playlists
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 26 21:37:10 volumio volumio[902]: info: Received Get System Info
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:37:10 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 26 21:37:10 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Aug 26 21:37:12 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 26 21:37:12 volumio volumio[902]: info: Received Get System Info
Aug 26 21:37:12 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:37:12 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:37:12 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:37:12 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:12 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:37:12 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Aug 26 21:37:13 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 26 21:37:13 volumio volumio[902]: info: Received Get System Info
Aug 26 21:37:13 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:37:13 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:37:13 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:37:13 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:13 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:37:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 26 21:37:17 volumio volumio[902]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Aug 26 21:37:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Aug 26 21:37:17 volumio volumio[902]: info: Received Get System Version
Aug 26 21:37:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 26 21:37:17 volumio volumio[902]: info: Received Get System Info
Aug 26 21:37:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:37:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:37:17 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:37:17 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:37:18 volumio go-librespot[1645]: time="2024-08-26T21:37:18+02:00" level=debug msg="fetched chunk 6/16, size: 524288" uri="spotify:track:1v5Qz44gB35Expy7nZkV3h"
Aug 26 21:37:20 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 26 21:37:21 volumio volumio[902]: info: Discovery: Getting this device information
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::volumioGetState
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 26 21:37:21 volumio volumio[902]: info: Retrieving Cloud Streaming UI
Aug 26 21:37:21 volumio volumio[902]: info: Getting Tidal Cloud Configuration
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 26 21:37:21 volumio volumio[902]: info: Getting Qobuz Cloud Configuration
Aug 26 21:37:21 volumio volumio[902]: info: Asking plugin for UI Config
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 26 21:37:21 volumio volumio[902]: info: Getting Spotify Cloud Configuration
Aug 26 21:37:21 volumio volumio[902]: info: Asking plugin for UI Config
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 26 21:37:21 volumio volumio[902]: info: Saving Spotify Acccount
Aug 26 21:37:21 volumio volumio[902]: info: Got Tidal Cloud Configuration
Aug 26 21:37:21 volumio volumio[902]: info: Got it
Aug 26 21:37:21 volumio volumio[902]: info: Got it
Aug 26 21:37:21 volumio volumio[902]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 26 21:37:21 volumio volumio[902]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 26 21:37:21 volumio volumio[902]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 26 21:37:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 26 21:37:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Aug 26 21:37:26 volumio volumio[902]: info: Disabling MyMusic plugin upnp
Aug 26 21:37:26 volumio sudo[3263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Aug 26 21:37:26 volumio sudo[3263]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 26 21:37:26 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
Aug 26 21:37:26 volumio volumio[902]: error: Upnp client error: Error: This socket has been ended by the other party
Aug 26 21:37:26 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Aug 26 21:37:27 volumio volumio[902]: info: Enabling MyMusic plugin upnp
Aug 26 21:37:27 volumio volumio[902]: info: Enabling plugin upnp
Aug 26 21:37:27 volumio volumio[902]: info: Loading plugin "upnp"...
Aug 26 21:37:27 volumio volumio[902]: info: [1724701047899] Starting Upmpd Daemon
Aug 26 21:37:27 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Aug 26 21:37:27 volumio volumio[902]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 26 21:37:27 volumio volumio[902]: Error: listen EADDRINUSE: address already in use :::6599
Aug 26 21:37:27 volumio volumio[902]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
Aug 26 21:37:27 volumio volumio[902]: at listenInCluster (net.js:1379:12)
Aug 26 21:37:27 volumio volumio[902]: at Server.listen (net.js:1465:7)
Aug 26 21:37:27 volumio volumio[902]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Aug 26 21:37:27 volumio volumio[902]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Aug 26 21:37:27 volumio volumio[902]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Aug 26 21:37:27 volumio volumio[902]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Aug 26 21:37:27 volumio volumio[902]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
Aug 26 21:37:27 volumio volumio[902]: code: 'EADDRINUSE',
Aug 26 21:37:27 volumio volumio[902]: errno: -98,
Aug 26 21:37:27 volumio volumio[902]: syscall: 'listen',
Aug 26 21:37:27 volumio volumio[902]: address: '::',
Aug 26 21:37:27 volumio volumio[902]: port: 6599
Aug 26 21:37:27 volumio volumio[902]: }
Aug 26 21:37:27 volumio volumio[902]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 26 21:37:27 volumio sudo[3274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 21:36
Aug 26 21:37:27 volumio sudo[3274]: pam_unix(sudo:session): session opened for user root by (uid=0)
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="5fd3886148e72a9cecd88a772d1f6079fb64d11a"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST"
VOLUMIO_VERSION="3.742"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"