-- Logs begin at Fri 2025-06-27 19:21:35 CST, end at Fri 2025-06-27 19:23:59 CST. -- Jun 27 19:22:00 volumio ntpd[1136]: receive: Unexpected origin timestamp 0xec08fd56.ede046d0 does not match aorg 0000000000.00000000 from server@95.111.202.5 xmt 0xec08fd58.14d786a0 Jun 27 19:22:00 volumio volumio[1073]: info: Applying required configuration parameters for plugin autostart Jun 27 19:22:00 volumio volumio[1073]: info: AutoStart - onVolumioStart - read config.json Jun 27 19:22:00 volumio volumio[1073]: info: Loading plugin "peppy_screensaver"... Jun 27 19:22:01 volumio volumio[1073]: info: Applying required configuration parameters for plugin peppy_screensaver Jun 27 19:22:01 volumio volumio[1073]: info: Loading plugin "outputs"... Jun 27 19:22:01 volumio volumio[1073]: info: Loading plugin "albumart"... Jun 27 19:22:01 volumio volumio[1073]: info: Plugin example_plugin is not enabled Jun 27 19:22:01 volumio volumio[1073]: info: Loading plugin "inputs"... Jun 27 19:22:01 volumio volumio[1073]: info: Loading plugin "updater_comm"... Jun 27 19:22:01 volumio volumio[1073]: Forking 1 albumart workers Jun 27 19:22:01 volumio volumio[1073]: info: Plugin mpdemulation is not enabled Jun 27 19:22:01 volumio volumio[1073]: info: Loading plugin "rest_api"... Jun 27 19:22:01 volumio volumio[1073]: info: Loading plugin "websocket"... Jun 27 19:22:01 volumio dbus-daemon[674]: [system] Successfully activated service 'org.freedesktop.hostname1' Jun 27 19:22:01 volumio systemd[1]: Started Hostname Service. Jun 27 19:22:01 volumio volumio[1073]: info: Starting Socket.io Server version 2.3.0 Jun 27 19:22:01 volumio volumio[1073]: info: Loading plugin "RoonBridge"... Jun 27 19:22:01 volumio volumio[1073]: info: Applying required configuration parameters for plugin RoonBridge Jun 27 19:22:01 volumio volumio[1073]: info: Loading plugin "minidlna"... Jun 27 19:22:01 volumio volumio[1073]: info: Applying required configuration parameters for plugin minidlna Jun 27 19:22:01 volumio volumio[1073]: Starting albumart workers Jun 27 19:22:01 volumio volumio[1073]: info: Loading i18n strings for locale zh Jun 27 19:22:02 volumio volumio-remote-updater[702]: [2025-06-27 19:22:02] [connect] Successful connection Jun 27 19:22:02 volumio volumio[1073]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Jun 27 19:22:02 volumio volumio[1073]: Updating browse sources language Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::initPlayerControls Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: Express server listening on port 3000 Jun 27 19:22:02 volumio volumio[1073]: [Metrics] WebUI: 9s 72.02ms Jun 27 19:22:02 volumio volumio[1073]: info: Setting Device type: x86 Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::resetVolumioState Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::getcurrentVolume Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 27 19:22:02 volumio volumio[1073]: info: Completed loading Core Plugins Jun 27 19:22:02 volumio volumio[1073]: info: Preparing to generate the ALSA configuration file Jun 27 19:22:02 volumio volumio[1073]: info: Volumio Network Manager: Network status updated: 2 Jun 27 19:22:02 volumio volumio[1073]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 27 19:22:02 volumio volumio[1073]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Jun 27 19:22:02 volumio volumio[1073]: info: Reading ALSA contributions from plugins. Jun 27 19:22:02 volumio volumio-remote-updater[702]: [2025-06-27 19:22:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751023321 101 Jun 27 19:22:02 volumio volumio[1073]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:02 volumio volumio[1073]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 27 19:22:02 volumio volumio[1073]: info: Reloading queue from file Jun 27 19:22:02 volumio volumio[1073]: info: VolumeController:: Volume=39 Mute =false Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Jun 27 19:22:02 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::setRepeat null single undefined Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::setRandom null Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:02 volumio volumio[1073]: info: VolumeController:: Volume=39 Mute =false Jun 27 19:22:02 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:02 volumio volumio[1073]: info: Asound.conf file unchanged, so no further update is needed Jun 27 19:22:02 volumio volumio[1073]: info: Output device has changed, restarting MPD Jun 27 19:22:02 volumio volumio[1073]: info: Output device has changed, restarting Shairport Sync Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:02 volumio sudo[1527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 27 19:22:02 volumio sudo[1527]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:02 volumio sudo[1527]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:02 volumio sudo[1529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 27 19:22:02 volumio sudo[1529]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:02 volumio systemd[1]: Stopping Music Player Daemon... Jun 27 19:22:02 volumio systemd[1]: mpd.service: Succeeded. Jun 27 19:22:02 volumio systemd[1]: Stopped Music Player Daemon. Jun 27 19:22:02 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 27 19:22:02 volumio volumio[1073]: info: ___________ START PLUGINS ___________ Jun 27 19:22:02 volumio systemd[1]: Starting Music Player Daemon... Jun 27 19:22:03 volumio volumio[1073]: info: ControllerMpd::onStart: Initializing MPD Jun 27 19:22:03 volumio volumio[1073]: info: Creating MPD Configuration file Jun 27 19:22:03 volumio sudo[1537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 27 19:22:03 volumio sudo[1537]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:03 volumio sudo[1537]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 19:22:03 volumio volumio[1073]: info: [1751023323105] CoreMusicLibrary::Adding element 媒体服务器 Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 19:22:03 volumio sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 27 19:22:03 volumio sudo[1535]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 27 19:22:03 volumio sudo[1535]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:03 volumio sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:03 volumio sudo[1535]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:03 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 27 19:22:03 volumio systemd[1]: mpd.service: Succeeded. Jun 27 19:22:03 volumio systemd[1]: Stopped Music Player Daemon. Jun 27 19:22:03 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:03 volumio systemd[1]: Starting Music Player Daemon... Jun 27 19:22:03 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 19:22:03 volumio volumio[1073]: info: [1751023323252] CoreMusicLibrary::Adding element Last_100 Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 27 19:22:03 volumio volumio[1073]: info: [1751023323255] CoreMusicLibrary::Adding element Webradio Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 27 19:22:03 volumio volumio[1073]: info: Initializing BBC Radios Jun 27 19:22:03 volumio sudo[1547]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 27 19:22:03 volumio sudo[1547]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:03 volumio sudo[1547]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: AutoStart - onStart Jun 27 19:22:03 volumio volumio[1073]: info: Loading i18n strings for locale zh Jun 27 19:22:03 volumio volumio[1073]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Jun 27 19:22:03 volumio volumio[1073]: info: /tmp/myfifo created Jun 27 19:22:03 volumio volumio[1073]: info: /tmp/myfifosa created Jun 27 19:22:03 volumio sudo[1568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Jun 27 19:22:03 volumio sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:03 volumio sudo[1568]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:03 volumio volumio[1073]: info: snd-dummy loaded Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:03 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 27 19:22:03 volumio volumio[1073]: info: Loading i18n strings for locale zh Jun 27 19:22:03 volumio volumio[1073]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Jun 27 19:22:03 volumio sudo[1588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jun 27 19:22:04 volumio sudo[1588]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:04 volumio volumio[1073]: info: Volumio Calling Home Jun 27 19:22:04 volumio systemd[1]: Started RoonBridge. Jun 27 19:22:04 volumio sudo[1588]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:04 volumio sudo[1341]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:04 volumio mpd[1559]: Jun 27 19:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 27 19:22:04 volumio volumio[1073]: info: Discovery: adding 6576be8c-9ca3-4f6e-ad09-3e064e726785 Jun 27 19:22:04 volumio volumio[1073]: info: Discovery: Found device Volumio Jun 27 19:22:04 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:04 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:04 volumio systemd[1]: Started Music Player Daemon. Jun 27 19:22:04 volumio sudo[1529]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:04 volumio sudo[1540]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:05 volumio volumio[1073]: info: minidlna: Found miniDLNA version 1.2.1 Jun 27 19:22:05 volumio volumio[1073]: info: minidlna: Starting minidlna.service Jun 27 19:22:05 volumio volumio[1073]: info: MPD Permissions set Jun 27 19:22:05 volumio volumio[1073]: info: MPD Permissions set Jun 27 19:22:05 volumio sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Jun 27 19:22:05 volumio sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:05 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Jun 27 19:22:05 volumio sudo[1608]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:05 volumio volumio[1073]: info: Volumio called home Jun 27 19:22:05 volumio sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Jun 27 19:22:05 volumio sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:05 volumio RoonBridge[1592]: 00:00:00.020 Warn: get lock file path: /tmp/.rnbgem0- Jun 27 19:22:05 volumio sudo[1617]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:05 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:05 volumio volumio[1073]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 27 19:22:05 volumio volumio[1073]: info: MPD running with PID1559 Jun 27 19:22:05 volumio volumio[1073]: ,establishing connection Jun 27 19:22:05 volumio volumio[1073]: info: minidlna: systemctl start minidlna.service succeeded. Jun 27 19:22:05 volumio volumio[1073]: info: Completed starting Core Plugins Jun 27 19:22:05 volumio volumio[1073]: info: ------------------------------------------- Jun 27 19:22:05 volumio volumio[1073]: info: ----- MyVolumio plugins startup ---- Jun 27 19:22:05 volumio volumio[1073]: info: ------------------------------------------- Jun 27 19:22:05 volumio volumio[1073]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 27 19:22:05 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:00.788 Trace: [childprocess] using unix child process Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:00.924 Debug: PathForResource, filename: ../.update Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:00.970 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Jun 27 19:22:06 volumio RoonBridge[1592]: Initializing Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:00.981 Debug: PathForResource, filename: RAATServer Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:00.983 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:00.983 Debug: PathForResource, filename: RoonBridgeHelper Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:00.983 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:01.137 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jun 27 19:22:06 volumio volumio[1073]: error: MPD error: The expression evaluated to a falsy value: Jun 27 19:22:06 volumio volumio[1073]: assert.ok(self.idling) Jun 27 19:22:06 volumio volumio[1073]: error: The expression evaluated to a falsy value: Jun 27 19:22:06 volumio volumio[1073]: assert.ok(self.idling) Jun 27 19:22:06 volumio volumio[1073]: error: MPD error: The expression evaluated to a falsy value: Jun 27 19:22:06 volumio volumio[1073]: assert.ok(self.idling) Jun 27 19:22:06 volumio volumio[1073]: error: The expression evaluated to a falsy value: Jun 27 19:22:06 volumio volumio[1073]: assert.ok(self.idling) Jun 27 19:22:06 volumio RoonBridge[1592]: 00:00:01.246 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jun 27 19:22:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Jun 27 19:22:06 volumio sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 27 19:22:06 volumio sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:06 volumio sudo[1704]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:06 volumio RoonBridge[1592]: Not Running (.o) Jun 27 19:22:06 volumio volumio[1073]: error: updateQueue error: null Jun 27 19:22:06 volumio volumio[1073]: info: MPD Permissions set Jun 27 19:22:06 volumio volumio[1073]: info: Starting Shairport Sync Jun 27 19:22:07 volumio volumio[1073]: info: Starting Shairport Sync Jun 27 19:22:07 volumio sudo[1729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 27 19:22:07 volumio sudo[1729]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 27 19:22:07 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 27 19:22:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:07 volumio volumio[1073]: info: Starting Shairport Sync Jun 27 19:22:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:07 volumio sudo[1729]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:07 volumio sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 27 19:22:07 volumio volumio[1073]: info: Starting Shairport Sync Jun 27 19:22:07 volumio sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 27 19:22:07 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 27 19:22:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:07 volumio sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 27 19:22:07 volumio sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:07 volumio sudo[1734]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:07 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:07 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Jun 27 19:22:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 27 19:22:07 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 27 19:22:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:07 volumio sudo[1767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 27 19:22:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:07 volumio sudo[1754]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:07 volumio sudo[1767]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 27 19:22:07 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 27 19:22:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:07 volumio sudo[1767]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:07 volumio sudo[1783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 27 19:22:07 volumio sudo[1783]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:07 volumio volumio[1073]: info: Shairport-Sync Started Jun 27 19:22:07 volumio volumio[1073]: Error adding Membership: Error: addMembership EINVAL Jun 27 19:22:07 volumio volumio[1073]: info: Shairport-Sync Started Jun 27 19:22:07 volumio systemd[1]: Stopping Music Player Daemon... Jun 27 19:22:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:07 volumio systemd[1]: mpd.service: Succeeded. Jun 27 19:22:07 volumio systemd[1]: Stopped Music Player Daemon. Jun 27 19:22:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:07 volumio systemd[1]: Starting Music Player Daemon... Jun 27 19:22:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 27 19:22:07 volumio RoonBridge[1592]: Running Jun 27 19:22:07 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:07 volumio sudo[1805]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 27 19:22:07 volumio sudo[1805]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:08 volumio sudo[1805]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:08 volumio volumio[1073]: info: Shairport-Sync Started Jun 27 19:22:08 volumio volumio[1073]: info: Shairport-Sync Started Jun 27 19:22:08 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jun 27 19:22:08 volumio sudo[1887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 27 19:22:08 volumio sudo[1887]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:08 volumio sudo[1887]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:08 volumio sudo[1891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 27 19:22:08 volumio sudo[1891]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:08 volumio sudo[1891]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:08 volumio sudo[1894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 27 19:22:08 volumio sudo[1894]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:08 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 27 19:22:08 volumio sudo[1894]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:08 volumio volumio[1073]: info: Upmpdcli Daemon Started Jun 27 19:22:09 volumio sh[620]: timed out Jun 27 19:22:09 volumio dhcpcd[663]: timed out Jun 27 19:22:09 volumio sh[620]: dhcpcd exited Jun 27 19:22:09 volumio dhcpcd[663]: dhcpcd exited Jun 27 19:22:09 volumio sh[620]: ifup: failed to bring up eth0 Jun 27 19:22:09 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jun 27 19:22:09 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jun 27 19:22:09 volumio RoonBridge[1592]: 00:00:00.080 Warn: get lock file path: /tmp/.rnbhgem0- Jun 27 19:22:09 volumio mpd[1842]: Jun 27 19:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 27 19:22:10 volumio systemd[1]: Started Music Player Daemon. Jun 27 19:22:10 volumio sudo[1783]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:10 volumio volumio[1073]: error: updateQueue error: null Jun 27 19:22:10 volumio volumio[1896]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 27 19:22:10 volumio volumio[1073]: 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/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 27 19:22:12 volumio volumio[1896]: .................................................++++ Jun 27 19:22:13 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:13 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 27 19:22:14 volumio volumio[1073]: info: Adding plugin bluetooth to MyMusic Plugins Jun 27 19:22:14 volumio volumio[1073]: info: Adding plugin multiroom to MyMusic Plugins Jun 27 19:22:14 volumio volumio[1073]: info: Adding plugin metavolumio to MyMusic Plugins Jun 27 19:22:14 volumio volumio[1073]: info: Adding plugin cd_controller to MyMusic Plugins Jun 27 19:22:14 volumio volumio[1073]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 27 19:22:14 volumio volumio[1073]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 27 19:22:14 volumio volumio[1073]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 27 19:22:15 volumio volumio[1073]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 27 19:22:15 volumio volumio[1073]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 27 19:22:15 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:15 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:15 volumio volumio[1073]: info: Starting MyVolumio Remote Streaming Endpoints Jun 27 19:22:15 volumio volumio[1073]: info: MyVolumio login type: Token Jun 27 19:22:16 volumio volumio[1073]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 27 19:22:16 volumio volumio[1073]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 27 19:22:18 volumio volumio[1073]: info: Starting Streaming Service Transparent Proxy Jun 27 19:22:18 volumio volumio[1073]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 27 19:22:18 volumio volumio[1073]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 27 19:22:18 volumio volumio[1073]: info: Streaming services startup Jun 27 19:22:18 volumio volumio[1073]: info: Starting Streaming Daemon Jun 27 19:22:18 volumio volumio[1896]: ................................................................................................++++ Jun 27 19:22:18 volumio volumio[1896]: e is 65537 (0x010001) Jun 27 19:22:18 volumio sudo[1953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 27 19:22:18 volumio sudo[1953]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:18 volumio volumio[1896]: writing RSA key Jun 27 19:22:18 volumio sudo[1953]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:18 volumio volumio[1073]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 27 19:22:18 volumio volumio[1073]: error: Cannot start Volumio Streaming Daemon Jun 27 19:22:18 volumio volumio[1073]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 27 19:22:18 volumio volumio[1073]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 27 19:22:18 volumio volumio[1073]: 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/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 27 19:22:19 volumio volumio[1073]: STREAMING PROXY: Starting server on port 3245 Jun 27 19:22:19 volumio volumio[1073]: Node JS runtime: 14 Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:19 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 19:22:19 volumio volumio[1073]: info: Received Get System Info Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 19:22:19 volumio volumio[1073]: info: Discovery: Getting this device information Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:19 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 19:22:19 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:19 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:19 volumio volumio[1073]: info: Listing playlists Jun 27 19:22:20 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 27 19:22:20 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 19:22:20 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 27 19:22:20 volumio volumio[1073]: info: Received Get System Info Jun 27 19:22:20 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 19:22:20 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 19:22:20 volumio volumio[1073]: info: Discovery: Getting this device information Jun 27 19:22:20 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:20 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:20 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 19:22:21 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 27 19:22:23 volumio volumio[1073]: info: AutoStart - Plugin is starting Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:23 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:23 volumio volumio[1073]: info: AutoStart - start playing Jun 27 19:22:23 volumio volumio[1073]: info: AutoStart - start playing with no specific position Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPlay Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::play index 0 Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::stop Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::play index undefined Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:22:23 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::startPlaybackTimer Jun 27 19:22:23 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:23 volumio volumio[1073]: info: [1751023343408] ControllerUPNPBrowser::clearAddPlayTrack Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 19:22:23 volumio volumio[1073]: info: sendMpdCommand stop took 2 milliseconds Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand clear Jun 27 19:22:23 volumio volumio[1073]: info: Jun 27 19:22:23 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Jun 27 19:22:23 volumio volumio[1073]: info: Ignoring MPD Status Update Jun 27 19:22:23 volumio volumio[1073]: info: sendMpdCommand clear took 6 milliseconds Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.132:8200/MediaItems/1550.mp3" Jun 27 19:22:23 volumio volumio[1073]: error: updateQueue error: null Jun 27 19:22:23 volumio volumio[1073]: info: ------------------------------ 12ms Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.132:8200/MediaItems/1550.mp3" Jun 27 19:22:23 volumio volumio[1073]: info: Jun 27 19:22:23 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Jun 27 19:22:23 volumio volumio[1073]: info: Ignoring MPD Status Update Jun 27 19:22:23 volumio volumio[1073]: info: sendMpdCommand add "http://192.168.0.132:8200/MediaItems/1550.mp3" took 8 milliseconds Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand play Jun 27 19:22:23 volumio volumio[1073]: info: ------------------------------ 10ms Jun 27 19:22:23 volumio volumio[1073]: info: sendMpdCommand play took 3 milliseconds Jun 27 19:22:23 volumio volumio[1073]: info: Jun 27 19:22:23 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:22:23 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:22:23 volumio volumio[1073]: info: Jun 27 19:22:23 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Jun 27 19:22:23 volumio volumio[1073]: info: Ignoring MPD Status Update Jun 27 19:22:23 volumio volumio[1073]: info: Jun 27 19:22:23 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:22:23 volumio volumio[1073]: info: sendMpdCommand status took 63 milliseconds Jun 27 19:22:23 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:22:23 volumio volumio[1073]: info: ------------------------------ 18ms Jun 27 19:22:23 volumio volumio[1073]: info: sendMpdCommand status took 13 milliseconds Jun 27 19:22:23 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 12 milliseconds Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:22:23 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:22:23 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:23 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":390,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"挪威的森林","artist":"伍佰/China Blue","album":"经典老歌","uri":"http://192.168.0.132:8200/MediaItems/1550.mp3","trackType":"mp3"} Jun 27 19:22:23 volumio volumio[1073]: verbose: CURRENT POSITION 0 Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Jun 27 19:22:23 volumio volumio[1073]: info: ------------------------------ 94ms Jun 27 19:22:23 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 9 milliseconds Jun 27 19:22:23 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:22:23 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:22:23 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:23 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":216,"duration":390,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"挪威的森林","artist":"伍佰/China Blue","album":"经典老歌","uri":"http://192.168.0.132:8200/MediaItems/1550.mp3","trackType":"mp3"} Jun 27 19:22:23 volumio volumio[1073]: verbose: CURRENT POSITION 0 Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 27 19:22:23 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:23 volumio volumio[1073]: info: ------------------------------ 74ms Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:23 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:23 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:23 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:23 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:24 volumio volumio[1073]: info: Jun 27 19:22:24 volumio volumio[1073]: ---------------------------- USB Audio Device Detached Jun 27 19:22:24 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jun 27 19:22:24 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:22:24 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jun 27 19:22:24 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:24 volumio sudo[2012]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Jun 27 19:22:24 volumio kernel: usb 1-1.4.2: reset full-speed USB device number 6 using ehci-pci Jun 27 19:22:24 volumio sudo[2012]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:25 volumio systemd[1]: systemd-timedated.service: Succeeded. Jun 27 19:22:25 volumio volumio[1073]: info: Jun 27 19:22:25 volumio volumio[1073]: ---------------------------- USB Audio Device Attached Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::Close All Modals sent Jun 27 19:22:25 volumio volumio[1073]: info: Preparing to save Alsa Options, stopping services first Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::volumioPause Jun 27 19:22:25 volumio volumio[1073]: info: CoreStateMachine::pause Jun 27 19:22:25 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Jun 27 19:22:25 volumio volumio[1073]: info: CoreStateMachine::servicePause Jun 27 19:22:25 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::servicePause Jun 27 19:22:25 volumio volumio[1073]: info: [1751023345450] ControllerUPNPBrowser::pause Jun 27 19:22:25 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand pause Jun 27 19:22:25 volumio volumio[1073]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"Bravo-X USB Audio","alsacard":"Audio"},"i2s":false} Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:22:25 volumio volumio[1073]: info: Setting mixer PCM for card Bravo-X USB Audio Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 27 19:22:25 volumio volumio[1073]: info: Updating Volume Controller Parameters: Device: 5 Name: Bravo-X USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 27 19:22:25 volumio volumio[1073]: info: Disabling external Volume Control Jun 27 19:22:25 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 19:22:26 volumio volumio[1073]: info: Preparing to generate the ALSA configuration file Jun 27 19:22:26 volumio volumio[1073]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Jun 27 19:22:26 volumio volumio[1073]: info: Reading ALSA contributions from plugins. Jun 27 19:22:26 volumio volumio[1073]: info: Jun 27 19:22:26 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:22:26 volumio volumio[1073]: info: sendMpdCommand pause took 677 milliseconds Jun 27 19:22:26 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:22:26 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:22:26 volumio volumio[1073]: info: sendMpdCommand status took 51 milliseconds Jun 27 19:22:26 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:22:26 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:22:26 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 21 milliseconds Jun 27 19:22:26 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:22:26 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:22:26 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:26 volumio volumio[1073]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":3141,"duration":390,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"挪威的森林","artist":"伍佰/China Blue","album":"经典老歌","uri":"http://192.168.0.132:8200/MediaItems/1550.mp3","trackType":"mp3"} Jun 27 19:22:26 volumio volumio[1073]: verbose: CURRENT POSITION 0 Jun 27 19:22:26 volumio volumio[1073]: info: CoreStateMachine::syncState stateService pause Jun 27 19:22:26 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus pause Jun 27 19:22:26 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:26 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Jun 27 19:22:26 volumio volumio[1073]: info: ------------------------------ 100ms Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:26 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:26 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:26 volumio volumio[1073]: info: VolumeController:: Volume=39 Mute =false Jun 27 19:22:26 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:26 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:26 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:26 volumio volumio[1073]: info: Asound.conf file unchanged, so no further update is needed Jun 27 19:22:26 volumio volumio[1073]: info: Output device has changed, restarting MPD Jun 27 19:22:26 volumio sudo[2041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 27 19:22:26 volumio sudo[2041]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:26 volumio volumio[1073]: info: Output device has changed, restarting Shairport Sync Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:26 volumio sudo[2041]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:26 volumio sudo[2044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 27 19:22:26 volumio sudo[2044]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:26 volumio systemd[1]: Stopping Music Player Daemon... Jun 27 19:22:26 volumio systemd[1]: mpd.service: Succeeded. Jun 27 19:22:26 volumio volumio[1073]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 27 19:22:26 volumio systemd[1]: Stopped Music Player Daemon. Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jun 27 19:22:26 volumio volumio[1073]: info: MPD Permissions set Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:26 volumio systemd[1]: Starting Music Player Daemon... Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 27 19:22:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:26 volumio volumio[1073]: info: Starting Shairport Sync Jun 27 19:22:26 volumio sudo[2049]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 27 19:22:26 volumio sudo[2049]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:26 volumio sudo[2049]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:26 volumio sudo[2058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 27 19:22:26 volumio sudo[2058]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 27 19:22:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 27 19:22:26 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 27 19:22:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 27 19:22:26 volumio sudo[2058]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:26 volumio volumio[1073]: info: Shairport-Sync Started Jun 27 19:22:27 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:27 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:27 volumio mpd[2059]: Jun 27 19:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 27 19:22:27 volumio systemd[1]: Started Music Player Daemon. Jun 27 19:22:27 volumio sudo[2044]: pam_unix(sudo:session): session closed for user root Jun 27 19:22:27 volumio volumio[1073]: error: updateQueue error: null Jun 27 19:22:28 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 27 19:22:28 volumio volumio[1073]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Jun 27 19:22:28 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:29 volumio volumio[1073]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Jun 27 19:22:29 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:29 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 27 19:22:29 volumio volumio[1073]: info: CoreStateMachine::getcurrentVolume Jun 27 19:22:29 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Jun 27 19:22:30 volumio volumio[1073]: info: VolumeController:: Volume=39 Mute =false Jun 27 19:22:30 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:30 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:30 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Jun 27 19:22:30 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Jun 27 19:22:30 volumio volumio[1073]: info: CoreCommandRouter::volumioRetrievevolume Jun 27 19:22:30 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:30 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:30 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:30 volumio volumio[1073]: info: VolumeController:: Volume=39 Mute =false Jun 27 19:22:30 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:30 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:30 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:30 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:30 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:30 volumio volumio[1073]: error: Upnp client error: Error: This socket has been ended by the other party Jun 27 19:22:30 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 27 19:22:30 volumio volumio[1073]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 27 19:22:30 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:31 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jun 27 19:22:33 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 27 19:22:33 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:33 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 27 19:22:35 volumio volumio[1073]: verbose: New Socket.io Connection to 192.168.0.128 from 192.168.0.152 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 9 Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetVisibleSources Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 27 19:22:35 volumio volumio[1073]: info: Received Get System Info Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 19:22:35 volumio volumio[1073]: info: Discovery: Getting this device information Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:35 volumio volumio[1073]: info: Listing playlists Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:35 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:35 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::volumioGetBrowseSources Jun 27 19:22:35 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 27 19:22:36 volumio volumio[1073]: verbose: New Socket.io Connection to 192.168.0.128 from 192.168.0.152 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 10 Jun 27 19:22:36 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 27 19:22:36 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 27 19:22:37 volumio volumio[1073]: info: CoreCommandRouter::volumioPlay Jun 27 19:22:37 volumio volumio[1073]: info: CoreStateMachine::play index undefined Jun 27 19:22:37 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:22:37 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:37 volumio volumio[1073]: info: CoreStateMachine::startPlaybackTimer Jun 27 19:22:37 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:37 volumio volumio[1073]: info: [1751023357151] ControllerUPNPBrowser::resume Jun 27 19:22:37 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand play Jun 27 19:22:37 volumio volumio[1073]: info: sendMpdCommand play took 1 milliseconds Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioNext Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::next Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::stop Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::serviceStop Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::serviceStop Jun 27 19:22:38 volumio volumio[1073]: info: [1751023358057] ControllerUPNPBrowser::stop Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand stop took 22 milliseconds Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::play index undefined Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrack 1 Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::startPlaybackTimer Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrack 1 Jun 27 19:22:38 volumio volumio[1073]: info: [1751023358085] ControllerUPNPBrowser::clearAddPlayTrack Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand stop took 4 milliseconds Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand clear Jun 27 19:22:38 volumio volumio[1073]: info: Jun 27 19:22:38 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Jun 27 19:22:38 volumio volumio[1073]: info: Ignoring MPD Status Update Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand clear took 4 milliseconds Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.0.132:8200/MediaItems/1554.mp3" Jun 27 19:22:38 volumio volumio[1073]: error: updateQueue error: null Jun 27 19:22:38 volumio volumio[1073]: info: ------------------------------ 7ms Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 27 19:22:38 volumio volumio[1073]: info: Discovery: Getting this device information Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrack 1 Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.0.132:8200/MediaItems/1554.mp3" Jun 27 19:22:38 volumio volumio[1073]: info: Jun 27 19:22:38 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Jun 27 19:22:38 volumio volumio[1073]: info: Ignoring MPD Status Update Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand add "http://192.168.0.132:8200/MediaItems/1554.mp3" took 3 milliseconds Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand play Jun 27 19:22:38 volumio volumio[1073]: info: ------------------------------ 5ms Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand play took 12 milliseconds Jun 27 19:22:38 volumio volumio[1073]: info: Jun 27 19:22:38 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:22:38 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:22:38 volumio volumio[1073]: info: Jun 27 19:22:38 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand status took 29 milliseconds Jun 27 19:22:38 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand status took 9 milliseconds Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 9 milliseconds Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:22:38 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrack 1 Jun 27 19:22:38 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":320,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1554.mp3","artist":null,"album":null,"uri":"http://192.168.0.132:8200/MediaItems/1554.mp3","trackType":"mp3"} Jun 27 19:22:38 volumio volumio[1073]: verbose: CURRENT POSITION 1 Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Jun 27 19:22:38 volumio volumio[1073]: info: ------------------------------ 48ms Jun 27 19:22:38 volumio volumio[1073]: info: Jun 27 19:22:38 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Jun 27 19:22:38 volumio volumio[1073]: info: Ignoring MPD Status Update Jun 27 19:22:38 volumio volumio[1073]: info: Jun 27 19:22:38 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 27 19:22:38 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:22:38 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrack 1 Jun 27 19:22:38 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":320,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱江山更爱美人","artist":"李丽芬","album":"经典老歌","uri":"http://192.168.0.132:8200/MediaItems/1554.mp3","trackType":"mp3"} Jun 27 19:22:38 volumio volumio[1073]: verbose: CURRENT POSITION 1 Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 27 19:22:38 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:38 volumio volumio[1073]: info: ------------------------------ 96ms Jun 27 19:22:38 volumio volumio[1073]: info: ------------------------------ 75ms Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand status took 72 milliseconds Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 43 milliseconds Jun 27 19:22:38 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:22:38 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getTrack 1 Jun 27 19:22:38 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":320,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"爱江山更爱美人","artist":"李丽芬","album":"经典老歌","uri":"http://192.168.0.132:8200/MediaItems/1554.mp3","trackType":"mp3"} Jun 27 19:22:38 volumio volumio[1073]: verbose: CURRENT POSITION 1 Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 27 19:22:38 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:38 volumio volumio[1073]: info: ------------------------------ 322ms Jun 27 19:22:38 volumio volumio[1073]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jun 27 19:22:38 volumio volumio[1073]: info: Completed starting MyVolumio Plugin Jun 27 19:22:38 volumio volumio[1073]: [Metrics] CommandRouter: 44s 771.10ms Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumiosetStartupVolume Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 27 19:22:38 volumio volumio[1073]: info: VolumeController:: Setting startup Volume 100 Jun 27 19:22:38 volumio volumio[1073]: info: VolumeController::SetAlsaVolume100 Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::Close All Modals sent Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::Close All Modals sent Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue Jun 27 19:22:38 volumio volumio[1073]: info: CoreStateMachine::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: CorePlayQueue::getQueue Jun 27 19:22:38 volumio volumio[1073]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Jun 27 19:22:38 volumio volumio[1073]: aplay: main:828: audio open error: Device or resource busy Jun 27 19:22:39 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 27 19:22:39 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:22:39 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 27 19:22:45 volumio volumio[1073]: info: BOOT COMPLETED Jun 27 19:22:48 volumio volumio[1073]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 27 19:22:48 volumio volumio[1073]: info: Retrying Login Due to Network Error Jun 27 19:22:55 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:22:55 volumio volumio[1073]: info: CURURI: music-library Jun 27 19:22:55 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:22:56 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:22:56 volumio volumio[1073]: info: CURURI: music-library/USB Jun 27 19:22:56 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:22:56 volumio volumio[1073]: info: Preloading song: music-library/USB/赵鹏 - 乌兰巴托的夜晚.flac Jun 27 19:22:56 volumio volumio[1073]: info: Preloading song: music-library/USB/赵鹏 - 北国之春.flac Jun 27 19:22:56 volumio volumio[1073]: info: Preloading song: music-library/USB/江智民,周虹 - 有没有人告诉你.flac Jun 27 19:22:56 volumio volumio[1073]: info: Preloading song: music-library/USB/区瑞强 - 偏偏喜欢你.flac Jun 27 19:22:56 volumio volumio[1073]: info: Preloading song: music-library/USB/赵鹏 - 白月光.flac Jun 27 19:22:56 volumio volumio[1073]: info: Preloading song: music-library/USB/蔡琴 - 恰似你的温柔.flac Jun 27 19:22:56 volumio volumio[1073]: info: Exploding uri music-library/USB/赵鹏 - 乌兰巴托的夜晚.flac in service mpd Jun 27 19:22:56 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=%E8%B5%B5%E9%B9%8F/%E4%B8%AD%E5%9B%BD%E6%9C%80%E5%A5%BD%E5%A3%B0%E9%9F%B3%3A%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E4%B8%93%E7%94%A8%E5%A4%A7%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F%E8%B5%B5%E9%B9%8F%20-%20%E4%B9%8C%E5%85%B0%E5%B7%B4%E6%89%98%E7%9A%84%E5%A4%9C%E6%99%9A.flac&metadata=false Jun 27 19:22:56 volumio volumio[1073]: info: URI /mnt/USB/赵鹏 - 乌兰巴托的夜晚.flac Jun 27 19:22:57 volumio volumio[1073]: info: Exploding uri music-library/USB/赵鹏 - 北国之春.flac in service mpd Jun 27 19:22:57 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=%E8%B5%B5%E9%B9%8F/%E4%B8%AD%E5%9B%BD%E6%9C%80%E5%A5%BD%E5%A3%B0%E9%9F%B3%3A%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E4%B8%93%E7%94%A8%E5%A4%A7%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F%E8%B5%B5%E9%B9%8F%20-%20%E5%8C%97%E5%9B%BD%E4%B9%8B%E6%98%A5.flac&metadata=false Jun 27 19:22:57 volumio volumio[1073]: info: URI /mnt/USB/赵鹏 - 北国之春.flac Jun 27 19:22:57 volumio volumio[1073]: info: Exploding uri music-library/USB/江智民,周虹 - 有没有人告诉你.flac in service mpd Jun 27 19:22:57 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=%E6%B1%9F%E6%99%BA%E6%B0%91%2F%E5%91%A8%E8%99%B9/%E5%BD%93%E6%B5%81%E8%A1%8C%E9%81%87%E4%B8%8A%E5%8F%91%E7%83%A7%E6%97%B6/extralarge&path=%2Fmnt%2FUSB%2F%E6%B1%9F%E6%99%BA%E6%B0%91%2C%E5%91%A8%E8%99%B9%20-%20%E6%9C%89%E6%B2%A1%E6%9C%89%E4%BA%BA%E5%91%8A%E8%AF%89%E4%BD%A0.flac&metadata=false Jun 27 19:22:57 volumio volumio[1073]: info: URI /mnt/USB/江智民,周虹 - 有没有人告诉你.flac Jun 27 19:22:57 volumio volumio[1073]: info: Exploding uri music-library/USB/区瑞强 - 偏偏喜欢你.flac in service mpd Jun 27 19:22:57 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=%E5%8C%BA%E7%91%9E%E5%BC%BA/%E6%83%A0%E5%A8%81T200A%E8%AF%95%E9%9F%B3%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F%E5%8C%BA%E7%91%9E%E5%BC%BA%20-%20%E5%81%8F%E5%81%8F%E5%96%9C%E6%AC%A2%E4%BD%A0.flac&metadata=false Jun 27 19:22:57 volumio volumio[1073]: info: URI /mnt/USB/区瑞强 - 偏偏喜欢你.flac Jun 27 19:22:57 volumio volumio[1073]: info: Exploding uri music-library/USB/赵鹏 - 白月光.flac in service mpd Jun 27 19:22:57 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=%E8%B5%B5%E9%B9%8F/%E6%A2%A6%E2%80%94%E2%80%94%E7%8C%AE%E7%BB%99%E5%A4%A7%E4%BA%BA%E4%BB%AC%E7%9A%84%E6%91%87%E7%AF%AE%E6%9B%B2/extralarge&path=%2Fmnt%2FUSB%2F%E8%B5%B5%E9%B9%8F%20-%20%E7%99%BD%E6%9C%88%E5%85%89.flac&metadata=false Jun 27 19:22:57 volumio volumio[1073]: info: URI /mnt/USB/赵鹏 - 白月光.flac Jun 27 19:22:57 volumio volumio[1073]: info: Exploding uri music-library/USB/蔡琴 - 恰似你的温柔.flac in service mpd Jun 27 19:22:57 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=%E8%94%A1%E7%90%B4/%E7%B2%BE%E9%80%89%E8%94%A1%E7%90%B4/extralarge&path=%2Fmnt%2FUSB%2F%E8%94%A1%E7%90%B4%20-%20%E6%81%B0%E4%BC%BC%E4%BD%A0%E7%9A%84%E6%B8%A9%E6%9F%94.flac&metadata=false Jun 27 19:22:57 volumio volumio[1073]: info: URI /mnt/USB/蔡琴 - 恰似你的温柔.flac Jun 27 19:22:58 volumio volumio[1073]: info: MyVolumio login type: Token Jun 27 19:22:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:22:59 volumio volumio[1073]: info: CURURI: music-library/USB/0FD9-11EB Jun 27 19:22:59 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:01 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:23:01 volumio volumio[1073]: info: CURURI: music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF Jun 27 19:23:01 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:01 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/05. 李偲菘+李伟菘 - 一千个伤心的理由.dsf Jun 27 19:23:01 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/10. 阿杜 - 坚持到底.dsf Jun 27 19:23:01 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/13. 朴树 - 那些花儿.dsf Jun 27 19:23:01 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/15. 姜育恒 - 但愿长醉.dsf Jun 27 19:23:01 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/05. 李偲菘+李伟菘 - 一千个伤心的理由.dsf in service mpd Jun 27 19:23:01 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=Li%20Yisong%20Li%20Weisong/SAMPLER%206%20-%20Best%20selection%20(Mandarin)%20Lavender/extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F052%20%E6%96%B0%E4%B8%96%E7%BA%AA%20-%20%E5%8F%91%E7%83%A7%E4%B8%AD%E7%9A%84%E7%B2%BE%E9%80%89Vol.6%20%E8%96%B0%E8%A1%A3%E8%8D%89%20SACD-2017%20DSF%2F05.%20%E6%9D%8E%E5%81%B2%E8%8F%98%2B%E6%9D%8E%E4%BC%9F%E8%8F%98%20-%20%E4%B8%80%E5%8D%83%E4%B8%AA%E4%BC%A4%E5%BF%83%E7%9A%84%E7%90%86%E7%94%B1.dsf&metadata=false Jun 27 19:23:01 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/05. 李偲菘+李伟菘 - 一千个伤心的理由.dsf Jun 27 19:23:01 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/10. 阿杜 - 坚持到底.dsf in service mpd Jun 27 19:23:01 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=Adu/SAMPLER%206%20-%20Best%20selection%20(Mandarin)%20Lavender/extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F052%20%E6%96%B0%E4%B8%96%E7%BA%AA%20-%20%E5%8F%91%E7%83%A7%E4%B8%AD%E7%9A%84%E7%B2%BE%E9%80%89Vol.6%20%E8%96%B0%E8%A1%A3%E8%8D%89%20SACD-2017%20DSF%2F10.%20%E9%98%BF%E6%9D%9C%20-%20%E5%9D%9A%E6%8C%81%E5%88%B0%E5%BA%95.dsf&metadata=false Jun 27 19:23:01 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/10. 阿杜 - 坚持到底.dsf Jun 27 19:23:01 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/13. 朴树 - 那些花儿.dsf in service mpd Jun 27 19:23:01 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=Pu%20Shu/SAMPLER%206%20-%20Best%20selection%20(Mandarin)%20Lavender/extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F052%20%E6%96%B0%E4%B8%96%E7%BA%AA%20-%20%E5%8F%91%E7%83%A7%E4%B8%AD%E7%9A%84%E7%B2%BE%E9%80%89Vol.6%20%E8%96%B0%E8%A1%A3%E8%8D%89%20SACD-2017%20DSF%2F13.%20%E6%9C%B4%E6%A0%91%20-%20%E9%82%A3%E4%BA%9B%E8%8A%B1%E5%84%BF.dsf&metadata=false Jun 27 19:23:01 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/13. 朴树 - 那些花儿.dsf Jun 27 19:23:01 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/15. 姜育恒 - 但愿长醉.dsf in service mpd Jun 27 19:23:01 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=Jiang%20Yuheng/SAMPLER%206%20-%20Best%20selection%20(Mandarin)%20Lavender/extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F052%20%E6%96%B0%E4%B8%96%E7%BA%AA%20-%20%E5%8F%91%E7%83%A7%E4%B8%AD%E7%9A%84%E7%B2%BE%E9%80%89Vol.6%20%E8%96%B0%E8%A1%A3%E8%8D%89%20SACD-2017%20DSF%2F15.%20%E5%A7%9C%E8%82%B2%E6%81%92%20-%20%E4%BD%86%E6%84%BF%E9%95%BF%E9%86%89.dsf&metadata=false Jun 27 19:23:01 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/052 新世纪 - 发烧中的精选Vol.6 薰衣草 SACD-2017 DSF/15. 姜育恒 - 但愿长醉.dsf Jun 27 19:23:20 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:23:20 volumio volumio[1073]: info: CURURI: music-library/USB/0F5F-114F Jun 27 19:23:20 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:28 volumio volumio[1073]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 27 19:23:28 volumio volumio[1073]: info: Retrying Login Due to Network Error Jun 27 19:23:30 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:23:30 volumio volumio[1073]: info: CURURI: music-library/USB Jun 27 19:23:30 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:32 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:23:32 volumio volumio[1073]: info: CURURI: music-library/USB/0FD9-11EB Jun 27 19:23:32 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:38 volumio volumio[1073]: info: MyVolumio login type: Token Jun 27 19:23:47 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:23:47 volumio volumio[1073]: info: CURURI: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF) Jun 27 19:23:48 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:49 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:23:49 volumio volumio[1073]: info: CURURI: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎 Jun 27 19:23:49 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/01.東方寶藏.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/02.亞拉伯跳舞女郎.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/03.沙丘魔女 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/05.追憶 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/06.隨意飄蕩 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/07.過去與今天 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/08. 孤單一吻.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/09.玻璃箱.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/10.水晶球.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/04.無聲的告別 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/01.東方寶藏.dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F01.%E6%9D%B1%E6%96%B9%E5%AF%B6%E8%97%8F.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/01.東方寶藏.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/02.亞拉伯跳舞女郎.dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F02.%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/02.亞拉伯跳舞女郎.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/03.沙丘魔女 .dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F03.%E6%B2%99%E4%B8%98%E9%AD%94%E5%A5%B3%20%20.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/03.沙丘魔女 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/05.追憶 .dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F05.%E8%BF%BD%E6%86%B6%20.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/05.追憶 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/06.隨意飄蕩 .dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F06.%E9%9A%A8%E6%84%8F%E9%A3%84%E8%95%A9%20.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/06.隨意飄蕩 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/07.過去與今天 .dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F07.%E9%81%8E%E5%8E%BB%E8%88%87%E4%BB%8A%E5%A4%A9%20.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/07.過去與今天 .dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/08. 孤單一吻.dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F08.%20%E5%AD%A4%E5%96%AE%E4%B8%80%E5%90%BB.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/08. 孤單一吻.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/09.玻璃箱.dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F09.%E7%8E%BB%E7%92%83%E7%AE%B1.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/09.玻璃箱.dsf Jun 27 19:23:49 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/10.水晶球.dsf in service mpd Jun 27 19:23:49 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F10.%E6%B0%B4%E6%99%B6%E7%90%83.dsf&metadata=false Jun 27 19:23:49 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/10.水晶球.dsf Jun 27 19:23:50 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/04.無聲的告別 .dsf in service mpd Jun 27 19:23:50 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F001%208860853%20BEYOND%20%E4%BA%9E%E6%8B%89%E4%BC%AF%E8%B7%B3%E8%88%9E%E5%A5%B3%E9%83%8E%2F04.%E7%84%A1%E8%81%B2%E7%9A%84%E5%91%8A%E5%88%A5%20.dsf&metadata=false Jun 27 19:23:50 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/001 8860853 BEYOND 亞拉伯跳舞女郎/04.無聲的告別 .dsf Jun 27 19:23:54 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 27 19:23:54 volumio volumio[1073]: info: CURURI: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对 Jun 27 19:23:54 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/2.兩顆心.dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/3.俾面派對.dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/4.無淚的遺憾 .dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/5.懷念您.dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/6.可知道.dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/7.相依的心 .dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/8.撒旦的咀咒.dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/9.送給不知怎去保護環境的人(包括我).dsf Jun 27 19:23:54 volumio volumio[1073]: info: Preloading song: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/10.戰勝心魔 [電影「開心鬼第四集」主題曲].dsf Jun 27 19:23:54 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf in service mpd Jun 27 19:23:54 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F1.%E5%85%89%E8%BC%9D%E6%AD%B2%E6%9C%88%20.dsf&metadata=false Jun 27 19:23:54 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf Jun 27 19:23:54 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/2.兩顆心.dsf in service mpd Jun 27 19:23:54 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F2.%E5%85%A9%E9%A1%86%E5%BF%83.dsf&metadata=false Jun 27 19:23:54 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/2.兩顆心.dsf Jun 27 19:23:54 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/3.俾面派對.dsf in service mpd Jun 27 19:23:54 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F3.%E4%BF%BE%E9%9D%A2%E6%B4%BE%E5%B0%8D.dsf&metadata=false Jun 27 19:23:54 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/3.俾面派對.dsf Jun 27 19:23:54 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/4.無淚的遺憾 .dsf in service mpd Jun 27 19:23:54 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F4.%E7%84%A1%E6%B7%9A%E7%9A%84%E9%81%BA%E6%86%BE%20.dsf&metadata=false Jun 27 19:23:54 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/4.無淚的遺憾 .dsf Jun 27 19:23:55 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/5.懷念您.dsf in service mpd Jun 27 19:23:55 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F5.%E6%87%B7%E5%BF%B5%E6%82%A8.dsf&metadata=false Jun 27 19:23:55 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/5.懷念您.dsf Jun 27 19:23:55 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/6.可知道.dsf in service mpd Jun 27 19:23:55 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F6.%E5%8F%AF%E7%9F%A5%E9%81%93.dsf&metadata=false Jun 27 19:23:55 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/6.可知道.dsf Jun 27 19:23:55 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/7.相依的心 .dsf in service mpd Jun 27 19:23:55 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F7.%E7%9B%B8%E4%BE%9D%E7%9A%84%E5%BF%83%20%20.dsf&metadata=false Jun 27 19:23:55 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/7.相依的心 .dsf Jun 27 19:23:55 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/8.撒旦的咀咒.dsf in service mpd Jun 27 19:23:55 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F8.%E6%92%92%E6%97%A6%E7%9A%84%E5%92%80%E5%92%92.dsf&metadata=false Jun 27 19:23:55 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/8.撒旦的咀咒.dsf Jun 27 19:23:55 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/9.送給不知怎去保護環境的人(包括我).dsf in service mpd Jun 27 19:23:55 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F9.%E9%80%81%E7%B5%A6%E4%B8%8D%E7%9F%A5%E6%80%8E%E5%8E%BB%E4%BF%9D%E8%AD%B7%E7%92%B0%E5%A2%83%E7%9A%84%E4%BA%BA(%E5%8C%85%E6%8B%AC%E6%88%91).dsf&metadata=false Jun 27 19:23:55 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/9.送給不知怎去保護環境的人(包括我).dsf Jun 27 19:23:55 volumio volumio[1073]: info: Exploding uri music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/10.戰勝心魔 [電影「開心鬼第四集」主題曲].dsf in service mpd Jun 27 19:23:55 volumio volumio[1073]: info: ALBUMART /albumart?cacheid=609&web=//extralarge&path=%2Fmnt%2FUSB%2F0FD9-11EB%2F037%20Beyond%20-%20STILL%20BEYOND(Unversal%208860852%2011SACD%20DSF)%2F006%208860858%20%20BEYOND%20%E5%91%BD%E8%BF%90%E6%B4%BE%E5%AF%B9%2F10.%E6%88%B0%E5%8B%9D%E5%BF%83%E9%AD%94%20%5B%E9%9B%BB%E5%BD%B1%E3%80%8C%E9%96%8B%E5%BF%83%E9%AC%BC%E7%AC%AC%E5%9B%9B%E9%9B%86%E3%80%8D%E4%B8%BB%E9%A1%8C%E6%9B%B2%5D.dsf&metadata=false Jun 27 19:23:55 volumio volumio[1073]: info: URI /mnt/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/10.戰勝心魔 [電影「開心鬼第四集」主題曲].dsf Jun 27 19:23:56 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::ClearQueue Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::stop Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrack 1 Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::serviceStop Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrack 1 Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::serviceStop Jun 27 19:23:56 volumio volumio[1073]: info: [1751023436508] ControllerUPNPBrowser::stop Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::clearPlayQueue Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::saveQueue Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::addQueueItems Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::addQueueItems Jun 27 19:23:56 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::saveQueue Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::volumioPlay Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::play index 0 Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::addQueueItems Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::addQueueItems Jun 27 19:23:56 volumio volumio[1073]: info: Preload queue cleared Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/2.兩顆心.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/2.兩顆心.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/3.俾面派對.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/3.俾面派對.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/4.無淚的遺憾 .dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/4.無淚的遺憾 .dsf Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/5.懷念您.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/5.懷念您.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/6.可知道.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/6.可知道.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/7.相依的心 .dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/7.相依的心 .dsf Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/8.撒旦的咀咒.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/8.撒旦的咀咒.dsf Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/9.送給不知怎去保護環境的人(包括我).dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/9.送給不知怎去保護環境的人(包括我).dsf Jun 27 19:23:56 volumio volumio[1073]: info: Adding Item to queue: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/10.戰勝心魔 [電影「開心鬼第四集」主題曲].dsf Jun 27 19:23:56 volumio volumio[1073]: info: Using cached record of: music-library/USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/10.戰勝心魔 [電影「開心鬼第四集」主題曲].dsf Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::stop Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::saveQueue Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::play index undefined Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::startPlaybackTimer Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::clearAddPlayTracks USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Jun 27 19:23:56 volumio volumio[1073]: info: Jun 27 19:23:56 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand stop took 88 milliseconds Jun 27 19:23:56 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand stop took 15 milliseconds Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand clear Jun 27 19:23:56 volumio volumio[1073]: info: Jun 27 19:23:56 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Jun 27 19:23:56 volumio volumio[1073]: info: Ignoring MPD Status Update Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand status took 6 milliseconds Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand clear took 4 milliseconds Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand add "USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf" Jun 27 19:23:56 volumio volumio[1073]: error: updateQueue error: null Jun 27 19:23:56 volumio volumio[1073]: info: Jun 27 19:23:56 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Jun 27 19:23:56 volumio volumio[1073]: info: Ignoring MPD Status Update Jun 27 19:23:56 volumio volumio[1073]: info: ------------------------------ 17ms Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 13 milliseconds Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand add "USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf" took 14 milliseconds Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand play Jun 27 19:23:56 volumio volumio[1073]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 27 19:23:56 volumio volumio[1073]: info: ------------------------------ 28ms Jun 27 19:23:56 volumio volumio[1073]: info: ------------------------------ 7ms Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand play took 3 milliseconds Jun 27 19:23:56 volumio volumio[1073]: info: Jun 27 19:23:56 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:23:56 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:23:56 volumio volumio[1073]: info: Jun 27 19:23:56 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand status took 8 milliseconds Jun 27 19:23:56 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand status took 3 milliseconds Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:23:56 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:56 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":305,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"光辉岁月","artist":null,"album":null,"uri":"USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf","trackType":"dsf"} Jun 27 19:23:56 volumio volumio[1073]: verbose: CURRENT POSITION 0 Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Jun 27 19:23:56 volumio volumio[1073]: info: ------------------------------ 17ms Jun 27 19:23:56 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 27 19:23:56 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:23:56 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:56 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":305,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"光辉岁月","artist":null,"album":null,"uri":"USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf","trackType":"dsf"} Jun 27 19:23:56 volumio volumio[1073]: verbose: CURRENT POSITION 0 Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Jun 27 19:23:56 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:23:56 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:23:56 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:56 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:23:56 volumio volumio[1073]: info: ------------------------------ 60ms Jun 27 19:23:58 volumio volumio[1073]: info: Jun 27 19:23:58 volumio volumio[1073]: ---------------------------- USB Audio Device Detached Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jun 27 19:23:58 volumio kernel: usb 1-1.4.2: reset full-speed USB device number 6 using ehci-pci Jun 27 19:23:58 volumio volumio[1073]: info: Jun 27 19:23:58 volumio volumio[1073]: ---------------------------- USB Audio Device Attached Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::Close All Modals sent Jun 27 19:23:58 volumio volumio[1073]: info: Preparing to save Alsa Options, stopping services first Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Jun 27 19:23:58 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::volumioPause Jun 27 19:23:58 volumio volumio[1073]: info: CoreStateMachine::pause Jun 27 19:23:58 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Jun 27 19:23:58 volumio volumio[1073]: info: CoreStateMachine::servicePause Jun 27 19:23:58 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::servicePause Jun 27 19:23:58 volumio volumio[1073]: info: ControllerMpd::pause Jun 27 19:23:58 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand pause Jun 27 19:23:58 volumio volumio[1073]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"Bravo-X USB Audio","alsacard":"Audio"},"i2s":false} Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:23:58 volumio volumio[1073]: info: Setting mixer PCM for card Bravo-X USB Audio Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 27 19:23:58 volumio volumio[1073]: info: Updating Volume Controller Parameters: Device: 5 Name: Bravo-X USB Audio Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 27 19:23:58 volumio volumio[1073]: info: Disabling external Volume Control Jun 27 19:23:58 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 27 19:23:58 volumio volumio[1073]: info: Preparing to generate the ALSA configuration file Jun 27 19:23:59 volumio volumio[1073]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Jun 27 19:23:59 volumio volumio[1073]: info: Reading ALSA contributions from plugins. Jun 27 19:23:59 volumio volumio[1073]: info: Jun 27 19:23:59 volumio volumio[1073]: ---------------------------- MPD announces state update: player Jun 27 19:23:59 volumio volumio[1073]: info: sendMpdCommand pause took 382 milliseconds Jun 27 19:23:59 volumio volumio[1073]: info: ControllerMpd::getState Jun 27 19:23:59 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Jun 27 19:23:59 volumio volumio[1073]: info: sendMpdCommand status took 22 milliseconds Jun 27 19:23:59 volumio volumio[1073]: verbose: ControllerMpd::parseState Jun 27 19:23:59 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 27 19:23:59 volumio volumio[1073]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jun 27 19:23:59 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 27 19:23:59 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Jun 27 19:23:59 volumio volumio[1073]: info: ControllerMpd::pushState Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Jun 27 19:23:59 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:59 volumio volumio[1073]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2891,"duration":305,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"光辉岁月","artist":null,"album":null,"uri":"USB/0FD9-11EB/037 Beyond - STILL BEYOND(Unversal 8860852 11SACD DSF)/006 8860858 BEYOND 命运派对/1.光輝歲月 .dsf","trackType":"dsf"} Jun 27 19:23:59 volumio volumio[1073]: verbose: CURRENT POSITION 0 Jun 27 19:23:59 volumio volumio[1073]: info: CoreStateMachine::syncState stateService pause Jun 27 19:23:59 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus pause Jun 27 19:23:59 volumio volumio[1073]: info: CoreStateMachine::pushState Jun 27 19:23:59 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Jun 27 19:23:59 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Jun 27 19:23:59 volumio volumio[1073]: info: ------------------------------ 63ms Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 27 19:23:59 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 27 19:23:59 volumio volumio[1073]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 19:23:59 volumio volumio[1073]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Jun 27 19:23:59 volumio volumio[1073]: at Object.readdirSync (fs.js:1048:3) Jun 27 19:23:59 volumio volumio[1073]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Jun 27 19:23:59 volumio volumio[1073]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Jun 27 19:23:59 volumio volumio[1073]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Jun 27 19:23:59 volumio volumio[1073]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Jun 27 19:23:59 volumio volumio[1073]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Jun 27 19:23:59 volumio volumio[1073]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jun 27 19:23:59 volumio volumio[1073]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Jun 27 19:23:59 volumio volumio[1073]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Jun 27 19:23:59 volumio volumio[1073]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Jun 27 19:23:59 volumio volumio[1073]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jun 27 19:23:59 volumio volumio[1073]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Jun 27 19:23:59 volumio volumio[1073]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Jun 27 19:23:59 volumio volumio[1073]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jun 27 19:23:59 volumio volumio[1073]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Jun 27 19:23:59 volumio volumio[1073]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Jun 27 19:23:59 volumio volumio[1073]: errno: -20, Jun 27 19:23:59 volumio volumio[1073]: syscall: 'scandir', Jun 27 19:23:59 volumio volumio[1073]: code: 'ENOTDIR', Jun 27 19:23:59 volumio volumio[1073]: path: '/tmp/peppyrunning' Jun 27 19:23:59 volumio volumio[1073]: } Jun 27 19:23:59 volumio volumio[1073]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 27 19:23:59 volumio sudo[2493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-27 19:22 Jun 27 19:23:59 volumio sudo[2493]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"