-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2025-05-21 07:56:27 CEST. --
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Discovery: adding 2c7d52a5-bb2d-469a-835f-5bda7a36805e
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Discovery: Found device Volumio Werkkamer
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:00 volumio-werkkamer sudo[978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 21 07:55:00 volumio-werkkamer sudo[978]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Completed loading Core Plugins
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Preparing to generate the ALSA configuration file
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Asound.conf file unchanged, so no further update is needed
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Output device has changed, restarting MPD
May 21 07:55:00 volumio-werkkamer systemd[1]: Started UPnP Renderer front-end to MPD.
May 21 07:55:00 volumio-werkkamer sudo[978]: pam_unix(sudo:session): session closed for user root
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Output device has changed, restarting Shairport Sync
May 21 07:55:00 volumio-werkkamer sudo[983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:00 volumio-werkkamer sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:00 volumio-werkkamer sudo[988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 21 07:55:00 volumio-werkkamer sudo[988]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:00 volumio-werkkamer sudo[983]: pam_unix(sudo:session): session closed for user root
May 21 07:55:00 volumio-werkkamer systemd[1]: Stopping Music Player Daemon...
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 21 07:55:00 volumio-werkkamer volumio[783]: info: ___________ START PLUGINS ___________
May 21 07:55:00 volumio-werkkamer volumio[783]: info: ControllerMpd::onStart: Initializing MPD
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Creating MPD Configuration file
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 21 07:55:00 volumio-werkkamer volumio[783]: info: [1747806900326] CoreMusicLibrary::Adding element Media Servers
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 07:55:00 volumio-werkkamer sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 21 07:55:00 volumio-werkkamer sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:00 volumio-werkkamer sudo[999]: pam_unix(sudo:session): session closed for user root
May 21 07:55:00 volumio-werkkamer sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 21 07:55:00 volumio-werkkamer sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:00 volumio-werkkamer systemd[1]: mpd.service: Succeeded.
May 21 07:55:00 volumio-werkkamer systemd[1]: Stopped Music Player Daemon.
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:00 volumio-werkkamer systemd[1]: Starting Music Player Daemon...
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 21 07:55:00 volumio-werkkamer volumio[783]: info: [1747806900506] CoreMusicLibrary::Adding element Last_100
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 21 07:55:00 volumio-werkkamer volumio[783]: info: [1747806900509] CoreMusicLibrary::Adding element Webradio
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Initializing BBC Radios
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:00 volumio-werkkamer sudo[1023]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 21 07:55:00 volumio-werkkamer sudo[1023]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Creating Spotify config file
May 21 07:55:00 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:00 volumio-werkkamer sudo[1023]: pam_unix(sudo:session): session closed for user root
May 21 07:55:00 volumio-werkkamer volumio[783]: info: AutoStart - onStart
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Volumio Calling Home
May 21 07:55:00 volumio-werkkamer volumio[783]: info: MPD Permissions set
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Upmpdcli Daemon Started
May 21 07:55:00 volumio-werkkamer volumio[783]: info: Spotify config file written
May 21 07:55:01 volumio-werkkamer sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
May 21 07:55:01 volumio-werkkamer sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:01 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
May 21 07:55:01 volumio-werkkamer volumio[783]: info: No need to fix Spotify hosts
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer systemd[1]: Started go-librespot Daemon.
May 21 07:55:01 volumio-werkkamer go-librespot[1046]: go-librespot daemon starting...
May 21 07:55:01 volumio-werkkamer sudo[1043]: pam_unix(sudo:session): session closed for user root
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:01 volumio-werkkamer volumio[783]: info: Volumio called home
May 21 07:55:01 volumio-werkkamer volumio[783]: info: Starting Shairport Sync
May 21 07:55:01 volumio-werkkamer volumio[783]: info: Starting Shairport Sync
May 21 07:55:01 volumio-werkkamer volumio[783]: info: Starting Shairport Sync
May 21 07:55:01 volumio-werkkamer sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 21 07:55:01 volumio-werkkamer sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:01 volumio-werkkamer sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 21 07:55:01 volumio-werkkamer sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:01 volumio-werkkamer sudo[1066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 21 07:55:01 volumio-werkkamer sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:01 volumio-werkkamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 21 07:55:01 volumio-werkkamer systemd[1]: shairport-sync.service: Succeeded.
May 21 07:55:01 volumio-werkkamer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:01 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:01 volumio-werkkamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 21 07:55:01 volumio-werkkamer sudo[1061]: pam_unix(sudo:session): session closed for user root
May 21 07:55:01 volumio-werkkamer sudo[1063]: pam_unix(sudo:session): session closed for user root
May 21 07:55:01 volumio-werkkamer sudo[1066]: pam_unix(sudo:session): session closed for user root
May 21 07:55:01 volumio-werkkamer volumio[783]: info: Shairport-Sync Started
May 21 07:55:01 volumio-werkkamer volumio[783]: Error adding Membership: Error: addMembership EINVAL
May 21 07:55:01 volumio-werkkamer volumio[783]: info: Shairport-Sync Started
May 21 07:55:01 volumio-werkkamer volumio[783]: info: Shairport-Sync Started
May 21 07:55:01 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:01+02:00" level=info msg="running go-librespot 0.2.0"
May 21 07:55:01 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:01+02:00" level=debug msg="app state loaded"
May 21 07:55:01 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:01+02:00" level=debug msg="stored credentials not found"
May 21 07:55:01 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:01+02:00" level=info msg="api server listening on 127.0.0.1:9879"
May 21 07:55:02 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:02+02: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-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
May 21 07:55:02 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:02+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
May 21 07:55:02 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:02+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
May 21 07:55:02 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:02+02:00" level=info msg="zeroconf server listening on port 44411"
May 21 07:55:02 volumio-werkkamer volumio[783]: info: [yt-cast-receiver] DIAL server listening on port 8098
May 21 07:55:02 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioRetrievevolume
May 21 07:55:02 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:02 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:02 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:02 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:02 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:02 volumio-werkkamer volumio[783]: error: [ytcr] VolumeControl failed to obtain volume from Volumio:
May 21 07:55:02 volumio-werkkamer volumio[783]: (TypeError) Cannot read property 'vol' of undefined
May 21 07:55:02 volumio-werkkamer volumio[783]: TypeError: Cannot read property 'vol' of undefined
May 21 07:55:02 volumio-werkkamer volumio[783]: at VolumeControl.getVolume (/data/plugins/music_service/ytcr/dist/lib/VolumeControl.js:56:42)
May 21 07:55:02 volumio-werkkamer volumio[783]: at processTicksAndRejections (internal/process/task_queues.js:93:5)
May 21 07:55:02 volumio-werkkamer volumio[783]: at async VolumeControl.init (/data/plugins/music_service/ytcr/dist/lib/VolumeControl.js:28:68)
May 21 07:55:02 volumio-werkkamer volumio[783]: at async /data/plugins/music_service/ytcr/dist/index.js:326:13
May 21 07:55:02 volumio-werkkamer mpd[1038]: May 21 07:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 21 07:55:02 volumio-werkkamer systemd[1]: Started Music Player Daemon.
May 21 07:55:02 volumio-werkkamer sudo[1009]: pam_unix(sudo:session): session closed for user root
May 21 07:55:02 volumio-werkkamer sudo[988]: pam_unix(sudo:session): session closed for user root
May 21 07:55:02 volumio-werkkamer volumio[783]: error: MPD error: The expression evaluated to a falsy value:
May 21 07:55:02 volumio-werkkamer volumio[783]: assert.ok(self.idling)
May 21 07:55:02 volumio-werkkamer volumio[783]: error: The expression evaluated to a falsy value:
May 21 07:55:02 volumio-werkkamer volumio[783]: assert.ok(self.idling)
May 21 07:55:02 volumio-werkkamer volumio[783]: info: MPD running with PID1038
May 21 07:55:02 volumio-werkkamer volumio[783]: ,establishing connection
May 21 07:55:02 volumio-werkkamer volumio[783]: error: updateQueue error: null
May 21 07:55:02 volumio-werkkamer volumio[783]: info: Completed starting Core Plugins
May 21 07:55:02 volumio-werkkamer volumio[783]: info: -------------------------------------------
May 21 07:55:02 volumio-werkkamer volumio[783]: info: ----- MyVolumio plugins startup ----
May 21 07:55:02 volumio-werkkamer volumio[783]: info: -------------------------------------------
May 21 07:55:02 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Fetching plans data....
May 21 07:55:02 volumio-werkkamer volumio[980]: Generating RSA private key, 4096 bit long modulus (2 primes)
May 21 07:55:02 volumio-werkkamer volumio[783]: error: updateQueue error: null
May 21 07:55:04 volumio-werkkamer volumio[783]: info: AutoStart - Plugin is starting
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetQueue
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreStateMachine::getQueue
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CorePlayQueue::getQueue
May 21 07:55:04 volumio-werkkamer volumio[783]: info: AutoStart - start playing
May 21 07:55:04 volumio-werkkamer volumio[783]: info: AutoStart - start playing with no specific position
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPlay
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreStateMachine::play index 0
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreStateMachine::stop
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreStateMachine::play index undefined
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreStateMachine::startPlaybackTimer
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:04 volumio-werkkamer volumio[783]: info: [1747806904175] ControllerWebradio::clearAddPlayTrack
May 21 07:55:04 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand stop
May 21 07:55:04 volumio-werkkamer volumio[783]: info: sendMpdCommand stop took 3 milliseconds
May 21 07:55:04 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand clear
May 21 07:55:04 volumio-werkkamer volumio[783]: info:
May 21 07:55:04 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:04 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:04 volumio-werkkamer volumio[783]: info: sendMpdCommand clear took 4 milliseconds
May 21 07:55:04 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand load "https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac"
May 21 07:55:04 volumio-werkkamer volumio[783]: info:
May 21 07:55:04 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:04 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:04 volumio-werkkamer volumio[783]: info:
May 21 07:55:04 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:04 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:04 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 192.168.2.11 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 6
May 21 07:55:04 volumio-werkkamer volumio[783]: info: go-librespot daemon successfully initialized
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetVisibleSources
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 21 07:55:04 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:55:04 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:04 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:04 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:55:06 volumio-werkkamer volumio[783]: error: updateQueue error: null
May 21 07:55:06 volumio-werkkamer volumio[783]: info: ------------------------------ 2553ms
May 21 07:55:06 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand add "https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac"
May 21 07:55:06 volumio-werkkamer volumio[783]: info: ------------------------------ 2549ms
May 21 07:55:06 volumio-werkkamer volumio[783]: info: ------------------------------ 2548ms
May 21 07:55:06 volumio-werkkamer volumio[783]: info:
May 21 07:55:06 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:06 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:06 volumio-werkkamer volumio[783]: info: sendMpdCommand add "https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac" took 2 milliseconds
May 21 07:55:06 volumio-werkkamer volumio[783]: info: CoreStateMachine::setConsumeUpdateService mpd
May 21 07:55:06 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand play
May 21 07:55:06 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:55:06 volumio-werkkamer volumio[783]: info:
May 21 07:55:06 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:06 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:06 volumio-werkkamer volumio[783]: info:
May 21 07:55:06 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:06 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:06 volumio-werkkamer volumio[783]: info: ------------------------------ 38ms
May 21 07:55:06 volumio-werkkamer volumio[783]: info: sendMpdCommand play took 36 milliseconds
May 21 07:55:06 volumio-werkkamer volumio[783]: info: ------------------------------ 30ms
May 21 07:55:06 volumio-werkkamer volumio[783]: info: ------------------------------ 28ms
May 21 07:55:07 volumio-werkkamer volumio-remote-updater[548]: [2025-05-21 07:55:07] [connect] Successful connection
May 21 07:55:07 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7
May 21 07:55:07 volumio-werkkamer volumio-remote-updater[548]: [2025-05-21 07:55:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747806907 101
May 21 07:55:07 volumio-werkkamer volumio[783]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
May 21 07:55:07 volumio-werkkamer volumio[783]: info: Initializing connection to go-librespot Websocket
May 21 07:55:07 volumio-werkkamer go-librespot[1046]: time="2025-05-21T07:55:07+02:00" level=debug msg="new websocket client"
May 21 07:55:07 volumio-werkkamer volumio[783]: info: Connection to go-librespot Websocket established
May 21 07:55:07 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:07 volumio-werkkamer systemd[1]: systemd-fsckd.service: Succeeded.
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 15 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 10 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 51 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 50 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 42 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 41 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 35 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus stop
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Received an update from plugin. extracting info from payload
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 130ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 138ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces system playlist update
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Ignoring MPD Status Update
May 21 07:55:08 volumio-werkkamer volumio[783]: info:
May 21 07:55:08 volumio-werkkamer volumio[783]: ---------------------------- MPD announces state update: player
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::getState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand status
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 116 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 110ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 103 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 96 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 92 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 89 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 26ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 23 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 17ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand status took 16 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseState
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"100 Kbps","isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Received an update from plugin. extracting info from payload
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":228,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"100 Kbps","isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Received an update from plugin. extracting info from payload
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"100 Kbps","isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Received an update from plugin. extracting info from payload
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 209ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 206ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 191ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 71 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 71 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 69 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: info: sendMpdCommand playlistinfo took 70 milliseconds
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: ControllerMpd::parseTrackInfo
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"100 Kbps","isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Received an update from plugin. extracting info from payload
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"100 Kbps","isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Received an update from plugin. extracting info from payload
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"100 Kbps","isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Received an update from plugin. extracting info from payload
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ControllerMpd::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::servicePushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CorePlayQueue::getTrack 0
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"100 Kbps","isStreaming":false,"title":"ALEX WARREN - ORDINARY","artist":"538","album":null,"uri":"https://playerservices.streamtheworld.com/api/livestream-redirect/RADIO538AAC.aac","trackType":"aac"}
May 21 07:55:08 volumio-werkkamer volumio[783]: verbose: CURRENT POSITION 0
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState stateService play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::syncState currentStatus play
May 21 07:55:08 volumio-werkkamer volumio[783]: info: Received an update from plugin. extracting info from payload
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 255ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 245ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 161ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: ------------------------------ 155ms
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:08 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:10 volumio-werkkamer volumio[783]: info: Getting Spotify volume
May 21 07:55:10 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
May 21 07:55:10 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 21 07:55:10 volumio-werkkamer volumio[783]: info: Adding plugin bluetooth to MyMusic Plugins
May 21 07:55:10 volumio-werkkamer volumio[783]: info: Adding plugin multiroom to MyMusic Plugins
May 21 07:55:10 volumio-werkkamer volumio[783]: info: Adding plugin metavolumio to MyMusic Plugins
May 21 07:55:10 volumio-werkkamer volumio[783]: info: Adding plugin cd_controller to MyMusic Plugins
May 21 07:55:10 volumio-werkkamer volumio[783]: info: Adding plugin qobuzconnect to MyMusic Plugins
May 21 07:55:10 volumio-werkkamer volumio[783]: info: Adding plugin smart_inputs to MyMusic Plugins
May 21 07:55:10 volumio-werkkamer volumio[783]: info: Adding plugin tidalconnect to MyMusic Plugins
May 21 07:55:10 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 21 07:55:11 volumio-werkkamer systemd[1]: systemd-hostnamed.service: Succeeded.
May 21 07:55:11 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 21 07:55:11 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 21 07:55:11 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:11 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:11 volumio-werkkamer volumio[783]: info: Starting MyVolumio Remote Streaming Endpoints
May 21 07:55:12 volumio-werkkamer volumio[783]: info: MyVolumio login type: Token
May 21 07:55:12 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 21 07:55:12 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 21 07:55:13 volumio-werkkamer volumio[980]: ...........................................................................................++++
May 21 07:55:13 volumio-werkkamer volumio[783]: info: Starting Streaming Service Transparent Proxy
May 21 07:55:13 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 21 07:55:13 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 21 07:55:13 volumio-werkkamer volumio[783]: info: Streaming services startup
May 21 07:55:13 volumio-werkkamer volumio[783]: info: Starting Streaming Daemon
May 21 07:55:13 volumio-werkkamer sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 21 07:55:13 volumio-werkkamer sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:13 volumio-werkkamer volumio[783]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 21 07:55:13 volumio-werkkamer sudo[1143]: pam_unix(sudo:session): session closed for user root
May 21 07:55:13 volumio-werkkamer volumio[783]: error: Cannot start Volumio Streaming Daemon
May 21 07:55:13 volumio-werkkamer volumio[783]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 21 07:55:13 volumio-werkkamer volumio[783]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 21 07:55:13 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:55:13 volumio-werkkamer volumio[783]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 21 07:55:14 volumio-werkkamer volumio[783]: STREAMING PROXY: Starting server on port 3245
May 21 07:55:14 volumio-werkkamer volumio[783]: Node JS runtime: 14
May 21 07:55:15 volumio-werkkamer volumio[783]: info: MyVolumio token set successfully
May 21 07:55:15 volumio-werkkamer volumio[783]: info: MYVOLUMIO: Adding device
May 21 07:55:15 volumio-werkkamer volumio[783]: info: MYVOLUMIO: Evaluating Server
May 21 07:55:15 volumio-werkkamer volumio[783]: info: MyVolumio status changed
May 21 07:55:15 volumio-werkkamer volumio[783]: info: Streaming services startup
May 21 07:55:15 volumio-werkkamer volumio[783]: info: Starting Streaming Daemon
May 21 07:55:15 volumio-werkkamer volumio[783]: info: Removing browser output: myVolumio user plan is not superstar
May 21 07:55:15 volumio-werkkamer volumio[783]: info: Removing audio output:
May 21 07:55:15 volumio-werkkamer volumio[783]: info: Stoppping Tunnel 1
May 21 07:55:15 volumio-werkkamer sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 21 07:55:15 volumio-werkkamer sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:15 volumio-werkkamer sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
May 21 07:55:15 volumio-werkkamer sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:15 volumio-werkkamer sudo[1172]: pam_unix(sudo:session): session closed for user root
May 21 07:55:15 volumio-werkkamer volumio[783]: error: Cannot start Volumio Streaming Daemon
May 21 07:55:15 volumio-werkkamer volumio[783]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 21 07:55:15 volumio-werkkamer volumio[783]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 21 07:55:15 volumio-werkkamer sudo[1175]: pam_unix(sudo:session): session closed for user root
May 21 07:55:15 volumio-werkkamer volumio[783]: info: Remote SSH Stopped
May 21 07:55:15 volumio-werkkamer volumio[783]: info: Setting Geolocation for MyVolumio to eu2
May 21 07:55:15 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:15 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:15 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:16 volumio-werkkamer volumio[783]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
May 21 07:55:16 volumio-werkkamer volumio[783]: info: Updating MyVolumio device info
May 21 07:55:16 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:17 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:17 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:55:17 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:55:17 volumio-werkkamer volumio[783]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
May 21 07:55:20 volumio-werkkamer systemd[1]: systemd-timedated.service: Succeeded.
May 21 07:55:20 volumio-werkkamer volumio[783]: info: MYVOLUMIO: Adding device
May 21 07:55:20 volumio-werkkamer volumio[783]: info: MYVOLUMIO: Evaluating Server
May 21 07:55:20 volumio-werkkamer volumio[783]: info: Setting Geolocation for MyVolumio to eu8
May 21 07:55:20 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:20 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:20 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:21 volumio-werkkamer volumio[980]: ....................................................................++++
May 21 07:55:21 volumio-werkkamer volumio[980]: e is 65537 (0x010001)
May 21 07:55:21 volumio-werkkamer volumio[980]: writing RSA key
May 21 07:55:21 volumio-werkkamer volumio[783]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
May 21 07:55:21 volumio-werkkamer volumio[783]: info: Updating MyVolumio device info
May 21 07:55:21 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:21 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:21 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:22 volumio-werkkamer volumio[783]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
May 21 07:55:23 volumio-werkkamer sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 21 07:55:23 volumio-werkkamer sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:23 volumio-werkkamer sudo[1240]: pam_unix(sudo:session): session closed for user root
May 21 07:55:23 volumio-werkkamer sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 21 07:55:23 volumio-werkkamer sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:23 volumio-werkkamer sudo[1243]: pam_unix(sudo:session): session closed for user root
May 21 07:55:23 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 192.168.2.11 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 8
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetVisibleSources
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 21 07:55:23 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:55:23 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:23 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 21 07:55:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 21 07:55:24 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 07:55:25 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:55:25 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 07:55:25 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:55:25 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:55:26 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 21 07:55:27 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
May 21 07:55:27 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:27 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:28 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 07:55:28 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 21 07:55:30 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 21 07:55:30 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:30 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 21 07:55:30 volumio-werkkamer volumio-remote-updater[548]: No test mode
May 21 07:55:30 volumio-werkkamer volumio-remote-updater[548]: No alpha test mode
May 21 07:55:30 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
May 21 07:55:30 volumio-werkkamer volumio[783]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
May 21 07:55:30 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 21 07:55:31 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:31 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:31 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 21 07:55:31 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 21 07:55:31 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 21 07:55:31 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetBrowseSources
May 21 07:55:31 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 21 07:55:33 volumio-werkkamer volumio[783]: error: MyVolumio Plugin failed to authenticate in a timely fashion
May 21 07:55:33 volumio-werkkamer volumio[783]: info: Completed starting MyVolumio Plugin
May 21 07:55:33 volumio-werkkamer volumio[783]: [Metrics] CommandRouter: 47s 922.28ms
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumiosetStartupVolume
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 21 07:55:33 volumio-werkkamer volumio[783]: info: VolumeController:: Setting startup Volume 100
May 21 07:55:33 volumio-werkkamer volumio[783]: info: VolumeController::SetAlsaVolume100
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::Close All Modals sent
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::Close All Modals sent
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreStateMachine::pushState
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 21 07:55:33 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioPushState
May 21 07:55:34 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 21 07:55:34 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 21 07:55:34 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 21 07:55:34 volumio-werkkamer volumio[783]: info: Version has changed, forcing UI Reload
May 21 07:55:34 volumio-werkkamer volumio[783]: info: CoreCommandRouter::Reload Ui
May 21 07:55:36 volumio-werkkamer sudo[1296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 21 07:55:36 volumio-werkkamer sudo[1296]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:36 volumio-werkkamer sudo[1296]: pam_unix(sudo:session): session closed for user root
May 21 07:55:36 volumio-werkkamer sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 21 07:55:36 volumio-werkkamer sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 21 07:55:36 volumio-werkkamer sudo[1298]: pam_unix(sudo:session): session closed for user root
May 21 07:55:36 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 192.168.2.11 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetVisibleSources
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 21 07:55:36 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:55:36 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:36 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 21 07:55:36 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 21 07:55:37 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:37 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:55:37 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:55:37 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 07:55:38 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:55:38 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 21 07:55:38 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:55:38 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:38 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:55:38 volumio-werkkamer volumiologrotate[566]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
May 21 07:55:38 volumio-werkkamer volumiologrotate[566]: ls: cannot access 'WERKKAMER': No such file or directory
May 21 07:55:40 volumio-werkkamer volumio[783]: info: BOOT COMPLETED
May 21 07:55:44 volumio-werkkamer volumio[783]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytcr/volumio/buster/armhf
May 21 07:55:46 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 21 07:55:46 volumio-werkkamer ntpd[753]: Soliciting pool server 164.92.156.55
May 21 07:55:47 volumio-werkkamer volumio[783]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ytcr/volumio/buster/armhf
May 21 07:55:47 volumio-werkkamer volumio[783]: info: [yt-cast-receiver] Player.reset()
May 21 07:55:47 volumio-werkkamer ntpd[753]: Soliciting pool server 45.138.55.60
May 21 07:55:47 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:47 volumio-werkkamer ntpd[753]: Soliciting pool server 191.96.11.19
May 21 07:55:47 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:48 volumio-werkkamer ntpd[753]: Soliciting pool server 104.167.19.180
May 21 07:55:48 volumio-werkkamer ntpd[753]: Soliciting pool server 149.210.142.45
May 21 07:55:49 volumio-werkkamer ntpd[753]: Soliciting pool server 103.204.195.5
May 21 07:55:49 volumio-werkkamer ntpd[753]: Soliciting pool server 45.159.204.28
May 21 07:55:50 volumio-werkkamer ntpd[753]: Soliciting pool server 81.172.248.188
May 21 07:55:51 volumio-werkkamer ntpd[753]: Soliciting pool server 86.80.166.233
May 21 07:55:51 volumio-werkkamer ntpd[753]: Soliciting pool server 191.96.11.19
May 21 07:55:52 volumio-werkkamer ntpd[753]: Soliciting pool server 185.244.24.70
May 21 07:55:52 volumio-werkkamer ntpd[753]: Soliciting pool server 2001:7b8:3:2b::5
May 21 07:55:53 volumio-werkkamer ntpd[753]: Soliciting pool server 23.94.217.117
May 21 07:55:54 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 21 07:55:54 volumio-werkkamer volumio[783]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 21 07:55:54 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 21 07:55:54 volumio-werkkamer volumio[783]: info: Received Get System Version
May 21 07:55:54 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 21 07:55:54 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:55:54 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:55:54 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:55:54 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:55:54 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:55:54 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:55:54 volumio-werkkamer ntpd[753]: Soliciting pool server 77.175.129.186
May 21 07:55:55 volumio-werkkamer ntpd[753]: receive: Unexpected origin timestamp 0xebd7e96a.459d426d does not match aorg 0000000000.00000000 from server@45.159.204.28 xmt 0xebd7e96b.1e04e71e
May 21 07:55:55 volumio-werkkamer ntpd[753]: receive: Unexpected origin timestamp 0xebd7e96a.459b8b18 does not match aorg 0000000000.00000000 from server@86.80.166.233 xmt 0xebd7e96b.1dda08c4
May 21 07:55:55 volumio-werkkamer ntpd[753]: receive: Unexpected origin timestamp 0xebd7e96a.459e47f9 does not match aorg 0000000000.00000000 from server@45.138.55.60 xmt 0xebd7e96b.1e503729
May 21 07:55:55 volumio-werkkamer ntpd[753]: receive: Unexpected origin timestamp 0xebd7e96a.4596b732 does not match aorg 0000000000.00000000 from server@23.94.217.117 xmt 0xebd7e96b.321e5850
May 21 07:55:56 volumio-werkkamer ntpd[753]: Soliciting pool server 185.45.112.121
May 21 07:55:57 volumio-werkkamer ntpd[753]: Soliciting pool server 162.159.200.123
May 21 07:55:57 volumio-werkkamer volumio[783]: info: Check plugin dependencies
May 21 07:55:58 volumio-werkkamer ntpd[753]: Soliciting pool server 178.239.19.56
May 21 07:55:59 volumio-werkkamer ntpd[753]: Soliciting pool server 94.198.159.11
May 21 07:56:00 volumio-werkkamer ntpd[753]: Soliciting pool server 158.101.216.150
May 21 07:56:02 volumio-werkkamer volumio-remote-updater[548]: [2025-05-21 07:56:02] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
May 21 07:56:07 volumio-werkkamer volumio-remote-updater[548]: [2025-05-21 07:56:07] [connect] Successful connection
May 21 07:56:20 volumio-werkkamer volumio-remote-updater[548]: [2025-05-21 07:56:20] [connect] Successful connection
May 21 07:56:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 21 07:56:23 volumio-werkkamer volumio[783]: info: Rename folder
May 21 07:56:23 volumio-werkkamer volumio[783]: info: Move to category
May 21 07:56:23 volumio-werkkamer volumio[783]: info: Folder /tmp/downloaded_plugin.zip removed
May 21 07:56:23 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:23 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 192.168.2.11 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 1
May 21 07:56:23 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 192.168.2.11 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 2
May 21 07:56:23 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 192.168.2.11 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 3
May 21 07:56:23 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 192.168.2.11 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
May 21 07:56:23 volumio-werkkamer volumio-remote-updater[548]: [2025-05-21 07:56:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747806980 101
May 21 07:56:23 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 5
May 21 07:56:23 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:56:23 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:23 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:23 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:23 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:23 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:23 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:23 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:56:23 volumio-werkkamer volumio[783]: info: Listing playlists
May 21 07:56:24 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:24 volumio-werkkamer volumio[783]: Upnp client error: Error: This socket has been ended by the other party
May 21 07:56:25 volumio-werkkamer volumio[783]: verbose: New Socket.io Connection to 192.168.2.11 from 192.168.2.63 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 6
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetVisibleSources
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 21 07:56:25 volumio-werkkamer volumio[783]: info: Received Get System Info
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 21 07:56:25 volumio-werkkamer volumio[783]: info: Discovery: Getting this device information
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 21 07:56:25 volumio-werkkamer volumio[783]: info: CoreCommandRouter::volumioGetState
May 21 07:56:27 volumio-werkkamer volumio[783]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 21 07:56:27 volumio-werkkamer volumio[783]: TypeError: Cannot read property 'plugin_type' of undefined
May 21 07:56:27 volumio-werkkamer volumio[783]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1644:56)
May 21 07:56:27 volumio-werkkamer volumio[783]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1540:29)
May 21 07:56:27 volumio-werkkamer volumio[783]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1342:45)
May 21 07:56:27 volumio-werkkamer volumio[783]: at Socket.emit (events.js:315:20)
May 21 07:56:27 volumio-werkkamer volumio[783]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
May 21 07:56:27 volumio-werkkamer volumio[783]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
May 21 07:56:27 volumio-werkkamer volumio[783]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 21 07:56:27 volumio-werkkamer sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-21 07:55
May 21 07:56:27 volumio-werkkamer sudo[1484]: 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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"