-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-11-01 17:18:38 CET. -- Nov 01 17:17:00 volumio-salon sudo[1132]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:00 volumio-salon volumio[998]: info: Loading plugin "alarm-clock"... Nov 01 17:17:00 volumio-salon volumio[998]: info: Loading plugin "airplay_emulation"... Nov 01 17:17:00 volumio-salon volumio[998]: info: Starting Shairport Sync Nov 01 17:17:00 volumio-salon volumio[998]: info: Loading plugin "last_100"... Nov 01 17:17:00 volumio-salon volumio[998]: info: Loading plugin "webradio"... Nov 01 17:17:00 volumio-salon volumio[998]: info: Loading plugin "i2s_dacs"... Nov 01 17:17:00 volumio-salon volumio[998]: info: I2S DAC not set, start Auto-detection Nov 01 17:17:00 volumio-salon volumio[998]: info: Loading plugin "volumiodiscovery"... Nov 01 17:17:00 volumio-salon volumio[998]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 01 17:17:00 volumio-salon volumio[998]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 01 17:17:00 volumio-salon volumio[998]: *** WARNING *** For more information see Nov 01 17:17:00 volumio-salon volumio[998]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 01 17:17:00 volumio-salon node[998]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 01 17:17:00 volumio-salon volumio[998]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 01 17:17:00 volumio-salon volumio[998]: *** WARNING *** For more information see Nov 01 17:17:00 volumio-salon node[998]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 01 17:17:00 volumio-salon node[998]: *** WARNING *** For more information see Nov 01 17:17:00 volumio-salon node[998]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 01 17:17:00 volumio-salon node[998]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 01 17:17:00 volumio-salon node[998]: *** WARNING *** For more information see Nov 01 17:17:00 volumio-salon volumio[998]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 01 17:17:00 volumio-salon volumio[998]: info: Discovery: Started advertising with name: Volumio-Salon Nov 01 17:17:00 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 01 17:17:00 volumio-salon volumio[998]: info: Loading plugin "spop"... Nov 01 17:17:02 volumio-salon volumio[998]: info: Loading plugin "outputs"... Nov 01 17:17:02 volumio-salon sudo[1111]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:02 volumio-salon volumio[998]: info: Loading plugin "albumart"... Nov 01 17:17:02 volumio-salon volumio[998]: info: Plugin example_plugin is not enabled Nov 01 17:17:02 volumio-salon volumio[998]: info: Loading plugin "inputs"... Nov 01 17:17:02 volumio-salon volumio[998]: info: Loading plugin "updater_comm"... Nov 01 17:17:02 volumio-salon volumio[998]: info: Plugin mpdemulation is not enabled Nov 01 17:17:02 volumio-salon volumio[998]: info: Loading plugin "rest_api"... Nov 01 17:17:02 volumio-salon volumio[998]: info: Loading plugin "websocket"... Nov 01 17:17:02 volumio-salon volumio[998]: info: Starting Socket.io Server version 2.3.0 Nov 01 17:17:02 volumio-salon volumio[998]: info: Loading plugin "lastfm"... Nov 01 17:17:02 volumio-salon volumio[998]: Forking 3 albumart workers Nov 01 17:17:03 volumio-salon volumio[998]: info: Loading i18n strings for locale pl Nov 01 17:17:03 volumio-salon volumio[998]: Updating browse sources language Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:17:03 volumio-salon volumio[998]: Starting albumart workers Nov 01 17:17:03 volumio-salon volumio[998]: Starting albumart workers Nov 01 17:17:03 volumio-salon volumio[998]: Starting albumart workers Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::initPlayerControls Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 17:17:03 volumio-salon volumio[998]: Express server listening on port 3000 Nov 01 17:17:03 volumio-salon volumio[998]: [Metrics] WebUI: 8s 829.36ms Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreStateMachine::resetVolumioState Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreStateMachine::getcurrentVolume Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::volumioRetrievevolume Nov 01 17:17:03 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:04 volumio-salon volumio[998]: info: Volumio Network Manager: Network status updated: 2 Nov 01 17:17:04 volumio-salon volumio-remote-updater[554]: [2025-11-01 17:17:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762013819 101 Nov 01 17:17:04 volumio-salon volumio[998]: 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: 1 Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:04 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:04 volumio-salon volumio[998]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Nov 01 17:17:04 volumio-salon volumio[998]: info: Reloading queue from file Nov 01 17:17:04 volumio-salon volumio[998]: info: VolumeController:: Volume=100 Mute =false Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:17:04 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreStateMachine::updateTrackBlock Nov 01 17:17:04 volumio-salon volumio[998]: info: CorePlayQueue::getTrackBlock Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::volumioRetrievevolume Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreStateMachine::setRepeat null single undefined Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:17:04 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreStateMachine::setRandom null Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:17:04 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:17:04 volumio-salon volumio[998]: info: Setting Device type: Raspberry PI Nov 01 17:17:04 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:17:04 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:17:04 volumio-salon volumio[998]: info: VolumeController:: Volume=100 Mute =false Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:17:04 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:17:04 volumio-salon volumio[998]: info: Discovery: adding a4e08a3a-5bac-42fd-b94e-8ff65732c35e Nov 01 17:17:04 volumio-salon volumio[998]: info: Discovery: Found device Volumio-Salon Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:04 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:04 volumio-salon volumio[998]: info: Completed loading Core Plugins Nov 01 17:17:04 volumio-salon volumio[998]: info: Preparing to generate the ALSA configuration file Nov 01 17:17:04 volumio-salon volumio[998]: info: Asound.conf file unchanged, so no further update is needed Nov 01 17:17:04 volumio-salon volumio[998]: info: Output device has changed, restarting MPD Nov 01 17:17:04 volumio-salon volumio[998]: info: Output device has changed, restarting Shairport Sync Nov 01 17:17:04 volumio-salon sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:04 volumio-salon sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:04 volumio-salon sudo[1275]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:04 volumio-salon sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 01 17:17:04 volumio-salon sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:04 volumio-salon systemd[1]: systemd-fsckd.service: Succeeded. Nov 01 17:17:04 volumio-salon systemd[1]: Stopping Music Player Daemon... Nov 01 17:17:04 volumio-salon volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 01 17:17:04 volumio-salon volumio[998]: info: ___________ START PLUGINS ___________ Nov 01 17:17:04 volumio-salon volumio[998]: info: ControllerMpd::onStart: Initializing MPD Nov 01 17:17:04 volumio-salon volumio[998]: info: Creating MPD Configuration file Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 17:17:04 volumio-salon sudo[1284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 01 17:17:04 volumio-salon volumio[998]: info: [1762013824868] CoreMusicLibrary::Adding element Serwery Mediów Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:17:04 volumio-salon sudo[1284]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:04 volumio-salon sudo[1284]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:04 volumio-salon sudo[1286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 01 17:17:04 volumio-salon sudo[1286]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:04 volumio-salon volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:04 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:04 volumio-salon systemd[1]: mpd.service: Succeeded. Nov 01 17:17:04 volumio-salon systemd[1]: Stopped Music Player Daemon. Nov 01 17:17:05 volumio-salon volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 01 17:17:05 volumio-salon volumio[998]: info: [1762013825011] CoreMusicLibrary::Adding element Last_100 Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 01 17:17:05 volumio-salon volumio[998]: info: [1762013825014] CoreMusicLibrary::Adding element Webradio Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 17:17:05 volumio-salon volumio[998]: info: Initializing BBC Radios Nov 01 17:17:05 volumio-salon systemd[1]: Starting Music Player Daemon... Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: Creating Spotify config file Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 01 17:17:05 volumio-salon volumio[998]: info: [1762013825106] CoreMusicLibrary::Adding element LastFM Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:17:05 volumio-salon volumio[998]: Cannot find translation for source LastFM Nov 01 17:17:05 volumio-salon volumio[998]: info: [LastFM] scrobbler initiated! Nov 01 17:17:05 volumio-salon volumio[998]: info: [LastFM] extended logging: false Nov 01 17:17:05 volumio-salon volumio[998]: info: [LastFM] try scrobble stream/radio plays: false Nov 01 17:17:05 volumio-salon volumio[998]: info: [LastFM] Left init routine Nov 01 17:17:05 volumio-salon volumio[998]: info: [LastFM] Socket already connected: true Nov 01 17:17:05 volumio-salon volumio[998]: info: Volumio Calling Home Nov 01 17:17:05 volumio-salon sudo[1295]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 01 17:17:05 volumio-salon sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:05 volumio-salon sudo[1295]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:05 volumio-salon volumio[998]: info: MPD Permissions set Nov 01 17:17:05 volumio-salon volumio[998]: info: MPD Permissions set Nov 01 17:17:05 volumio-salon volumio[998]: info: Volumio called home Nov 01 17:17:05 volumio-salon volumio[998]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 01 17:17:05 volumio-salon volumio[998]: info: Spotify config file written Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon sudo[1312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 01 17:17:05 volumio-salon sudo[1312]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:05 volumio-salon volumio[998]: info: No need to fix Spotify hosts Nov 01 17:17:05 volumio-salon systemd[1]: Started go-librespot Daemon. Nov 01 17:17:05 volumio-salon go-librespot[1322]: go-librespot daemon starting... Nov 01 17:17:05 volumio-salon sudo[1312]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:05 volumio-salon volumio[998]: info: Starting Shairport Sync Nov 01 17:17:05 volumio-salon volumio[998]: info: Starting Shairport Sync Nov 01 17:17:05 volumio-salon sudo[1325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 01 17:17:05 volumio-salon sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:05 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:05 volumio-salon sudo[1327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 01 17:17:05 volumio-salon sudo[1327]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:05 volumio-salon volumio[998]: info: Starting Shairport Sync Nov 01 17:17:05 volumio-salon systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 01 17:17:05 volumio-salon systemd[1]: shairport-sync.service: Succeeded. Nov 01 17:17:05 volumio-salon systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 01 17:17:05 volumio-salon sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 01 17:17:05 volumio-salon sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:05 volumio-salon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 01 17:17:05 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:05 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:05 volumio-salon sudo[1325]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:05 volumio-salon volumio[998]: info: Shairport-Sync Started Nov 01 17:17:05 volumio-salon volumio[998]: Error adding Membership: Error: addMembership EINVAL Nov 01 17:17:05 volumio-salon systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 01 17:17:05 volumio-salon systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 01 17:17:05 volumio-salon systemd[1]: shairport-sync.service: Succeeded. Nov 01 17:17:05 volumio-salon systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 01 17:17:05 volumio-salon systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 01 17:17:05 volumio-salon sudo[1331]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:05 volumio-salon sudo[1327]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:05 volumio-salon volumio[998]: info: Shairport-Sync Started Nov 01 17:17:05 volumio-salon volumio[998]: info: Shairport-Sync Started Nov 01 17:17:05 volumio-salon volumio[998]: info: [LastFM] finished init: Authenticated successfully! Nov 01 17:17:06 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:06+01:00" level=info msg="running go-librespot 0.4.0" Nov 01 17:17:06 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:06+01:00" level=debug msg="app state loaded" Nov 01 17:17:06 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:06+01:00" level=debug msg="stored credentials not found" Nov 01 17:17:06 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:06+01:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 17:17:06 volumio-salon sh[464]: timed out Nov 01 17:17:06 volumio-salon dhcpcd[511]: timed out Nov 01 17:17:06 volumio-salon sh[464]: dhcpcd exited Nov 01 17:17:06 volumio-salon dhcpcd[511]: dhcpcd exited Nov 01 17:17:06 volumio-salon sh[464]: ifup: failed to bring up eth0 Nov 01 17:17:06 volumio-salon systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 01 17:17:06 volumio-salon systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 01 17:17:06 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:06+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 17:17:06 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:06+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 01 17:17:06 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:06+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 01 17:17:06 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:06+01:00" level=info msg="zeroconf server listening on port 37181" Nov 01 17:17:06 volumio-salon mpd[1310]: Nov 01 17:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 01 17:17:06 volumio-salon systemd[1]: Started Music Player Daemon. Nov 01 17:17:06 volumio-salon sudo[1277]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:06 volumio-salon sudo[1286]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:07 volumio-salon volumio[998]: info: Completed starting Core Plugins Nov 01 17:17:07 volumio-salon volumio[998]: info: ------------------------------------------- Nov 01 17:17:07 volumio-salon volumio[998]: info: ----- MyVolumio plugins startup ---- Nov 01 17:17:07 volumio-salon volumio[998]: info: ------------------------------------------- Nov 01 17:17:07 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 01 17:17:07 volumio-salon volumio[998]: error: MPD error: The expression evaluated to a falsy value: Nov 01 17:17:07 volumio-salon volumio[998]: assert.ok(self.idling) Nov 01 17:17:07 volumio-salon volumio[998]: error: The expression evaluated to a falsy value: Nov 01 17:17:07 volumio-salon volumio[998]: assert.ok(self.idling) Nov 01 17:17:07 volumio-salon volumio[998]: info: MPD running with PID1310 Nov 01 17:17:07 volumio-salon volumio[998]: ,establishing connection Nov 01 17:17:07 volumio-salon volumio[998]: error: updateQueue error: null Nov 01 17:17:07 volumio-salon volumio[998]: error: updateQueue error: null Nov 01 17:17:08 volumio-salon systemd[1]: systemd-hostnamed.service: Succeeded. Nov 01 17:17:08 volumio-salon volumio[998]: info: go-librespot daemon successfully initialized Nov 01 17:17:09 volumio-salon sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 17:17:09 volumio-salon sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:09 volumio-salon sudo[1367]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:09 volumio-salon sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 17:17:09 volumio-salon sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:09 volumio-salon sudo[1369]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:09 volumio-salon sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 01 17:17:09 volumio-salon sudo[1373]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:09 volumio-salon systemd[1]: Started UPnP Renderer front-end to MPD. Nov 01 17:17:09 volumio-salon sudo[1373]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:09 volumio-salon volumio[998]: info: Upmpdcli Daemon Started Nov 01 17:17:09 volumio-salon volumio[1375]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 01 17:17:11 volumio-salon volumio[1375]: ...........++++ Nov 01 17:17:11 volumio-salon volumio[998]: info: Initializing connection to go-librespot Websocket Nov 01 17:17:11 volumio-salon go-librespot[1322]: time="2025-11-01T17:17:11+01:00" level=debug msg="new websocket client" Nov 01 17:17:11 volumio-salon volumio[998]: info: Connection to go-librespot Websocket established Nov 01 17:17:12 volumio-salon volumio[998]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 01 17:17:14 volumio-salon volumio[998]: info: Getting Spotify volume Nov 01 17:17:15 volumio-salon volumio[998]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 01 17:17:16 volumio-salon volumio[998]: Cannot compose Albumart path Nov 01 17:17:17 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:17 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:17 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:17 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:17 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:17:17 volumio-salon volumio[998]: SPOTIFY: SPOTIFY VOLUME undefined Nov 01 17:17:17 volumio-salon volumio[998]: SPOTIFY: VOLUMIO VOLUME 100 Nov 01 17:17:17 volumio-salon volumio[998]: info: Aligning Spotify Volume to Volumio Volume Nov 01 17:17:17 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:17 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:17 volumio-salon volumio[998]: info: Setting Spotify Volume from Volumio: 100 Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 01 17:17:17 volumio-salon volumio[998]: info: Adding plugin bluetooth to MyMusic Plugins Nov 01 17:17:17 volumio-salon volumio[998]: info: Adding plugin multiroom to MyMusic Plugins Nov 01 17:17:17 volumio-salon volumio[998]: info: Adding plugin metavolumio to MyMusic Plugins Nov 01 17:17:17 volumio-salon volumio[998]: info: Adding plugin cd_controller to MyMusic Plugins Nov 01 17:17:17 volumio-salon volumio[998]: info: Adding plugin qobuzconnect to MyMusic Plugins Nov 01 17:17:17 volumio-salon volumio[998]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 01 17:17:17 volumio-salon volumio[998]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 01 17:17:17 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 01 17:17:19 volumio-salon volumio[998]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 01 17:17:19 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 01 17:17:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:19 volumio-salon volumio[998]: info: Starting MyVolumio Remote Streaming Endpoints Nov 01 17:17:19 volumio-salon volumio[998]: info: MyVolumio login type: Token Nov 01 17:17:19 volumio-salon volumio[998]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 01 17:17:19 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 01 17:17:20 volumio-salon volumio[998]: info: Starting Streaming Service Transparent Proxy Nov 01 17:17:20 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 01 17:17:20 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 01 17:17:20 volumio-salon volumio[998]: info: Streaming services startup Nov 01 17:17:20 volumio-salon volumio[998]: info: Starting Streaming Daemon Nov 01 17:17:20 volumio-salon sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 01 17:17:20 volumio-salon sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:20 volumio-salon sudo[1412]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:20 volumio-salon volumio[998]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 01 17:17:20 volumio-salon volumio[998]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Nov 01 17:17:20 volumio-salon volumio[998]: info: Sending Spotify command with payload to local API: /player/volume Nov 01 17:17:20 volumio-salon volumio[998]: error: Cannot start Volumio Streaming Daemon Nov 01 17:17:20 volumio-salon volumio[998]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 01 17:17:20 volumio-salon volumio[998]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 01 17:17:20 volumio-salon volumio[998]: error: MyVolumio Custom Token format not valid, refreshing it Nov 01 17:17:21 volumio-salon volumio[998]: STREAMING PROXY: Starting server on port 3245 Nov 01 17:17:21 volumio-salon volumio[998]: Node JS runtime: 14 Nov 01 17:17:21 volumio-salon volumio[998]: info: MyVolumio login type: Token Nov 01 17:17:22 volumio-salon volumio[998]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 01 17:17:22 volumio-salon volumio[998]: info: MyVolumio token set successfully Nov 01 17:17:22 volumio-salon volumio[998]: info: MYVOLUMIO: Adding device Nov 01 17:17:22 volumio-salon volumio[998]: info: MYVOLUMIO: Evaluating Server Nov 01 17:17:22 volumio-salon volumio[1375]: ..................................................................................................++++ Nov 01 17:17:22 volumio-salon volumio[1375]: e is 65537 (0x010001) Nov 01 17:17:22 volumio-salon volumio[1375]: writing RSA key Nov 01 17:17:23 volumio-salon volumio[998]: info: MyVolumio status changed Nov 01 17:17:23 volumio-salon volumio[998]: info: Streaming services startup Nov 01 17:17:23 volumio-salon volumio[998]: info: Starting Streaming Daemon Nov 01 17:17:23 volumio-salon volumio[998]: info: Removing browser output: myVolumio user plan is not superstar Nov 01 17:17:23 volumio-salon volumio[998]: info: Removing audio output: Nov 01 17:17:23 volumio-salon volumio[998]: info: Stoppping Tunnel 1 Nov 01 17:17:23 volumio-salon sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 01 17:17:23 volumio-salon sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:23 volumio-salon sudo[1456]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:23 volumio-salon volumio[998]: error: Cannot start Volumio Streaming Daemon Nov 01 17:17:23 volumio-salon volumio[998]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 01 17:17:23 volumio-salon volumio[998]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 01 17:17:23 volumio-salon sudo[1459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 01 17:17:23 volumio-salon sudo[1459]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:17:23 volumio-salon sudo[1459]: pam_unix(sudo:session): session closed for user root Nov 01 17:17:23 volumio-salon volumio[998]: info: Remote SSH Stopped Nov 01 17:17:23 volumio-salon volumio[998]: info: Setting Geolocation for MyVolumio to eu10 Nov 01 17:17:23 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:23 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:23 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:24 volumio-salon volumio[998]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 01 17:17:24 volumio-salon volumio[998]: info: Updating MyVolumio device info Nov 01 17:17:24 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:24 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:24 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:25 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:25 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:25 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:17:25 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:17:25 volumio-salon volumio[998]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 01 17:17:28 volumio-salon systemd[1]: systemd-timedated.service: Succeeded. Nov 01 17:17:28 volumio-salon volumio[998]: info: MYVOLUMIO: Adding device Nov 01 17:17:28 volumio-salon volumio[998]: info: MYVOLUMIO: Evaluating Server Nov 01 17:17:28 volumio-salon volumio[998]: info: Setting Geolocation for MyVolumio to eu7 Nov 01 17:17:28 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:29 volumio-salon volumio[998]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 01 17:17:29 volumio-salon volumio[998]: info: Updating MyVolumio device info Nov 01 17:17:29 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:29 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:29 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:30 volumio-salon volumio[998]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 01 17:17:34 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 17:17:34 volumio-salon volumio[998]: 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 01 17:17:34 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:34 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:35 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 17:17:35 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:35 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 17:17:35 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 01 17:17:35 volumio-salon volumio-remote-updater[554]: No test mode Nov 01 17:17:35 volumio-salon volumio-remote-updater[554]: No alpha test mode Nov 01 17:17:35 volumio-salon volumio[998]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 01 17:17:35 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 01 17:17:35 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:35 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:39 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:39 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 01 17:17:39 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 01 17:17:39 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 01 17:17:39 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 17:17:39 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 17:17:40 volumio-salon volumio[998]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 01 17:17:40 volumio-salon volumio[998]: info: Completed starting MyVolumio Plugin Nov 01 17:17:40 volumio-salon volumio[998]: [Metrics] CommandRouter: 44s 605.16ms Nov 01 17:17:40 volumio-salon volumio[998]: info: CoreCommandRouter::volumiosetStartupVolume Nov 01 17:17:40 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 01 17:17:40 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 17:17:40 volumio-salon volumio[998]: info: CoreCommandRouter::Close All Modals sent Nov 01 17:17:40 volumio-salon volumio[998]: info: CoreCommandRouter::Close All Modals sent Nov 01 17:17:41 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 01 17:17:41 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 01 17:17:41 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 01 17:17:43 volumio-salon ntpd[728]: Soliciting pool server 212.127.95.218 Nov 01 17:17:44 volumio-salon ntpd[728]: Soliciting pool server 178.215.228.24 Nov 01 17:17:45 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:45 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:17:45 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:17:45 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:17:45 volumio-salon ntpd[728]: Soliciting pool server 158.75.5.245 Nov 01 17:17:46 volumio-salon ntpd[728]: Soliciting pool server 46.175.224.7 Nov 01 17:17:46 volumio-salon ntpd[728]: Soliciting pool server 193.70.94.182 Nov 01 17:17:46 volumio-salon ntpd[728]: Soliciting pool server 192.86.14.67 Nov 01 17:17:47 volumio-salon ntpd[728]: Soliciting pool server 46.174.178.150 Nov 01 17:17:47 volumio-salon volumio[998]: info: BOOT COMPLETED Nov 01 17:17:47 volumio-salon ntpd[728]: Soliciting pool server 212.127.78.21 Nov 01 17:17:47 volumio-salon ntpd[728]: Soliciting pool server 193.59.134.156 Nov 01 17:17:47 volumio-salon ntpd[728]: Soliciting pool server 51.68.141.5 Nov 01 17:17:48 volumio-salon ntpd[728]: Soliciting pool server 213.222.217.10 Nov 01 17:17:48 volumio-salon ntpd[728]: Soliciting pool server 194.146.251.100 Nov 01 17:17:48 volumio-salon ntpd[728]: Soliciting pool server 94.154.96.7 Nov 01 17:17:49 volumio-salon ntpd[728]: Soliciting pool server 162.159.200.123 Nov 01 17:17:49 volumio-salon ntpd[728]: Soliciting pool server 194.146.251.102 Nov 01 17:17:49 volumio-salon ntpd[728]: Soliciting pool server 109.206.205.233 Nov 01 17:17:50 volumio-salon ntpd[728]: Soliciting pool server 2606:4700:f1::123 Nov 01 17:17:56 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:17:56 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:06 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:06 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:06 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:18:06 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:18:16 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:16 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:18 volumio-salon sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 17:18:18 volumio-salon sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:18:18 volumio-salon sudo[1611]: pam_unix(sudo:session): session closed for user root Nov 01 17:18:18 volumio-salon sudo[1613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 17:18:18 volumio-salon sudo[1613]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:18:18 volumio-salon sudo[1613]: pam_unix(sudo:session): session closed for user root Nov 01 17:18:18 volumio-salon volumio[998]: verbose: New Socket.io Connection to 192.168.50.202 from 192.168.50.231 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 OPR/122.0.0.0 (Edition ms_store) Engine version: 3 Transport: polling Total Clients: 6 Nov 01 17:18:19 volumio-salon sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 01 17:18:19 volumio-salon sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:18:19 volumio-salon sudo[1617]: pam_unix(sudo:session): session closed for user root Nov 01 17:18:19 volumio-salon sudo[1619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 01 17:18:19 volumio-salon sudo[1619]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 01 17:18:19 volumio-salon sudo[1619]: pam_unix(sudo:session): session closed for user root Nov 01 17:18:19 volumio-salon volumio[998]: verbose: New Socket.io Connection to 192.168.50.202 from 192.168.50.231 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.0.0 Safari/537.36 OPR/122.0.0.0 (Edition ms_store) Engine version: 3 Transport: polling Total Clients: 7 Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetVisibleSources Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:19 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 01 17:18:19 volumio-salon volumio[998]: info: Received Get System Info Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 17:18:19 volumio-salon volumio[998]: info: Discovery: Getting this device information Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:19 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:19 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:19 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 01 17:18:19 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 01 17:18:20 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 01 17:18:20 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:20 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:21 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 17:18:21 volumio-salon volumio[998]: info: Received Get System Info Nov 01 17:18:21 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 17:18:21 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 17:18:21 volumio-salon volumio[998]: info: Discovery: Getting this device information Nov 01 17:18:21 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:21 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:21 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 17:18:21 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 01 17:18:23 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 17:18:23 volumio-salon volumio[998]: info: Received Get System Info Nov 01 17:18:23 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 17:18:23 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 17:18:23 volumio-salon volumio[998]: info: Discovery: Getting this device information Nov 01 17:18:23 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:23 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:23 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 17:18:26 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetQueue Nov 01 17:18:26 volumio-salon volumio[998]: info: CoreStateMachine::getQueue Nov 01 17:18:26 volumio-salon volumio[998]: info: CorePlayQueue::getQueue Nov 01 17:18:26 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:26 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:26 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:18:26 volumio-salon volumio[998]: info: Listing playlists Nov 01 17:18:28 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 17:18:28 volumio-salon volumio[998]: info: CURURI: artists:// Nov 01 17:18:28 volumio-salon volumio[998]: info: Preload queue cleared Nov 01 17:18:29 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 17:18:30 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 17:18:30 volumio-salon volumio[998]: info: CURURI: artists://A%20Perfect%20Circle Nov 01 17:18:30 volumio-salon volumio[998]: info: Preload queue cleared Nov 01 17:18:30 volumio-salon volumio[998]: info: Preload queue cleared Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/02 - Magdalena.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/03 - Rose.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/04 - Judith.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/05 - Orestes.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/06 - 3 Libras.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/07 - Sleeping Beauty.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/08 - Thomas.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/09 - Renholdër.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/10 - Thinking of You.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/11 - Breña.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/12 - Over.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 01 - The Package.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 02 - Weak And Powerless.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 03 - The Noose.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 04 - Blue.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 05 - Vanishing.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 06 - A Stranger.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 07 - The Outsider.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 08 - Crimes.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 09 - The Nurse Who Loved Me.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 10 - Pet.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 11 - Lullaby.mp3 Nov 01 17:18:30 volumio-salon volumio[998]: info: Preloading song: music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 12 - Gravity.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F01%20-%20The%20Hollow.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/02 - Magdalena.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F02%20-%20Magdalena.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/02 - Magdalena.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/03 - Rose.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F03%20-%20Rose.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/03 - Rose.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/04 - Judith.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F04%20-%20Judith.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/04 - Judith.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/05 - Orestes.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F05%20-%20Orestes.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/05 - Orestes.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/06 - 3 Libras.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F06%20-%203%20Libras.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/06 - 3 Libras.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/07 - Sleeping Beauty.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F07%20-%20Sleeping%20Beauty.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/07 - Sleeping Beauty.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/08 - Thomas.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F08%20-%20Thomas.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/08 - Thomas.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/09 - Renholdër.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F09%20-%20Renhold%C3%ABr.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/09 - Renholdër.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/10 - Thinking of You.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F10%20-%20Thinking%20of%20You.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/10 - Thinking of You.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/11 - Breña.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F11%20-%20Bre%C3%B1a.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/11 - Breña.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/12 - Over.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Mer%20De%20Noms/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2000%20-%20Mer%20De%20Noms%2F12%20-%20Over.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2000 - Mer De Noms/12 - Over.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 01 - The Package.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2001%20-%20The%20Package.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 01 - The Package.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 02 - Weak And Powerless.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2002%20-%20Weak%20And%20Powerless.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 02 - Weak And Powerless.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 03 - The Noose.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2003%20-%20The%20Noose.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 03 - The Noose.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 04 - Blue.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2004%20-%20Blue.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 04 - Blue.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 05 - Vanishing.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2005%20-%20Vanishing.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 05 - Vanishing.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 06 - A Stranger.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2006%20-%20A%20Stranger.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 06 - A Stranger.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 07 - The Outsider.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2007%20-%20The%20Outsider.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 07 - The Outsider.mp3 Nov 01 17:18:31 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 08 - Crimes.mp3 in service mpd Nov 01 17:18:31 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2008%20-%20Crimes.mp3&metadata=false Nov 01 17:18:31 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 08 - Crimes.mp3 Nov 01 17:18:32 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 09 - The Nurse Who Loved Me.mp3 in service mpd Nov 01 17:18:32 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2009%20-%20The%20Nurse%20Who%20Loved%20Me.mp3&metadata=false Nov 01 17:18:32 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 09 - The Nurse Who Loved Me.mp3 Nov 01 17:18:32 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 10 - Pet.mp3 in service mpd Nov 01 17:18:32 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2010%20-%20Pet.mp3&metadata=false Nov 01 17:18:32 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 10 - Pet.mp3 Nov 01 17:18:32 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 11 - Lullaby.mp3 in service mpd Nov 01 17:18:32 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2011%20-%20Lullaby.mp3&metadata=false Nov 01 17:18:32 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 11 - Lullaby.mp3 Nov 01 17:18:32 volumio-salon volumio[998]: info: Exploding uri music-library/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 12 - Gravity.mp3 in service mpd Nov 01 17:18:32 volumio-salon volumio[998]: info: ALBUMART /albumart?cacheid=220&web=A%20Perfect%20Circle/Thirteenth%20Step/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FA%20Perfect%20Circle%2F2003%20-%20Thirteenth%20Step%2FA%20Perfect%20Circle%20-%2012%20-%20Gravity.mp3&metadata=false Nov 01 17:18:32 volumio-salon volumio[998]: info: URI /mnt/NAS/NAS/A Perfect Circle/2003 - Thirteenth Step/A Perfect Circle - 12 - Gravity.mp3 Nov 01 17:18:33 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 01 17:18:33 volumio-salon volumio[998]: info: CURURI: artists://A%20Perfect%20Circle/Mer%20De%20Noms Nov 01 17:18:33 volumio-salon volumio[998]: info: Preload queue cleared Nov 01 17:18:34 volumio-salon volumio[998]: info: No valid Plugin REST Endpoint Nov 01 17:18:34 volumio-salon volumio[998]: info: No valid Plugin REST Endpoint Nov 01 17:18:35 volumio-salon volumio[998]: info: Preload queue cleared Nov 01 17:18:35 volumio-salon volumio[998]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 01 17:18:35 volumio-salon volumio[998]: info: CoreStateMachine::ClearQueue Nov 01 17:18:35 volumio-salon volumio[998]: info: CoreStateMachine::stop Nov 01 17:18:35 volumio-salon volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:18:35 volumio-salon volumio[998]: info: CorePlayQueue::clearPlayQueue Nov 01 17:18:35 volumio-salon volumio[998]: info: CorePlayQueue::saveQueue Nov 01 17:18:35 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushQueue Nov 01 17:18:35 volumio-salon volumio[998]: info: CoreStateMachine::addQueueItems Nov 01 17:18:35 volumio-salon volumio[998]: info: CorePlayQueue::addQueueItems Nov 01 17:18:35 volumio-salon volumio[998]: info: Preload queue cleared Nov 01 17:18:35 volumio-salon volumio[998]: info: Adding Item to queue: artists://A%20Perfect%20Circle/Mer%20De%20Noms Nov 01 17:18:35 volumio-salon volumio[998]: info: Exploding uri artists://A%20Perfect%20Circle/Mer%20De%20Noms in service mpd Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushQueue Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::saveQueue Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::updateTrackBlock Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrackBlock Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPlay Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::play index 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::stop Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::play index undefined Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::startPlaybackTimer Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3 Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand stop took 3 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces system playlist update Nov 01 17:18:36 volumio-salon volumio[998]: info: Ignoring MPD Status Update Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand clear took 13 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3" Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces system playlist update Nov 01 17:18:36 volumio-salon volumio[998]: info: Ignoring MPD Status Update Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces system playlist update Nov 01 17:18:36 volumio-salon volumio[998]: info: Ignoring MPD Status Update Nov 01 17:18:36 volumio-salon volumio[998]: error: updateQueue error: null Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces system playlist update Nov 01 17:18:36 volumio-salon volumio[998]: info: Ignoring MPD Status Update Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 13ms Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand add "NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3" took 10 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 8ms Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 7ms Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand play Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces system playlist update Nov 01 17:18:36 volumio-salon volumio[998]: info: Ignoring MPD Status Update Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces system playlist update Nov 01 17:18:36 volumio-salon volumio[998]: info: Ignoring MPD Status Update Nov 01 17:18:36 volumio-salon volumio[998]: error: Upnp client error: Error: This socket has been ended by the other party Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 12ms Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand play took 9 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 8ms Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 7ms Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces state update: player Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::getState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces state update: player Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::getState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces state update: player Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::getState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces state update: player Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::getState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces state update: player Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::getState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:18:36 volumio-salon volumio[998]: info: Nov 01 17:18:36 volumio-salon volumio[998]: ---------------------------- MPD announces state update: player Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand status took 12 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::getState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand status Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand status took 11 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand status took 10 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand status took 8 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand status took 7 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand status took 11 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseState Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::servicePushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":179,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Hollow","artist":"A Perfect Circle","album":"Mer De Noms","uri":"NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3","trackType":"mp3"} Nov 01 17:18:36 volumio-salon volumio[998]: verbose: CURRENT POSITION 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState stateService play Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState currentStatus stop Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::servicePushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":179,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Hollow","artist":"A Perfect Circle","album":"Mer De Noms","uri":"NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3","trackType":"mp3"} Nov 01 17:18:36 volumio-salon volumio[998]: verbose: CURRENT POSITION 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState stateService play Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:18:36 volumio-salon volumio[998]: info: Received an update from plugin. extracting info from payload Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::servicePushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":179,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Hollow","artist":"A Perfect Circle","album":"Mer De Noms","uri":"NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3","trackType":"mp3"} Nov 01 17:18:36 volumio-salon volumio[998]: verbose: CURRENT POSITION 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState stateService play Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:18:36 volumio-salon volumio[998]: info: Received an update from plugin. extracting info from payload Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::servicePushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":179,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Hollow","artist":"A Perfect Circle","album":"Mer De Noms","uri":"NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3","trackType":"mp3"} Nov 01 17:18:36 volumio-salon volumio[998]: verbose: CURRENT POSITION 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState stateService play Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:18:36 volumio-salon volumio[998]: info: Received an update from plugin. extracting info from payload Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::servicePushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":179,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Hollow","artist":"A Perfect Circle","album":"Mer De Noms","uri":"NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3","trackType":"mp3"} Nov 01 17:18:36 volumio-salon volumio[998]: verbose: CURRENT POSITION 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState stateService play Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:18:36 volumio-salon volumio[998]: info: Received an update from plugin. extracting info from payload Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 90ms Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 148ms Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 146ms Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 144ms Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 143ms Nov 01 17:18:36 volumio-salon volumio[998]: info: sendMpdCommand playlistinfo took 126 milliseconds Nov 01 17:18:36 volumio-salon volumio[998]: verbose: ControllerMpd::parseTrackInfo Nov 01 17:18:36 volumio-salon volumio[998]: info: ControllerMpd::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::servicePushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":179,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"The Hollow","artist":"A Perfect Circle","album":"Mer De Noms","uri":"NAS/NAS/A Perfect Circle/2000 - Mer De Noms/01 - The Hollow.mp3","trackType":"mp3"} Nov 01 17:18:36 volumio-salon volumio[998]: verbose: CURRENT POSITION 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState stateService play Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::syncState currentStatus play Nov 01 17:18:36 volumio-salon volumio[998]: info: Received an update from plugin. extracting info from payload Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreStateMachine::pushState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioPushState Nov 01 17:18:36 volumio-salon volumio[998]: info: ------------------------------ 172ms Nov 01 17:18:36 volumio-salon volumio[998]: info: [LastFM] Current track has sufficient metadata: title (The Hollow) and artist (A Perfect Circle) passed on explicitly Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 01 17:18:36 volumio-salon volumio[998]: info: CoreCommandRouter::volumioGetState Nov 01 17:18:36 volumio-salon volumio[998]: info: CorePlayQueue::getTrack 0 Nov 01 17:18:36 volumio-salon volumio[998]: info: [LastFM] track info: {"success":true,"trackInfo":{"name":"The Hollow","mbid":"03ef7153-77dd-3851-a2b9-4313c4c463e4","url":"https://www.last.fm/music/A+Perfect+Circle/_/The+Hollow","duration":"288000","streamable":{"#":"0","@":{"fulltrack":"0"}},"listeners":"536422","playcount":"4112241","artist":{"name":"A Perfect Circle","mbid":"078a9376-3c04-4280-b7d7-b20e158f345d","url":"https://www.last.fm/music/A+Perfect+Circle"},"album":{"artist":"A Perfect Circle","title":"Mer de noms","url":"https://www.last.fm/music/A+Perfect+Circle/Mer+de+noms","image":[{"#":"https://lastfm.freetls.fastly.net/i/u/34s/63d10287cb9c44d6950c08d9418bf59b.png","@":{"size":"small"}},{"#":"https://lastfm.freetls.fastly.net/i/u/64s/63d10287cb9c44d6950c08d9418bf59b.png","@":{"size":"medium"}},{"#":"https://lastfm.freetls.fastly.net/i/u/174s/63d10287cb9c44d6950c08d9418bf59b.png","@":{"size":"large"}},{"#":"https://lastfm.freetls.fastly.net/i/u/300x300/63d10287cb9c44d6950c08d9418bf59b.png","@":{"size":"extralarge"}}]},"userplaycount":"7","userloved":"0","toptags":"","wiki":{"published":"08 Jul 2009, 16:00","summary":"\"The Hollow\" is a single from A Perfect Circle's 2000 album Mer de Noms. It serves as the opening track of the album, utilizing layered guitars. \"The Hollow\" was recorded in the key of B-flat minor and is arranged using a 6/8 time signature. Tim Alexander, drummer from the band Primus plays drums on the album version of the song. The song was remixed for the 2001 single release. Read more on Last.fm.","content":"\"The Hollow\" is a single from A Perfect Circle's 2000 album Mer de Noms. It serves as the opening track of the album, utilizing layered guitars. \"The Hollow\" was recorded in the key of B-flat minor and is arranged using a 6/8 time signature. Tim Alexander, drummer from the band Primus plays drums on the album version of the song. The song was remixed for the 2001 single release. Read more on Last.fm. User-contributed text is available under the Creative Commons By-SA License; additional terms may apply."}}} Nov 01 17:18:37 volumio-salon volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 17:18:37 volumio-salon volumio[998]: TypeError: Cannot read property 'slice' of null Nov 01 17:18:37 volumio-salon volumio[998]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Nov 01 17:18:37 volumio-salon volumio[998]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Nov 01 17:18:37 volumio-salon volumio[998]: at Object.onceWrapper (events.js:422:26) Nov 01 17:18:37 volumio-salon volumio[998]: at ClientRequest.emit (events.js:315:20) Nov 01 17:18:37 volumio-salon volumio[998]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Nov 01 17:18:37 volumio-salon volumio[998]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Nov 01 17:18:37 volumio-salon volumio[998]: at TLSSocket.socketOnData (_http_client.js:509:22) Nov 01 17:18:37 volumio-salon volumio[998]: at TLSSocket.emit (events.js:315:20) Nov 01 17:18:37 volumio-salon volumio[998]: at addChunk (internal/streams/readable.js:309:12) Nov 01 17:18:37 volumio-salon volumio[998]: at readableAddChunk (internal/streams/readable.js:284:9) Nov 01 17:18:37 volumio-salon volumio[998]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Nov 01 17:18:37 volumio-salon volumio[998]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Nov 01 17:18:37 volumio-salon volumio[998]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 17:18:38 volumio-salon sudo[1703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-01 17:17 Nov 01 17:18:38 volumio-salon sudo[1703]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"