-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-11-30 14:08:06 CET. -- Nov 30 14:07:29 slaapkamer-m volumio[1213]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 14:07:32 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 30 14:07:32 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 30 14:07:33 slaapkamer-m volumio[1213]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 14:07:44 slaapkamer-m volumio[1213]: info: Received OAUTH Data Nov 30 14:07:44 slaapkamer-m volumio[1213]: info: Executing Spotify Oauth Login Nov 30 14:07:44 slaapkamer-m volumio[1213]: info: Saving Spotify Refresh Token Nov 30 14:07:45 slaapkamer-m volumio[1213]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 30 14:07:45 slaapkamer-m volumio[1213]: SPOTIFY: BQChsi2z7NC4kNtx7yvD6XD4XnGRpSddotneq4TOHT1Px6BZP2Fxk3TxXz36ZIINaMuXsXI2_5bGMHPCLArMq1MMlCM2pZqntgVvvyFobPNrI_73JWClXbtplWtcHpLXMoOffKnVukpii5FYe9TB6AmSMd3fDZ8Um8n1wBVVXDt-djcqKlFBRUOgFwdquXAWut5KuhsvD_oziFcBFLLreyvN0gpxKW8YJmxw9LC4kYjLRBQQe6Ys5kdVVrpbrReFzVfQTx-nPlE_KkY Nov 30 14:07:45 slaapkamer-m volumio[1213]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: New Spotify access token = BQChsi2z7NC4kNtx7yvD6XD4XnGRpSddotneq4TOHT1Px6BZP2Fxk3TxXz36ZIINaMuXsXI2_5bGMHPCLArMq1MMlCM2pZqntgVvvyFobPNrI_73JWClXbtplWtcHpLXMoOffKnVukpii5FYe9TB6AmSMd3fDZ8Um8n1wBVVXDt-djcqKlFBRUOgFwdquXAWut5KuhsvD_oziFcBFLLreyvN0gpxKW8YJmxw9LC4kYjLRBQQe6Ys5kdVVrpbrReFzVfQTx-nPlE_KkY Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: Spotify credentials grant success - running version from March 24, 2019 Nov 30 14:07:45 slaapkamer-m volumio[1213]: SPOTIFY: User informations: {"country":"NL","display_name":"Merijn Guldemond","email":"merijnguldemond@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/5dpf6z2n8e1klhyiwk17u575p"},"followers":{"href":null,"total":6},"href":"https://api.spotify.com/v1/users/5dpf6z2n8e1klhyiwk17u575p","id":"5dpf6z2n8e1klhyiwk17u575p","images":[{"height":300,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=230074664620405&height=300&width=300&ext=1735551700&hash=AbZV1dpCLBrauRi1oHDrC__e","width":300},{"height":64,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=230074664620405&height=50&width=50&ext=1735551700&hash=AbYEm7rvemXRm0N8pOAj6m3T","width":64}],"product":"premium","type":"user","uri":"spotify:user:5dpf6z2n8e1klhyiwk17u575p"} Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: Creating Spotify config file Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: Spotify config file written Nov 30 14:07:45 slaapkamer-m sudo[2637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 30 14:07:45 slaapkamer-m sudo[2637]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 14:07:45 slaapkamer-m systemd[1]: Stopping go-librespot Daemon... Nov 30 14:07:45 slaapkamer-m systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Nov 30 14:07:45 slaapkamer-m systemd[1]: go-librespot-daemon.service: Succeeded. Nov 30 14:07:45 slaapkamer-m systemd[1]: Stopped go-librespot Daemon. Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: Connection to go-librespot Websocket closed Nov 30 14:07:45 slaapkamer-m systemd[1]: Started go-librespot Daemon. Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: Librespot-go daemon starting... Nov 30 14:07:45 slaapkamer-m sudo[2637]: pam_unix(sudo:session): session closed for user root Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=info msg="generated new device id: 365c2e4452c5365c451c58344990776678a2e395" Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=debug msg="stored credentials not found" Nov 30 14:07:45 slaapkamer-m volumio[1213]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 30 14:07:45 slaapkamer-m volumio[1213]: SPOTIFY: BQCAKeDoFeb_BZdlO-i3Oyi4RiwRw8VeMVNBZJwi1Pfa5xQOdZ9wr7b9eTUnqhhTIJTJ8zezvu0TZJRqJiqbb5m8mCUpj9NDuKhKjrhrr_SXwsE30TdYng9DsYnSdydYlSvIw4ZK0fb-bDsysAUXruvuj2Bg2BoMF5y_1Gbw-ybz2S8_m7Dsu7gQqiuFi_998-r6x063xL48BqhcnYaE2vkHu-2nqLynVR77i3RffzjeccBNN7_y9TS5lNiRVY4dcdyhEkXnisESH7g Nov 30 14:07:45 slaapkamer-m volumio[1213]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: New Spotify access token = BQCAKeDoFeb_BZdlO-i3Oyi4RiwRw8VeMVNBZJwi1Pfa5xQOdZ9wr7b9eTUnqhhTIJTJ8zezvu0TZJRqJiqbb5m8mCUpj9NDuKhKjrhrr_SXwsE30TdYng9DsYnSdydYlSvIw4ZK0fb-bDsysAUXruvuj2Bg2BoMF5y_1Gbw-ybz2S8_m7Dsu7gQqiuFi_998-r6x063xL48BqhcnYaE2vkHu-2nqLynVR77i3RffzjeccBNN7_y9TS5lNiRVY4dcdyhEkXnisESH7g Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: Spotify credentials grant success - running version from March 24, 2019 Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=debug msg="zeroconf server listening on port 39873" Nov 30 14:07:45 slaapkamer-m volumio[1213]: SPOTIFY: User informations: {"country":"NL","display_name":"Merijn Guldemond","email":"merijnguldemond@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/5dpf6z2n8e1klhyiwk17u575p"},"followers":{"href":null,"total":6},"href":"https://api.spotify.com/v1/users/5dpf6z2n8e1klhyiwk17u575p","id":"5dpf6z2n8e1klhyiwk17u575p","images":[{"height":300,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=230074664620405&height=300&width=300&ext=1735551700&hash=AbZV1dpCLBrauRi1oHDrC__e","width":300},{"height":64,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=230074664620405&height=50&width=50&ext=1735551700&hash=AbYEm7rvemXRm0N8pOAj6m3T","width":64}],"product":"premium","type":"user","uri":"spotify:user:5dpf6z2n8e1klhyiwk17u575p"} Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: Spotify Successfully logged in Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: [1732972065513] CoreMusicLibrary::Adding element Spotify Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 14:07:45 slaapkamer-m volumio[1213]: Cannot find translation for source Spotify Nov 30 14:07:45 slaapkamer-m volumio[1213]: info: An error occurred while initializing Spotify Browsing facility: TypeError: Cannot read property 'broadcastMessage' of null Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=debug msg="obtained new client token: AACHRpLdQv4BElkuL/E+z3pnH8+jwAukzBKr3UuksT+1vFtTt1xI5Y9Ex6PWKvpgZjJNX5bEio9NoOvDngx6XTxf5D8bqbgOFwkV+djkB9hsu8fLnKljLK0ucj7Z7eoGG2XRZO3SgTcVwRrsJRmnfwPg5u18zEHmWe1up6IGwUm56wBk9qDo76a5ebmjFk8L28VG8qXsThQT25tvwaXyZ4792aJuNYUOWOl4MHdODKkVKeu8P7ME3MlAJps2tQ==" Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070 (error: dial tcp 34.158.1.133:4070: connect: connection refused), retrying with a different AP" Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=info msg="connected to ap-gew4.spotify.com:443" Nov 30 14:07:45 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:45+01:00" level=debug msg="completed keyexchange" Nov 30 14:07:45 slaapkamer-m sudo[2648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 30 14:07:45 slaapkamer-m sudo[2648]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 14:07:45 slaapkamer-m sudo[2648]: pam_unix(sudo:session): session closed for user root Nov 30 14:07:45 slaapkamer-m sudo[2651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 30 14:07:45 slaapkamer-m sudo[2651]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 30 14:07:45 slaapkamer-m sudo[2651]: pam_unix(sudo:session): session closed for user root Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="completed challenge" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="authenticated as 5dpf6z2n8e1klhyiwk17u575p" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="authenticated as 5dpf6z2n8e1klhyiwk17u575p" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="dealer connection opened" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="stored credentials for 5dpf6z2n8e1klhyiwk17u575p" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="initializing zeroconf session, username: 5dpf6z2n8e1klhyiwk17u575p" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="autoplay enabled: false" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="received connection id: OWYzMzQwNzYtNGYwNy00ZDA3LTg4MTEtNGYwNGQ1YjMwOTVjK2RlYWxlcit0Y3A6Ly8wYWNhNTkxMy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMzA3QUJENUZFNkM5Q0ZDODhEMTYwNzg2MERCRTIxMkM0MjUzQjMxNTFCQjA4QjM5ODQwMkVFNEM4NDUzNEU3MA==" Nov 30 14:07:46 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:46+01:00" level=debug msg="put connect state because NEW_DEVICE" Nov 30 14:07:47 slaapkamer-m volumio[1213]: verbose: New Socket.io Connection to 192.168.1.114 from 192.168.1.60 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetVisibleSources Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: Received Get System Info Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: Discovery: Getting this device information Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: Listing playlists Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: Received Get System Info Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: Discovery: Getting this device information Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: Initializing connection to go-librespot Websocket Nov 30 14:07:48 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:48+01:00" level=debug msg="new websocket client" Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: Connection to go-librespot Websocket established Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 30 14:07:48 slaapkamer-m volumio[1213]: info: go-librespot daemon successfully initialized Nov 30 14:07:49 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 30 14:07:50 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 30 14:07:50 slaapkamer-m volumio[1213]: info: Received Get System Info Nov 30 14:07:50 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 14:07:50 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 14:07:50 slaapkamer-m volumio[1213]: info: Discovery: Getting this device information Nov 30 14:07:50 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:50 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:50 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: Getting Spotify volume Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: Spotify volume: 100 Nov 30 14:07:51 slaapkamer-m volumio[1213]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:51 slaapkamer-m volumio[1213]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Nov 30 14:07:51 slaapkamer-m volumio[1213]: SPOTIFY: SPOTIFY VOLUME 100 Nov 30 14:07:51 slaapkamer-m volumio[1213]: SPOTIFY: VOLUMIO VOLUME 86 Nov 30 14:07:51 slaapkamer-m volumio[1213]: SPOTIFY: DELTA VOLUME ENOUGH: true Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: Setting Spotify Volume from Volumio: 86 Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: Initializing connection to go-librespot Websocket Nov 30 14:07:51 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:51+01:00" level=debug msg="new websocket client" Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: Connection to go-librespot Websocket established Nov 30 14:07:51 slaapkamer-m volumio[1213]: verbose: New Socket.io Connection to 192.168.1.114 from 192.168.1.60 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetVisibleSources Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: Received Get System Info Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: Discovery: Getting this device information Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: Listing playlists Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 30 14:07:51 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 30 14:07:52 slaapkamer-m volumio[1213]: SPOTIFY: SETTING SPOTIFY VOLUME 86 Nov 30 14:07:52 slaapkamer-m volumio[1213]: info: Sending Spotify command with payload to local API: /player/volume Nov 30 14:07:52 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:52+01:00" level=debug msg="update volume to 56360/65535" Nov 30 14:07:52 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:52+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Nov 30 14:07:52 slaapkamer-m go-librespot[2639]: time="2024-11-30T14:07:52+01:00" level=trace msg="emitting websocket event: volume" Nov 30 14:07:52 slaapkamer-m volumio[1213]: SPOTIFY: received: {"type":"volume","data":{"value":86,"max":100}} Nov 30 14:07:52 slaapkamer-m volumio[1213]: SPOTIFY: RECEIVED SPOTIFY VOLUME 86 Nov 30 14:07:52 slaapkamer-m volumio[1213]: SPOTIFY: received: {"type":"volume","data":{"value":86,"max":100}} Nov 30 14:07:52 slaapkamer-m volumio[1213]: SPOTIFY: RECEIVED SPOTIFY VOLUME 86 Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: Received Get System Info Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: Discovery: Getting this device information Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 14:07:53 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: Received Get System Info Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: Discovery: Getting this device information Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: Getting Spotify volume Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: Spotify volume: 86 Nov 30 14:07:54 slaapkamer-m volumio[1213]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CoreCommandRouter::volumioGetState Nov 30 14:07:54 slaapkamer-m volumio[1213]: info: CorePlayQueue::getTrack 0 Nov 30 14:07:54 slaapkamer-m volumio[1213]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Nov 30 14:07:56 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 30 14:07:56 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 30 14:08:01 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 30 14:08:02 slaapkamer-m volumio[1213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 30 14:08:05 slaapkamer-m volumio[1213]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/ampswitch/0.2.1/volumio/buster/armhf Nov 30 14:08:05 slaapkamer-m volumio[1213]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 14:08:05 slaapkamer-m volumio[1213]: TypeError: Cannot read property 'broadcastMessage' of null Nov 30 14:08:05 slaapkamer-m volumio[1213]: at /volumio/app/index.js:1529:32 Nov 30 14:08:05 slaapkamer-m volumio[1213]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Nov 30 14:08:05 slaapkamer-m volumio[1213]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Nov 30 14:08:05 slaapkamer-m volumio[1213]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1527:13) Nov 30 14:08:05 slaapkamer-m volumio[1213]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Nov 30 14:08:05 slaapkamer-m volumio[1213]: at PluginManager.installPlugin (/volumio/app/pluginmanager.js:776:8) Nov 30 14:08:05 slaapkamer-m volumio[1213]: at CoreCommandRouter.installPlugin (/volumio/app/index.js:1448:22) Nov 30 14:08:05 slaapkamer-m volumio[1213]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1203:47) Nov 30 14:08:05 slaapkamer-m volumio[1213]: at Socket.emit (events.js:315:20) Nov 30 14:08:05 slaapkamer-m volumio[1213]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 30 14:08:05 slaapkamer-m volumio[1213]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 30 14:08:05 slaapkamer-m volumio[1213]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 30 14:08:06 slaapkamer-m sudo[2737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-30 14:07 Nov 30 14:08:06 slaapkamer-m sudo[2737]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"