Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Volumio Calling Home Oct 12 13:25:00 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:00.111+01:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreStateMachine::setRepeat null single undefined Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreStateMachine::setRandom null Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:00 volumio-soyo volumio[1273]: info: MPD Permissions set Oct 12 13:25:00 volumio-soyo volumio[1273]: info: MPD Permissions set Oct 12 13:25:00 volumio-soyo volumio[1273]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Spotify config file written Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Discovery: adding e9454958-3eea-40b3-9d9e-2e1c7cfc2384 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Discovery: Found device Volumio-SOYO Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:00 volumio-soyo sudo[1743]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 12 13:25:00 volumio-soyo sudo[1743]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:00 volumio-soyo volumio[1273]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 13:25:00 volumio-soyo systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 12 13:25:00 volumio-soyo go-librespot[1748]: go-librespot daemon starting... Oct 12 13:25:00 volumio-soyo sudo[1743]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:00 volumio-soyo volumio[1273]: info: No need to fix Spotify hosts Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Discovery: this is already registered, e9454958-3eea-40b3-9d9e-2e1c7cfc2384 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Discovery: Found device Volumio-SOYO Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=info msg="running go-librespot 0.9.1" Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 12 13:25:00 volumio-soyo volumio[1273]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Received Get System Info Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Discovery: Getting this device information Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=debug msg="app state loaded" Oct 12 13:25:00 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:00.674+01:00 level=INFO msg="system info for 5a1cb20401210e07980a47484312aa1a" deviceName=Volumio-SOYO deviceVariant=volumio deviceModel= softwareVersion=4.119 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Volumio called home Oct 12 13:25:00 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:00.706+01:00 level=INFO msg="bootstrapping state" hasInternet=true Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Received Get System Info Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Discovery: Getting this device information Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:00 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Starting Shairport Sync Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Starting Shairport Sync Oct 12 13:25:00 volumio-soyo volumio[1273]: info: Starting Shairport Sync Oct 12 13:25:00 volumio-soyo sudo[1780]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 13:25:00 volumio-soyo sudo[1780]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:00 volumio-soyo volumio-remote-updater[753]: Test mode disabled Oct 12 13:25:00 volumio-soyo volumio-remote-updater[753]: Alpha mode disabled Oct 12 13:25:00 volumio-soyo volumio-remote-updater[753]: Alpha legacy test mode disabled Oct 12 13:25:00 volumio-soyo sudo[1785]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 13:25:00 volumio-soyo sudo[1783]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 13:25:00 volumio-soyo sudo[1783]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:00 volumio-soyo sudo[1785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:00 volumio-soyo systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 13:25:00 volumio-soyo systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 13:25:00 volumio-soyo systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 13:25:00 volumio-soyo systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 13:25:00 volumio-soyo sudo[1780]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:00 volumio-soyo systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 12 13:25:00 volumio-soyo systemd[1]: shairport-sync.service: Deactivated successfully. Oct 12 13:25:00 volumio-soyo systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=info msg="zeroconf server listening on port 43649" Oct 12 13:25:00 volumio-soyo systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 12 13:25:00 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:00+01:00" level=info msg="loading previously persisted zeroconf credentials" username="31************************yi" Oct 12 13:25:00 volumio-soyo sudo[1785]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:00 volumio-soyo sudo[1783]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:01 volumio-soyo volumio[1273]: info: Shairport-Sync Started Oct 12 13:25:01 volumio-soyo volumio[1273]: Error adding Membership: Error: addMembership EINVAL Oct 12 13:25:01 volumio-soyo volumio[1273]: info: Shairport-Sync Started Oct 12 13:25:01 volumio-soyo volumio[1273]: info: Shairport-Sync Started Oct 12 13:25:01 volumio-soyo volumio[1273]: info: New Spotify access tokenBQCDGiuHGe... Oct 12 13:25:01 volumio-soyo volumio[1273]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:01 volumio-soyo volumio[1273]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 13:25:01 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:01.102+01:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Oct 12 13:25:01 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:01.103+01:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Oct 12 13:25:01 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:01.103+01:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 13:25:01 volumio-soyo volumio[1273]: info: Received Get System Info Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 13:25:01 volumio-soyo volumio[1273]: info: Discovery: Getting this device information Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 12 13:25:01 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:01.121+01:00 level=INFO msg="enabling local network discovery" Oct 12 13:25:01 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:01.134+01:00 level=INFO msg="enabling BLE discovery" Oct 12 13:25:01 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:01+01:00" level=debug msg="obtained new client token: AAGKp1HSZuqmMcvC46j/isQ/xynEVbAjjqQrWS5fm4SoceuteOMO/DmHmzZdKwr4cMnI/7CFuAk8DWuOIMBvTuQh9RgJ1J74foRjpGYYCyKEJIard/eX6aPoAItQTGxy8HqGyXg5CFOqRpNgjg2mziwUefNRGA1Zci2C9lcSjdFUJIIrAlM9fSTQyrULaWeiaH8k0B0TW2Z+pvRCVj6m0rxRy6ZusLj2gMQOKcRlv9GXlqq9f2JKryZUOg==" Oct 12 13:25:01 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:01+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 12 13:25:01 volumio-soyo volumio[1273]: SPOTIFY: User informations: {"account_id":"5fs0U6djG6","country":"BR","display_name":"Bruno Fialho","email":"bruno.fialho@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/31tlxhhvgj5ancrbgiycaqkhkryi"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/31tlxhhvgj5ancrbgiycaqkhkryi","id":"31tlxhhvgj5ancrbgiycaqkhkryi","images":[],"product":"premium","type":"user","uri":"spotify:user:31tlxhhvgj5ancrbgiycaqkhkryi"} Oct 12 13:25:01 volumio-soyo volumio[1273]: info: Spotify Successfully logged in Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 13:25:01 volumio-soyo volumio[1273]: info: [1791807901313] CoreMusicLibrary::Adding element Spotify Oct 12 13:25:01 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 13:25:01 volumio-soyo volumio[1273]: Cannot find translation for source Spotify Oct 12 13:25:01 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:01+01:00" level=debug msg="completed keyexchange" Oct 12 13:25:01 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:01+01:00" level=debug msg="completed challenge" Oct 12 13:25:01 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:01+01:00" level=info msg="authenticated AP" username="31************************yi" Oct 12 13:25:02 volumio-soyo ntpd[1089]: CLOCK: time stepped by 0.480926 Oct 12 13:25:02 volumio-soyo ntpd[1089]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Oct 12 13:25:02 volumio-soyo systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. Oct 12 13:25:02 volumio-soyo systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 13:25:02 volumio-soyo systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 13:25:02 volumio-soyo upmpdcli[1817]: Could not open config: /tmp/upmpdcli.conf Oct 12 13:25:02 volumio-soyo systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 12 13:25:02 volumio-soyo systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=info msg="authenticated Login5" username="31************************yi" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="initializing zeroconf session" username="31************************yi" Oct 12 13:25:02 volumio-soyo mpd[1713]: 2026-10-12T13:25:02 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 12 13:25:02 volumio-soyo systemd[1]: Started mpd.service - Music Player Daemon. Oct 12 13:25:02 volumio-soyo sudo[1687]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:02 volumio-soyo sudo[1670]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:02 volumio-soyo volumio[1273]: info: Completed starting Core Plugins Oct 12 13:25:02 volumio-soyo volumio[1273]: info: ------------------------------------------- Oct 12 13:25:02 volumio-soyo volumio[1273]: info: ----- MyVolumio plugins startup ---- Oct 12 13:25:02 volumio-soyo volumio[1273]: info: ------------------------------------------- Oct 12 13:25:02 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 12 13:25:02 volumio-soyo volumio[1273]: info: MPD running with PID1713 Oct 12 13:25:02 volumio-soyo volumio[1273]: ,establishing connection Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="avahi service \"Volumio-SOYO\" established" Oct 12 13:25:02 volumio-soyo volumio[1273]: error: MPD error: The expression evaluated to a falsy value: Oct 12 13:25:02 volumio-soyo volumio[1273]: assert.ok(self.idling) Oct 12 13:25:02 volumio-soyo volumio[1273]: error: The expression evaluated to a falsy value: Oct 12 13:25:02 volumio-soyo volumio[1273]: assert.ok(self.idling) Oct 12 13:25:02 volumio-soyo volumio[1273]: error: MPD error: The expression evaluated to a falsy value: Oct 12 13:25:02 volumio-soyo volumio[1273]: assert.ok(self.idling) Oct 12 13:25:02 volumio-soyo volumio[1273]: error: The expression evaluated to a falsy value: Oct 12 13:25:02 volumio-soyo volumio[1273]: assert.ok(self.idling) Oct 12 13:25:02 volumio-soyo volumio[1273]: error: updateQueue error: null Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="connected to gew1-dealer.spotify.com:443" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=trace msg="starting accesspoint recv loop" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=trace msg="starting dealer recv loop" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="received connection id: ZjhmYWMwZTctYTFi...MkRDMTlBRjNENw==" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="put connect state because NEW_DEVICE" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=trace msg="emitting websocket event: playback_ready" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="update volume requested to 65535/65535" Oct 12 13:25:02 volumio-soyo volumio5-onboarding[1689]: time=2026-10-12T13:25:02.640+01:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Oct 12 13:25:02 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:02+01:00" level=trace msg="emitting websocket event: volume" Oct 12 13:25:03 volumio-soyo volumio[1273]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 12 13:25:03 volumio-soyo volumio[1273]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 12 13:25:04 volumio-soyo volumio[1273]: info: go-librespot daemon successfully initialized Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 12 13:25:04 volumio-soyo volumio[1273]: info: Received Get System Info Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 13:25:04 volumio-soyo volumio[1273]: info: Discovery: Getting this device information Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:04 volumio-soyo volumio[1273]: info: Listing playlists Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:04 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:05 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 13:25:05 volumio-soyo volumio[1273]: info: Received Get System Info Oct 12 13:25:05 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 13:25:05 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 13:25:05 volumio-soyo volumio[1273]: info: Discovery: Getting this device information Oct 12 13:25:05 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:05 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:05 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 13:25:06 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 12 13:25:06 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 12 13:25:06 volumio-soyo sudo[1845]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 13:25:06 volumio-soyo sudo[1843]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 13:25:06 volumio-soyo sudo[1843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:06 volumio-soyo sudo[1845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:06 volumio-soyo sudo[1843]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:06 volumio-soyo sudo[1845]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:06 volumio-soyo sudo[1849]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 12 13:25:06 volumio-soyo sudo[1849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:06 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 13:25:06 volumio-soyo volumio[1273]: info: Received Get System Info Oct 12 13:25:06 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 13:25:06 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 13:25:06 volumio-soyo volumio[1273]: info: Discovery: Getting this device information Oct 12 13:25:06 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:06 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:06 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 13:25:07 volumio-soyo volumio[1273]: info: Initializing connection to go-librespot Websocket Oct 12 13:25:07 volumio-soyo go-librespot[1751]: time="2026-10-12T13:25:07+01:00" level=debug msg="new websocket client" Oct 12 13:25:07 volumio-soyo volumio[1273]: info: Connection to go-librespot Websocket established Oct 12 13:25:07 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 12 13:25:07 volumio-soyo volumio[1273]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 12 13:25:08 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetQueue Oct 12 13:25:08 volumio-soyo volumio[1273]: info: CoreStateMachine::getQueue Oct 12 13:25:08 volumio-soyo volumio[1273]: info: CorePlayQueue::getQueue Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Getting Spotify volume Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Spotify volume: 100 Oct 12 13:25:10 volumio-soyo volumio[1273]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 12 13:25:10 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:10 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:10 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 13:25:10 volumio-soyo volumio[1273]: info: CURURI: music-library Oct 12 13:25:10 volumio-soyo volumio[1273]: error: Failed LSINFO: null Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Preload queue cleared Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Adding plugin bluetooth to MyMusic Plugins Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Adding plugin multiroom to MyMusic Plugins Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Adding plugin metavolumio to MyMusic Plugins Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Adding plugin cd_controller to MyMusic Plugins Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 12 13:25:10 volumio-soyo volumio[1273]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 12 13:25:10 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 12 13:25:11 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 12 13:25:11 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 12 13:25:11 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:11 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:11 volumio-soyo volumio[1273]: info: Starting MyVolumio Remote Streaming Endpoints Oct 12 13:25:11 volumio-soyo volumio[1273]: info: MyVolumio login type: Token Oct 12 13:25:11 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 12 13:25:11 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 12 13:25:11 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 12 13:25:11 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 12 13:25:11 volumio-soyo volumio[1273]: info: Streaming services startup Oct 12 13:25:11 volumio-soyo volumio[1273]: info: Starting Streaming Daemon Oct 12 13:25:11 volumio-soyo volumio[1273]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 12 13:25:11 volumio-soyo sudo[1859]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 12 13:25:11 volumio-soyo sudo[1859]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:11 volumio-soyo sudo[1859]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:11 volumio-soyo volumio[1273]: error: Cannot start Volumio Streaming Daemon Oct 12 13:25:11 volumio-soyo volumio[1273]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 12 13:25:11 volumio-soyo volumio[1273]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 12 13:25:12 volumio-soyo volumio[1273]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 12 13:25:13 volumio-soyo volumio[1273]: info: MyVolumio token set successfully Oct 12 13:25:13 volumio-soyo volumio[1273]: info: MYVOLUMIO: Adding device Oct 12 13:25:13 volumio-soyo volumio[1273]: info: MYVOLUMIO: Evaluating Server Oct 12 13:25:13 volumio-soyo volumio[1273]: info: MyVolumio status changed Oct 12 13:25:13 volumio-soyo volumio[1273]: info: Streaming services startup Oct 12 13:25:13 volumio-soyo volumio[1273]: info: Starting Streaming Daemon Oct 12 13:25:13 volumio-soyo volumio[1273]: info: Removing browser output: myVolumio user plan is not superstar Oct 12 13:25:13 volumio-soyo volumio[1273]: info: Removing audio output: Oct 12 13:25:13 volumio-soyo volumio[1273]: info: Stoppping Tunnel 1 Oct 12 13:25:13 volumio-soyo sudo[1891]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 12 13:25:13 volumio-soyo sudo[1889]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 12 13:25:13 volumio-soyo sudo[1889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:13 volumio-soyo sudo[1891]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 13:25:13 volumio-soyo sudo[1889]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:13 volumio-soyo volumio[1273]: error: Cannot start Volumio Streaming Daemon Oct 12 13:25:13 volumio-soyo volumio[1273]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 12 13:25:13 volumio-soyo volumio[1273]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 12 13:25:13 volumio-soyo systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 13:25:13 volumio-soyo systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 13:25:13 volumio-soyo systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 13:25:13 volumio-soyo systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 13:25:13 volumio-soyo systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 13:25:13 volumio-soyo systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 12 13:25:13 volumio-soyo sudo[1891]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:13 volumio-soyo volumio[1273]: info: Remote SSH Stopped Oct 12 13:25:13 volumio-soyo volumio[1273]: info: Setting Geolocation for MyVolumio to eu11 Oct 12 13:25:13 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:13 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:13 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:13 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 12 13:25:14 volumio-soyo volumio[1273]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 12 13:25:14 volumio-soyo volumio[1273]: info: Updating MyVolumio device info Oct 12 13:25:14 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:14 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:14 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:15 volumio-soyo volumio[1273]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 12 13:25:15 volumio-soyo systemd[1]: systemd-fsckd.service: Deactivated successfully. Oct 12 13:25:16 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 13:25:16 volumio-soyo volumio[1273]: info: CURURI: music-library Oct 12 13:25:16 volumio-soyo volumio[1273]: error: Failed LSINFO: null Oct 12 13:25:16 volumio-soyo volumio[1273]: info: Preload queue cleared Oct 12 13:25:17 volumio-soyo systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Oct 12 13:25:17 volumio-soyo systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 13:25:17 volumio-soyo systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 13:25:17 volumio-soyo sudo[1849]: pam_unix(sudo:session): session closed for user root Oct 12 13:25:17 volumio-soyo volumio[1273]: info: Upmpdcli Daemon Started Oct 12 13:25:18 volumio-soyo volumio[1273]: info: MYVOLUMIO: Adding device Oct 12 13:25:18 volumio-soyo volumio[1273]: info: MYVOLUMIO: Evaluating Server Oct 12 13:25:18 volumio-soyo systemd[1]: systemd-hostnamed.service: Deactivated successfully. Oct 12 13:25:18 volumio-soyo volumio[1273]: info: Setting Geolocation for MyVolumio to eu11 Oct 12 13:25:18 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:18 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:18 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:18 volumio-soyo upmpdcli[1950]: writing RSA key Oct 12 13:25:19 volumio-soyo volumio[1273]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 12 13:25:19 volumio-soyo volumio[1273]: info: Updating MyVolumio device info Oct 12 13:25:19 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:19 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:19 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:20 volumio-soyo volumio[1273]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 12 13:25:23 volumio-soyo volumio[1273]: info: Received Get System Version Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 13:25:23 volumio-soyo volumio[1273]: info: Received Get System Info Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 13:25:23 volumio-soyo volumio[1273]: info: Discovery: Getting this device information Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:23 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 13:25:25 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:25 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:26 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 13:25:26 volumio-soyo volumio[1273]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 12 13:25:26 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:26 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Retrieving Cloud Streaming UI Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Getting Tidal Cloud Configuration Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Getting Qobuz Cloud Configuration Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Asking plugin for UI Config Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Getting Spotify Cloud Configuration Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Asking plugin for UI Config Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Saving Spotify Acccount Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Got Tidal Cloud Configuration Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Got it Oct 12 13:25:29 volumio-soyo volumio[1273]: info: Got it Oct 12 13:25:29 volumio-soyo volumio[1273]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 13:25:29 volumio-soyo volumio[1273]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 13:25:29 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 12 13:25:30 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 13:25:30 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:30 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 13:25:30 volumio-soyo volumio-remote-updater[753]: Test mode disabled Oct 12 13:25:30 volumio-soyo volumio-remote-updater[753]: Alpha mode disabled Oct 12 13:25:30 volumio-soyo volumio-remote-updater[753]: Alpha legacy test mode disabled Oct 12 13:25:30 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 12 13:25:31 volumio-soyo volumio[1273]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetBrowseSources Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 13:25:31 volumio-soyo volumio[1273]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 12 13:25:31 volumio-soyo volumio[1273]: info: Completed starting MyVolumio Plugin Oct 12 13:25:31 volumio-soyo volumio[1273]: [Metrics] CommandRouter: 36s 428.86ms Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumiosetStartupVolume Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::Close All Modals sent Oct 12 13:25:31 volumio-soyo volumio[1273]: info: CoreCommandRouter::Close All Modals sent Oct 12 13:25:32 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 12 13:25:32 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 13:25:32 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 12 13:25:32 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 12 13:25:32 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand update Oct 12 13:25:32 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:32 volumio-soyo volumio[1273]: info: Oct 12 13:25:32 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: update Oct 12 13:25:32 volumio-soyo volumio[1273]: info: sendMpdCommand update took 4 milliseconds Oct 12 13:25:32 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:32 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:32 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:32 volumio-soyo volumio[1273]: info: Oct 12 13:25:32 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: update Oct 12 13:25:32 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:32 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:32 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:32 volumio-soyo volumio[1273]: info: Oct 12 13:25:32 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: update Oct 12 13:25:32 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:32 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:32 volumio-soyo volumio[1273]: info: sendMpdCommand status took 4 milliseconds Oct 12 13:25:32 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Command Router : Notfying DB Updatetrue Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 42 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 43 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 43 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 43 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 43 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Command Router : Notfying DB Updatetrue Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::Close All Modals sent Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Command Router : Notfying DB Updatetrue Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::Close All Modals sent Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ------------------------------ 125ms Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ------------------------------ 137ms Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ------------------------------ 137ms Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 13:25:33 volumio-soyo volumio[1273]: info: MPD Database updated - AlbumList cache refreshed Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Oct 12 13:25:33 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: database Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Oct 12 13:25:33 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: update Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: MPD Database updated - AlbumList cache refreshed Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Oct 12 13:25:33 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: database Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Oct 12 13:25:33 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: update Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: MPD Database updated - AlbumList cache refreshed Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Oct 12 13:25:33 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: database Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Oct 12 13:25:33 volumio-soyo volumio[1273]: ---------------------------- MPD announces state update: update Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::getState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand status Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 10 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 9 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 8 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 8 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 8 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: info: sendMpdCommand status took 8 milliseconds Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Command Router : Notfying DB Updatefalse Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::Close All Modals sent Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: Command Router : Notfying DB Updatefalse Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::Close All Modals sent Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:33 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:33 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: ------------------------------ 88ms Oct 12 13:25:34 volumio-soyo volumio[1273]: info: ------------------------------ 90ms Oct 12 13:25:34 volumio-soyo volumio[1273]: info: ------------------------------ 89ms Oct 12 13:25:34 volumio-soyo volumio[1273]: info: ------------------------------ 89ms Oct 12 13:25:34 volumio-soyo volumio[1273]: info: sendMpdCommand status took 92 milliseconds Oct 12 13:25:34 volumio-soyo volumio[1273]: info: sendMpdCommand status took 88 milliseconds Oct 12 13:25:34 volumio-soyo volumio[1273]: info: sendMpdCommand status took 89 milliseconds Oct 12 13:25:34 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: Command Router : Notfying DB Updatefalse Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::Close All Modals sent Oct 12 13:25:34 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:34 volumio-soyo volumio[1273]: verbose: ControllerMpd::parseState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:34 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: ControllerMpd::pushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::servicePushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 12 13:25:34 volumio-soyo volumio[1273]: verbose: CURRENT POSITION 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState stateService stop Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::syncState currentStatus stop Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: No code Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreStateMachine::pushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:25:34 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushState Oct 12 13:25:34 volumio-soyo volumio[1273]: info: ------------------------------ 129ms Oct 12 13:25:34 volumio-soyo volumio[1273]: info: ------------------------------ 129ms Oct 12 13:25:37 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 13:25:38 volumio-soyo volumio[1273]: info: BOOT COMPLETED Oct 12 13:25:41 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 13:25:42 volumio-soyo systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 12 13:25:43 volumio-soyo systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 12 13:25:43 volumio-soyo systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 12 13:25:45 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 13:25:49 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 13:25:53 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 12 13:25:53 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 12 13:25:53 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 13:25:57 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 13:25:58 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioGetState Oct 12 13:25:58 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:26:02 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 13:26:02 volumio-soyo volumio[1273]: info: CURURI: music-library Oct 12 13:26:02 volumio-soyo volumio[1273]: info: Preload queue cleared Oct 12 13:26:03 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 13:26:03 volumio-soyo volumio[1273]: info: CURURI: music-library/USB Oct 12 13:26:03 volumio-soyo volumio[1273]: info: Preload queue cleared Oct 12 13:26:04 volumio-soyo volumio[1273]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 12 13:26:04 volumio-soyo volumio[1273]: info: CURURI: music-library/USB/786048FC6048C31C Oct 12 13:26:04 volumio-soyo volumio[1273]: info: Preload queue cleared Oct 12 13:26:04 volumio-soyo volumio[1273]: info: Preloading song: music-library/USB/786048FC6048C31C/07 - Solitude.dsf Oct 12 13:26:04 volumio-soyo volumio[1273]: info: Preloading song: music-library/USB/786048FC6048C31C/03 - Pink Floyd - Have A Cigar.dsf Oct 12 13:26:04 volumio-soyo volumio[1273]: info: Exploding uri music-library/USB/786048FC6048C31C/07 - Solitude.dsf in service mpd Oct 12 13:26:04 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Black%20sabbath/Master%20of%20reality/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F07%20-%20Solitude.dsf&metadata=false Oct 12 13:26:04 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/07 - Solitude.dsf Oct 12 13:26:04 volumio-soyo volumio[1273]: info: Exploding uri music-library/USB/786048FC6048C31C/03 - Pink Floyd - Have A Cigar.dsf in service mpd Oct 12 13:26:04 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Pink%20Floyd/Wish%20You%20Were%20Here/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F03%20-%20Pink%20Floyd%20-%20Have%20A%20Cigar.dsf&metadata=false Oct 12 13:26:04 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/03 - Pink Floyd - Have A Cigar.dsf Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Preload queue cleared Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::ClearQueue Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::stop Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CorePlayQueue::clearPlayQueue Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CorePlayQueue::saveQueue Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushQueue Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::addQueueItems Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CorePlayQueue::addQueueItems Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Preload queue cleared Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Adding Item to queue: music-library/USB/786048FC6048C31C/07 - Solitude.dsf Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Using cached record of: music-library/USB/786048FC6048C31C/07 - Solitude.dsf Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPushQueue Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CorePlayQueue::saveQueue Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::updateTrackBlock Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrackBlock Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreCommandRouter::volumioPlay Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::play index 0 Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::addQueueItems Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CorePlayQueue::addQueueItems Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Preload queue cleared Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Adding Item to queue: music-library/USB/786048FC6048C31C/03 - Pink Floyd - Have A Cigar.dsf Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Using cached record of: music-library/USB/786048FC6048C31C/03 - Pink Floyd - Have A Cigar.dsf Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Adding Item to queue: music-library/USB/786048FC6048C31C/2010 - 30 Years Live Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Exploding uri music-library/USB/786048FC6048C31C/2010 - 30 Years Live in service mpd Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Adding Item to queue: music-library/USB/786048FC6048C31C/Bad Religion Discography Oct 12 13:26:07 volumio-soyo volumio[1273]: info: Exploding uri music-library/USB/786048FC6048C31C/Bad Religion Discography in service mpd Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::stop Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::play index undefined Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CoreStateMachine::startPlaybackTimer Oct 12 13:26:07 volumio-soyo volumio[1273]: info: CorePlayQueue::getTrack 0 Oct 12 13:26:07 volumio-soyo volumio[1273]: verbose: ControllerMpd::clearAddPlayTracks USB/786048FC6048C31C/07 - Solitude.dsf Oct 12 13:26:07 volumio-soyo volumio[1273]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F01%20Fuck%20Armageddon%2C%20This%20Is%20Hell.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/01 Fuck Armageddon, This Is Hell.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F02%20Dearly%20Beloved.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/02 Dearly Beloved.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F03%20Suffer.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/03 Suffer.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F04%20Man%20With%20A%20Mission.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/04 Man With A Mission.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F05%20New%20Dark%20Ages.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/05 New Dark Ages.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F06%20Germs%20Of%20Perfection.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/06 Germs Of Perfection.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F07%20Marked.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/07 Marked.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F08%20A%20Walk.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/08 A Walk.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F09%20Flat%20Earth%20Society.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/09 Flat Earth Society.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F10%20Resist%20Stance.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/10 Resist Stance.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F11%20American%20Jesus.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/11 American Jesus.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F12%20Social%20Suicide.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/12 Social Suicide.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F13%20Atheist%20Peace.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/13 Atheist Peace.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F14%20Tomorrow.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/14 Tomorrow.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F15%20Won't%20Somebody.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/15 Won't Somebody.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F16%20Los%20Angeles%20Is%20Burning.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/16 Los Angeles Is Burning.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/30%20Years%20Live/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2F2010%20-%2030%20Years%20Live%2F17%20We're%20Only%20Gonna%20Die.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/2010 - 30 Years Live/17 We're Only Gonna Die.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Bad%20Religion%20EP/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Bad%20Religion%20EP%2F01%20-%20Bad%20Religion%20Vol.1.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Bad Religion EP/01 - Bad Religion Vol.1.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Bad%20Religion%20EP/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Bad%20Religion%20EP%2F02%20-%20Politics.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Bad Religion EP/02 - Politics.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Bad%20Religion%20EP/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Bad%20Religion%20EP%2F03%20-%20Sensory%20Overload.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Bad Religion EP/03 - Sensory Overload.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Bad%20Religion%20EP/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Bad%20Religion%20EP%2F04%20-%20Slaves.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Bad Religion EP/04 - Slaves.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Bad%20Religion%20EP/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Bad%20Religion%20EP%2F05%20-%20Drastic%20Actions.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Bad Religion EP/05 - Drastic Actions.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Bad%20Religion%20EP/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Bad%20Religion%20EP%2F06%20-%20World%20War%20III.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Bad Religion EP/06 - World War III.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F01%20-%20We're%20Only%20Gonna%20Die.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/01 - We're Only Gonna Die.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F02%20-%20Latch%20Key%20Kids.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/02 - Latch Key Kids.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F03%20-%20Part%20III.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/03 - Part III.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F04%20-%20Faith%20In%20God.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/04 - Faith In God.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F05%20-%20Fuck%20Armageddon...%20This%20Is%20Hell.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/05 - Fuck Armageddon... This Is Hell.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F06%20-%20Pity.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/06 - Pity.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F07%20-%20In%20The%20Night.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/07 - In The Night.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F08%20-%20Damned%20To%20Be%20Free.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/08 - Damned To Be Free.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F09%20-%20White%20Trash%20(Second%20Generation).flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/09 - White Trash (Second Generation).flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F10%20-%20American%20Dream.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/10 - American Dream.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F11%20-%20Eat%20Your%20Dog.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/11 - Eat Your Dog.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F12%20-%20Voice%20Of%20God%20Is%20Government.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/12 - Voice Of God Is Government.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F13%20-%20Oligarchy.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/13 - Oligarchy.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/How%20Could%20Hell%20Be%20Any%20Worse%3F/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20How%20Could%20Hell%20Be%20Any%20Worse%20(Remaster)%2F14%20-%20Doing%20Time.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - How Could Hell Be Any Worse (Remaster)/14 - Doing Time.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Public%20Service%20Split/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Public%20Service%2F01%20-%20Bad%20Religion.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Public Service/01 - Bad Religion.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Public%20Service%20Split/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Public%20Service%2F02%20-%20Slaves.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Public Service/02 - Slaves.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Public%20Service%20Split/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1981%20-%20Public%20Service%2F03%20-%20Drastic%20Actions.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1981 - Public Service/03 - Drastic Actions.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Into%20The%20Unknown/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1983%20-%20Into%20The%20Unknown%20(1983)(US)%5BLP%5D%5B24-96%5D%5BFLAC%5D%2F01%20-%20It's%20Only%20Over%20When....flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1983 - Into The Unknown (1983)(US)[LP][24-96][FLAC]/01 - It's Only Over When....flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Into%20The%20Unknown/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1983%20-%20Into%20The%20Unknown%20(1983)(US)%5BLP%5D%5B24-96%5D%5BFLAC%5D%2F02%20-%20Chasing%20The%20Wild%20Goose.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1983 - Into The Unknown (1983)(US)[LP][24-96][FLAC]/02 - Chasing The Wild Goose.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Into%20The%20Unknown/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1983%20-%20Into%20The%20Unknown%20(1983)(US)%5BLP%5D%5B24-96%5D%5BFLAC%5D%2F03%20-%20Billy%20Gnosis.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1983 - Into The Unknown (1983)(US)[LP][24-96][FLAC]/03 - Billy Gnosis.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Into%20The%20Unknown/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1983%20-%20Into%20The%20Unknown%20(1983)(US)%5BLP%5D%5B24-96%5D%5BFLAC%5D%2F04%20-%20Time%20And%20Disregard.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1983 - Into The Unknown (1983)(US)[LP][24-96][FLAC]/04 - Time And Disregard.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Into%20The%20Unknown/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1983%20-%20Into%20The%20Unknown%20(1983)(US)%5BLP%5D%5B24-96%5D%5BFLAC%5D%2F05%20-%20The%20Dichotomy.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1983 - Into The Unknown (1983)(US)[LP][24-96][FLAC]/05 - The Dichotomy.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Into%20The%20Unknown/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1983%20-%20Into%20The%20Unknown%20(1983)(US)%5BLP%5D%5B24-96%5D%5BFLAC%5D%2F06%20-%20Million%20Days.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1983 - Into The Unknown (1983)(US)[LP][24-96][FLAC]/06 - Million Days.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Into%20The%20Unknown/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1983%20-%20Into%20The%20Unknown%20(1983)(US)%5BLP%5D%5B24-96%5D%5BFLAC%5D%2F07%20-%20Losing%20Generation.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1983 - Into The Unknown (1983)(US)[LP][24-96][FLAC]/07 - Losing Generation.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Into%20The%20Unknown/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1983%20-%20Into%20The%20Unknown%20(1983)(US)%5BLP%5D%5B24-96%5D%5BFLAC%5D%2F08%20-%20You%20Give%20Up.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1983 - Into The Unknown (1983)(US)[LP][24-96][FLAC]/08 - You Give Up.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Back%20to%20the%20Known/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1985%20-%20Back%20to%20the%20Know%20EP%2F01%20-%20Yesterday.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1985 - Back to the Know EP/01 - Yesterday.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Back%20to%20the%20Known/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1985%20-%20Back%20to%20the%20Know%20EP%2F02%20-%20Frogger.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1985 - Back to the Know EP/02 - Frogger.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Back%20to%20the%20Known/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1985%20-%20Back%20to%20the%20Know%20EP%2F03%20-%20Bad%20Religion.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1985 - Back to the Know EP/03 - Bad Religion.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Back%20to%20the%20Known/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1985%20-%20Back%20to%20the%20Know%20EP%2F04%20-%20Along%20The%20Way.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1985 - Back to the Know EP/04 - Along The Way.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Back%20to%20the%20Known/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1985%20-%20Back%20to%20the%20Know%20EP%2F05%20-%20New%20Leaf.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1985 - Back to the Know EP/05 - New Leaf.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F01%20-%20You%20Are%20(The%20Government).flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/01 - You Are (The Government).flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F02%20-%201000%20More%20Fools.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/02 - 1000 More Fools.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F03%20-%20How%20Much%20Is%20Enough.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/03 - How Much Is Enough.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F04%20-%20When.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/04 - When.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F05%20-%20Give%20You%20Nothing.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/05 - Give You Nothing.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F06%20-%20Land%20Of%20Competition.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/06 - Land Of Competition.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F07%20-%20Forbidden%20Beat.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/07 - Forbidden Beat.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F08%20-%20Best%20For%20You.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/08 - Best For You.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F09%20-%20Suffer.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/09 - Suffer.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F10%20-%20Delirium%20Of%20Disorder.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/10 - Delirium Of Disorder.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F11%20-%20Part%20II%20(The%20Numbers%20Game).flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/11 - Part II (The Numbers Game).flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F12%20-%20What%20Can%20You%20Do.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/12 - What Can You Do.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F13%20-%20Do%20What%20You%20Want.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/13 - Do What You Want.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F14%20-%20Part%20IV%20(The%20Index%20Fossil).flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/14 - Part IV (The Index Fossil).flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2F15%20-%20Pessimistic%20Lines.flac&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/15 - Pessimistic Lines.flac Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2FBad%20Religion%20-%20Suffer.cue&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/Bad Religion - Suffer.cue Oct 12 13:26:07 volumio-soyo volumio[1273]: info: ALBUMART /albumart?cacheid=411&web=Bad%20Religion/Suffer/extralarge&path=%2Fmnt%2FUSB%2F786048FC6048C31C%2FBad%20Religion%20Discography%2F1988%20-%20Suffer%2FBad%20Religion%20-%20Suffer.cue&metadata=false Oct 12 13:26:07 volumio-soyo volumio[1273]: info: URI /mnt/USB/786048FC6048C31C/Bad Religion Discography/1988 - Suffer/Bad Religion - Suffer.cue Oct 12 13:26:07 volumio-soyo volumio[1273]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 13:26:07 volumio-soyo volumio[1273]: Error: Unable to resolve or reject the same promise twice Oct 12 13:26:07 volumio-soyo volumio[1273]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 12 13:26:07 volumio-soyo volumio[1273]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 12 13:26:07 volumio-soyo volumio[1273]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 12 13:26:07 volumio-soyo volumio[1273]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 12 13:26:07 volumio-soyo volumio[1273]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 12 13:26:07 volumio-soyo volumio[1273]: at Socket.emit (node:events:514:28) Oct 12 13:26:07 volumio-soyo volumio[1273]: at addChunk (node:internal/streams/readable:343:12) Oct 12 13:26:07 volumio-soyo volumio[1273]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 12 13:26:07 volumio-soyo volumio[1273]: at Readable.push (node:internal/streams/readable:253:10) Oct 12 13:26:07 volumio-soyo volumio[1273]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 12 13:26:07 volumio-soyo volumio[1273]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 13:26:07 volumio-soyo sudo[2149]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 13:25' Oct 12 13:26:07 volumio-soyo sudo[2149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"