-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Tue 2025-10-28 15:19:35 CST. -- Oct 28 15:18:01 smsl-n100 volumio[981]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 28 15:18:01 smsl-n100 volumio[981]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 28 15:18:01 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 15:18:01 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 15:18:01 smsl-n100 volumio[981]: info: Starting MyVolumio Remote Streaming Endpoints Oct 28 15:18:01 smsl-n100 volumio[981]: info: MyVolumio not started Oct 28 15:18:01 smsl-n100 volumio[981]: info: Initializing device activation check Oct 28 15:18:01 smsl-n100 volumio[981]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 28 15:18:01 smsl-n100 volumio[981]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Oct 28 15:18:01 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:01 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:01 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:03 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:03 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:03 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:03 smsl-n100 volumio[1265]: .........................................................................................................................................................++++ Oct 28 15:18:03 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:03 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:03 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:04 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:04 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:04 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:05 smsl-n100 volumio[1265]: ..........................++++ Oct 28 15:18:05 smsl-n100 volumio[1265]: e is 65537 (0x010001) Oct 28 15:18:05 smsl-n100 volumio[1265]: writing RSA key Oct 28 15:18:05 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:05 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:05 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:06 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:06 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:06 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:07 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:07 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:07 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:08 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:08 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:08 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:09 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:09 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:09 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:10 smsl-n100 volumio[981]: error: MyVolumio Plugin failed to start in a timely fashion Oct 28 15:18:10 smsl-n100 volumio[981]: [Metrics] CommandRouter: 63s 602.90ms Oct 28 15:18:10 smsl-n100 volumio[981]: info: CoreCommandRouter::volumiosetStartupVolume Oct 28 15:18:10 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:10 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 15:18:10 smsl-n100 volumio[981]: info: CoreCommandRouter::Close All Modals sent Oct 28 15:18:10 smsl-n100 volumio[981]: info: CoreCommandRouter::Close All Modals sent Oct 28 15:18:10 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Oct 28 15:18:10 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:10 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:11 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:11 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 28 15:18:11 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 28 15:18:11 smsl-n100 volumio[981]: xcb_connection_has_error() returned true Oct 28 15:18:11 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 28 15:18:11 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:11 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:12 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:12 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:12 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:13 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:13 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:13 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:13 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 28 15:18:13 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 15:18:13 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 28 15:18:14 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:14 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:14 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:15 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 28 15:18:15 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:15 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:16 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 28 15:18:16 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:16 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:16 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 28 15:18:16 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 28 15:18:16 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:16 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:17 smsl-n100 volumio[981]: info: BOOT COMPLETED Oct 28 15:18:17 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:17 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 28 15:18:17 smsl-n100 volumio[981]: info: Not Reporting Auto name since its the default one Oct 28 15:18:17 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 28 15:18:17 smsl-n100 volumio[981]: xcb_connection_has_error() returned true Oct 28 15:18:17 smsl-n100 sudo[1549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 28 15:18:17 smsl-n100 sudo[1549]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 15:18:17 smsl-n100 sudo[1549]: pam_unix(sudo:session): session closed for user root Oct 28 15:18:17 smsl-n100 sudo[1551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 28 15:18:17 smsl-n100 sudo[1551]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 15:18:17 smsl-n100 systemd[1]: Started RAAT DAEMON. Oct 28 15:18:17 smsl-n100 sudo[1551]: pam_unix(sudo:session): session closed for user root Oct 28 15:18:18 smsl-n100 volumio[981]: info: Raat Daemon started successfully Oct 28 15:18:18 smsl-n100 volumio[981]: info: Executing endpoint restartRAATSocket Oct 28 15:18:18 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 28 15:18:18 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:18 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 28 15:18:18 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:18 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:18 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:18 smsl-n100 systemd[1]: systemd-hostnamed.service: Succeeded. Oct 28 15:18:19 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:19 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:19 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:20 smsl-n100 volumio[981]: info: RAAT: Requesting Headphone Status Oct 28 15:18:20 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 28 15:18:20 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:20 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:20 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:20 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:20 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:20 smsl-n100 volumio[981]: error: Serial API: Failed to decode command: 100, message: undefined Oct 28 15:18:20 smsl-n100 volumio[981]: error: Serial API: Failed to decode command: MAXVOL, message: Oct 28 15:18:20 smsl-n100 volumio[981]: error: Serial API: Failed to decode command: 100, message: undefined Oct 28 15:18:20 smsl-n100 volumio[981]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Oct 28 15:18:20 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:21 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:21 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:21 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:21 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 15:18:21 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 28 15:18:21 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 28 15:18:21 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 28 15:18:21 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetBrowseSources Oct 28 15:18:21 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 28 15:18:22 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:22 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:22 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:23 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 28 15:18:23 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 28 15:18:23 smsl-n100 volumio[981]: info: Discovery: Getting this device information Oct 28 15:18:23 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:23 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:23 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 28 15:18:24 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:24 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:24 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:24 smsl-n100 volumio[981]: verbose: New Socket.io Connection to 192.168.1.197 from 192.168.1.188 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Oct 28 15:18:24 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:24 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:24 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 28 15:18:24 smsl-n100 volumio[981]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 28 15:18:24 smsl-n100 volumio[981]: info: Listing playlists Oct 28 15:18:24 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetQueue Oct 28 15:18:24 smsl-n100 volumio[981]: info: CoreStateMachine::getQueue Oct 28 15:18:24 smsl-n100 volumio[981]: info: CorePlayQueue::getQueue Oct 28 15:18:24 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetVisibleSources Oct 28 15:18:24 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 28 15:18:25 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:25 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:25 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:26 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:27 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:27 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:28 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:28 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:28 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:29 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:29 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:29 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:30 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:30 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:30 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:30 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 28 15:18:30 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 28 15:18:30 smsl-n100 volumio[981]: info: Discovery: Getting this device information Oct 28 15:18:30 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:30 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:30 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 28 15:18:31 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:31 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:31 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:32 smsl-n100 volumio-remote-updater[570]: No test mode Oct 28 15:18:32 smsl-n100 volumio-remote-updater[570]: No alpha test mode Oct 28 15:18:33 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 28 15:18:33 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:33 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:33 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:33 smsl-n100 volumio[981]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 28 15:18:33 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 28 15:18:34 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:34 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:34 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:35 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:35 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:35 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:37 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:37 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:37 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:38 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:38 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:38 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:39 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:39 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:39 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:40 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:40 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:40 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:42 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:42 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:42 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:43 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:43 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:43 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:44 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:44 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:44 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:45 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:45 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:45 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:46 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:46 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:46 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:47 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:47 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:47 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:48 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:48 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:48 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:49 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:49 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:49 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:50 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:50 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:50 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:51 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:51 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:51 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:52 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:52 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:52 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:52 smsl-n100 wpa_supplicant[876]: wlan0: WPA: Group rekeying completed with 94:e7:ea:87:81:f8 [GTK=TKIP] Oct 28 15:18:53 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:53 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:53 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 0 Oct 28 15:18:54 smsl-n100 volumio[981]: info: Preload queue cleared Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::ClearQueue Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::stop Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::clearPlayQueue Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::saveQueue Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushQueue Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::addQueueItems Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::addQueueItems Oct 28 15:18:54 smsl-n100 volumio[981]: info: Preload queue cleared Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/01.蔡琴 - 被遗忘的时光.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/01.蔡琴 - 被遗忘的时光.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/02.蔡琴 - 跟我说爱我.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/02.蔡琴 - 跟我说爱我.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/03.蔡琴 - 你的眼神.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/03.蔡琴 - 你的眼神.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/04.蔡琴 - 想你的时候.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/04.蔡琴 - 想你的时候.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/05.蔡琴 - 抉择.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/05.蔡琴 - 抉择.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/06.蔡琴 - 我的思念.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/06.蔡琴 - 我的思念.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/07.蔡琴 - 出塞曲.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/07.蔡琴 - 出塞曲.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F01.%E8%94%A1%E7%90%B4%20-%20%E8%A2%AB%E9%81%97%E5%BF%98%E7%9A%84%E6%97%B6%E5%85%89.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/01.蔡琴 - 被遗忘的时光.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F02.%E8%94%A1%E7%90%B4%20-%20%E8%B7%9F%E6%88%91%E8%AF%B4%E7%88%B1%E6%88%91.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/02.蔡琴 - 跟我说爱我.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F03.%E8%94%A1%E7%90%B4%20-%20%E4%BD%A0%E7%9A%84%E7%9C%BC%E7%A5%9E.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/03.蔡琴 - 你的眼神.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F04.%E8%94%A1%E7%90%B4%20-%20%E6%83%B3%E4%BD%A0%E7%9A%84%E6%97%B6%E5%80%99.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/04.蔡琴 - 想你的时候.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F05.%E8%94%A1%E7%90%B4%20-%20%E6%8A%89%E6%8B%A9.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/05.蔡琴 - 抉择.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F06.%E8%94%A1%E7%90%B4%20-%20%E6%88%91%E7%9A%84%E6%80%9D%E5%BF%B5.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/06.蔡琴 - 我的思念.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F07.%E8%94%A1%E7%90%B4%20-%20%E5%87%BA%E5%A1%9E%E6%9B%B2.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/07.蔡琴 - 出塞曲.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F08.%E8%94%A1%E7%90%B4%20-%20%E6%B8%A1%E5%8F%A3.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushQueue Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::saveQueue Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::updateTrackBlock Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::getTrackBlock Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPlay Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::play index 7 Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::addQueueItems Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::addQueueItems Oct 28 15:18:54 smsl-n100 volumio[981]: info: Preload queue cleared Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/09.蔡琴 - 怎么能.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/09.蔡琴 - 怎么能.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/10.蔡琴 - 恰似你的温柔.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/10.蔡琴 - 恰似你的温柔.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/11.蔡琴 - 再爱我一次.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/11.蔡琴 - 再爱我一次.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: Adding Item to queue: music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/12.蔡琴 - 谢幕曲.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: Exploding uri music-library/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/12.蔡琴 - 谢幕曲.wav in service mpd Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::stop Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::play index undefined Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::startPlaybackTimer Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetVisibleSources Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::clearAddPlayTracks USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F09.%E8%94%A1%E7%90%B4%20-%20%E6%80%8E%E4%B9%88%E8%83%BD.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/09.蔡琴 - 怎么能.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F10.%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.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/10.蔡琴 - 恰似你的温柔.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F11.%E8%94%A1%E7%90%B4%20-%20%E5%86%8D%E7%88%B1%E6%88%91%E4%B8%80%E6%AC%A1.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/11.蔡琴 - 再爱我一次.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: ALBUMART /albumart?cacheid=399&web=//extralarge&path=%2Fmnt%2FUSB%2FF7D67CA019565C7E%2F%E8%94%A1%E7%90%B4%20-%20%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4%20(GOLD%20TYPHOON)%20(%E9%9B%A8%E6%9E%9C%E7%89%88)%20%5BLPCD45II%5D%20%5BWAV%5D%2F12.%E8%94%A1%E7%90%B4%20-%20%E8%B0%A2%E5%B9%95%E6%9B%B2.wav&metadata=false Oct 28 15:18:54 smsl-n100 volumio[981]: info: URI /mnt/USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/12.蔡琴 - 谢幕曲.wav Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand stop took 27 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand clear Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushQueue Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::saveQueue Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::updateTrackBlock Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::getTrackBlock Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces system playlist update Oct 28 15:18:54 smsl-n100 volumio[981]: info: Ignoring MPD Status Update Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand clear took 43 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand add "USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav" Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces system playlist update Oct 28 15:18:54 smsl-n100 volumio[981]: info: Ignoring MPD Status Update Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces system playlist update Oct 28 15:18:54 smsl-n100 volumio[981]: info: Ignoring MPD Status Update Oct 28 15:18:54 smsl-n100 volumio[981]: error: updateQueue error: null Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces system playlist update Oct 28 15:18:54 smsl-n100 volumio[981]: info: Ignoring MPD Status Update Oct 28 15:18:54 smsl-n100 volumio[981]: info: ------------------------------ 30ms Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand add "USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav" took 23 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: ------------------------------ 21ms Oct 28 15:18:54 smsl-n100 volumio[981]: info: ------------------------------ 18ms Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand play Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces system playlist update Oct 28 15:18:54 smsl-n100 volumio[981]: info: Ignoring MPD Status Update Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces system playlist update Oct 28 15:18:54 smsl-n100 volumio[981]: info: Ignoring MPD Status Update Oct 28 15:18:54 smsl-n100 volumio[981]: error: Upnp client error: Error: This socket has been ended by the other party Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces state update: player Oct 28 15:18:54 smsl-n100 volumio[981]: info: ------------------------------ 54ms Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand play took 44 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: ------------------------------ 42ms Oct 28 15:18:54 smsl-n100 volumio[981]: info: ------------------------------ 35ms Oct 28 15:18:54 smsl-n100 volumio[981]: info: ControllerMpd::getState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand status Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces state update: player Oct 28 15:18:54 smsl-n100 volumio[981]: info: ControllerMpd::getState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand status Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces state update: player Oct 28 15:18:54 smsl-n100 volumio[981]: info: ControllerMpd::getState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand status Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces state update: player Oct 28 15:18:54 smsl-n100 volumio[981]: info: ControllerMpd::getState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand status Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand status took 56 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand status took 46 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand status took 35 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces state update: player Oct 28 15:18:54 smsl-n100 volumio[981]: info: ControllerMpd::getState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand status Oct 28 15:18:54 smsl-n100 volumio[981]: info: Oct 28 15:18:54 smsl-n100 volumio[981]: ---------------------------- MPD announces state update: player Oct 28 15:18:54 smsl-n100 volumio[981]: info: ControllerMpd::getState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand status Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand status took 70 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand playlistinfo took 59 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand playlistinfo took 58 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand playlistinfo took 57 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand status took 52 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: info: sendMpdCommand status took 46 milliseconds Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseTrackInfo Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseTrackInfo Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseTrackInfo Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::parseState Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 15:18:54 smsl-n100 volumio[981]: info: ControllerMpd::pushState Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::servicePushState Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"08.蔡琴 - 渡口.wav","artist":null,"album":null,"uri":"USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav","trackType":"wav"} Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: CURRENT POSITION 7 Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::syncState stateService play Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::syncState currentStatus stop Oct 28 15:18:54 smsl-n100 volumio[981]: info: ControllerMpd::pushState Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::servicePushState Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"08.蔡琴 - 渡口.wav","artist":null,"album":null,"uri":"USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav","trackType":"wav"} Oct 28 15:18:54 smsl-n100 volumio[981]: verbose: CURRENT POSITION 7 Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::syncState stateService play Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::syncState currentStatus play Oct 28 15:18:54 smsl-n100 volumio[981]: info: Received an update from plugin. extracting info from payload Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:54 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:54 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:54 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:54 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: ControllerMpd::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::servicePushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"08.蔡琴 - 渡口.wav","artist":null,"album":null,"uri":"USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav","trackType":"wav"} Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: CURRENT POSITION 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::syncState stateService play Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::syncState currentStatus play Oct 28 15:18:55 smsl-n100 volumio[981]: info: Received an update from plugin. extracting info from payload Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: ------------------------------ 257ms Oct 28 15:18:55 smsl-n100 volumio[981]: info: ------------------------------ 300ms Oct 28 15:18:55 smsl-n100 volumio[981]: info: ------------------------------ 291ms Oct 28 15:18:55 smsl-n100 volumio[981]: info: sendMpdCommand playlistinfo took 177 milliseconds Oct 28 15:18:55 smsl-n100 volumio[981]: info: sendMpdCommand playlistinfo took 167 milliseconds Oct 28 15:18:55 smsl-n100 volumio[981]: info: sendMpdCommand playlistinfo took 166 milliseconds Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: ControllerMpd::parseTrackInfo Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: ControllerMpd::parseTrackInfo Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: ControllerMpd::parseTrackInfo Oct 28 15:18:55 smsl-n100 volumio[981]: info: ControllerMpd::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::servicePushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"08.蔡琴 - 渡口.wav","artist":null,"album":null,"uri":"USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav","trackType":"wav"} Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: CURRENT POSITION 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::syncState stateService play Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::syncState currentStatus play Oct 28 15:18:55 smsl-n100 volumio[981]: info: Received an update from plugin. extracting info from payload Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: ControllerMpd::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::servicePushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"08.蔡琴 - 渡口.wav","artist":null,"album":null,"uri":"USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav","trackType":"wav"} Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: CURRENT POSITION 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::syncState stateService play Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::syncState currentStatus play Oct 28 15:18:55 smsl-n100 volumio[981]: info: Received an update from plugin. extracting info from payload Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: ControllerMpd::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::servicePushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"08.蔡琴 - 渡口.wav","artist":null,"album":null,"uri":"USB/F7D67CA019565C7E/蔡琴 - 民歌蔡琴 (GOLD TYPHOON) (雨果版) [LPCD45II] [WAV]/08.蔡琴 - 渡口.wav","trackType":"wav"} Oct 28 15:18:55 smsl-n100 volumio[981]: verbose: CURRENT POSITION 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::syncState stateService play Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::syncState currentStatus play Oct 28 15:18:55 smsl-n100 volumio[981]: info: Received an update from plugin. extracting info from payload Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:18:55 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:18:55 smsl-n100 volumio[981]: info: ------------------------------ 454ms Oct 28 15:18:55 smsl-n100 volumio[981]: info: ------------------------------ 427ms Oct 28 15:18:55 smsl-n100 volumio[981]: info: ------------------------------ 424ms Oct 28 15:18:55 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:55 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:56 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:56 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:56 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:57 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:57 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:57 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:58 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:58 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:58 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:58 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 28 15:18:58 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 28 15:18:58 smsl-n100 volumio[981]: info: Discovery: Getting this device information Oct 28 15:18:58 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:58 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:18:58 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 28 15:18:59 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:18:59 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:18:59 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:01 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:01 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:01 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:02 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:02 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:02 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:04 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:04 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:04 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:05 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:05 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:05 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:06 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:06 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:06 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:07 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:07 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:07 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:08 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:08 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:08 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:09 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:09 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:09 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:10 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:11 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:11 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:12 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:12 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:12 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:13 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:13 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:13 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:14 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:14 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:14 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:15 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:15 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:15 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:16 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:16 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:16 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:17 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:17 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:17 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:19 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:19 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:19 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:19 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:19 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:19 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:20 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:20 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:20 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:21 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:21 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:21 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:23 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:23 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:23 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:24 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:24 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:24 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:25 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:25 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:25 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:27 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:27 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:27 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:27 smsl-n100 wpa_supplicant[876]: wlan0: CTRL-EVENT-DISCONNECTED bssid=94:e7:ea:87:81:f8 reason=0 Oct 28 15:19:27 smsl-n100 dhcpcd[970]: wlan0: carrier lost Oct 28 15:19:27 smsl-n100 wpa_supplicant[876]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 28 15:19:27 smsl-n100 wpa_supplicant[876]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=CN Oct 28 15:19:27 smsl-n100 avahi-daemon[564]: Withdrawing address record for 192.168.1.197 on wlan0. Oct 28 15:19:27 smsl-n100 avahi-daemon[564]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.197. Oct 28 15:19:27 smsl-n100 avahi-daemon[564]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 28 15:19:27 smsl-n100 dhcpcd[970]: wlan0: deleting route to 192.168.1.0/24 Oct 28 15:19:27 smsl-n100 dhcpcd[970]: wlan0: deleting default route via 192.168.1.1 Oct 28 15:19:27 smsl-n100 volumio[981]: info: Discovery: A device disappeared from network Oct 28 15:19:27 smsl-n100 wpa_supplicant[876]: wlan0: Trying to associate with 94:e7:ea:87:81:f4 (SSID='iFamily' freq=2412 MHz) Oct 28 15:19:28 smsl-n100 wpa_supplicant[876]: wlan0: Associated with 94:e7:ea:87:81:f4 Oct 28 15:19:28 smsl-n100 wpa_supplicant[876]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 28 15:19:28 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:28 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:28 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:29 smsl-n100 wpa_supplicant[876]: wlan0: WPA: Key negotiation completed with 94:e7:ea:87:81:f4 [PTK=CCMP GTK=CCMP] Oct 28 15:19:29 smsl-n100 wpa_supplicant[876]: wlan0: CTRL-EVENT-CONNECTED - Connection to 94:e7:ea:87:81:f4 completed [id=0 id_str=] Oct 28 15:19:29 smsl-n100 dhcpcd[970]: wlan0: carrier acquired Oct 28 15:19:29 smsl-n100 dhcpcd[970]: wlan0: IAID 2b:ee:c9:97 Oct 28 15:19:29 smsl-n100 dhcpcd[970]: wlan0: soliciting an IPv6 router Oct 28 15:19:29 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:29 smsl-n100 dhcpcd[970]: wlan0: rebinding lease of 192.168.1.197 Oct 28 15:19:29 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:29 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:29 smsl-n100 dhcpcd[970]: wlan0: probing address 192.168.1.197/24 Oct 28 15:19:30 smsl-n100 ntpd[969]: Deleting interface #3 wlan0, 192.168.1.197#123, interface stats: received=112, sent=117, dropped=2, active_time=149 secs Oct 28 15:19:30 smsl-n100 ntpd[969]: 14.103.157.44 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 5.79.108.34 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 119.28.206.193 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 101.43.66.2 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 139.199.215.251 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 193.182.111.12 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 185.209.85.222 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 162.159.200.1 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 193.182.111.141 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 162.159.200.123 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 ntpd[969]: 210.28.130.4 local addr 192.168.1.197 -> Oct 28 15:19:30 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:30 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:30 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:31 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:31 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:31 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:32 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:32 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:32 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:32 smsl-n100 volumio[981]: info: Reporting MCU Network Status: 0 Oct 28 15:19:32 smsl-n100 volumio[981]: info: Volumio Network Manager: Network status updated: 0 Oct 28 15:19:32 smsl-n100 volumio[981]: info: CoreStateMachine::pushState Oct 28 15:19:32 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:32 smsl-n100 volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 15:19:32 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPushState Oct 28 15:19:32 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output update for this device Oct 28 15:19:32 smsl-n100 volumio[981]: info: MRS: Pushing multiroomSync output Oct 28 15:19:32 smsl-n100 volumio[981]: error: Serial API: Failed to decode command: 100, message: undefined Oct 28 15:19:32 smsl-n100 volumio[981]: error: Serial API: Failed to decode command: MAXVOL, message: Oct 28 15:19:32 smsl-n100 volumio[981]: error: Serial API: Failed to decode command: 100, message: undefined Oct 28 15:19:32 smsl-n100 volumio[981]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Oct 28 15:19:32 smsl-n100 volumio[981]: error: Serial API: Failed to decode command: 0, message: undefined Oct 28 15:19:32 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:33 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:33 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:34 smsl-n100 dhcpcd[970]: wlan0: leased 192.168.1.197 for 3600 seconds Oct 28 15:19:34 smsl-n100 avahi-daemon[564]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.197. Oct 28 15:19:34 smsl-n100 avahi-daemon[564]: New relevant interface wlan0.IPv4 for mDNS. Oct 28 15:19:34 smsl-n100 dhcpcd[970]: wlan0: adding route to 192.168.1.0/24 Oct 28 15:19:34 smsl-n100 avahi-daemon[564]: Registering new address record for 192.168.1.197 on wlan0.IPv4. Oct 28 15:19:34 smsl-n100 dhcpcd[970]: wlan0: adding default route via 192.168.1.1 Oct 28 15:19:34 smsl-n100 ntpd[969]: ntpd exiting on signal 15 (Terminated) Oct 28 15:19:34 smsl-n100 systemd[1]: Stopping Network Time Service... Oct 28 15:19:34 smsl-n100 systemd[1]: ntp.service: Succeeded. Oct 28 15:19:34 smsl-n100 systemd[1]: Stopped Network Time Service. Oct 28 15:19:34 smsl-n100 volumio[981]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 28 15:19:34 smsl-n100 systemd[1]: Starting Network Time Service... Oct 28 15:19:34 smsl-n100 volumio[981]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 28 15:19:34 smsl-n100 volumio[981]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 28 15:19:34 smsl-n100 ntpd[1882]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 28 15:19:34 smsl-n100 ntpd[1882]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 28 15:19:34 smsl-n100 systemd[1]: Started Network Time Service. Oct 28 15:19:34 smsl-n100 ntpd[1888]: proto: precision = 1.166 usec (-20) Oct 28 15:19:34 smsl-n100 ntpd[1888]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 28 15:19:34 smsl-n100 ntpd[1888]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 28 15:19:34 smsl-n100 ntpd[1888]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1036 days ago Oct 28 15:19:34 smsl-n100 ntpd[1888]: Listen and drop on 0 v6wildcard [::]:123 Oct 28 15:19:34 smsl-n100 ntpd[1888]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 28 15:19:34 smsl-n100 ntpd[1888]: Listen normally on 2 lo 127.0.0.1:123 Oct 28 15:19:34 smsl-n100 ntpd[1888]: Listen normally on 3 wlan0 192.168.1.197:123 Oct 28 15:19:34 smsl-n100 ntpd[1888]: Listening on routing socket on fd #20 for interface updates Oct 28 15:19:34 smsl-n100 ntpd[1888]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 28 15:19:34 smsl-n100 ntpd[1888]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 28 15:19:34 smsl-n100 volumio[981]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Oct 28 15:19:34 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:34 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:34 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioPause Oct 28 15:19:34 smsl-n100 volumio[981]: info: CoreStateMachine::pause Oct 28 15:19:34 smsl-n100 volumio[981]: info: CoreStateMachine::stPlaybackTimer Oct 28 15:19:34 smsl-n100 volumio[981]: info: CoreStateMachine::servicePause Oct 28 15:19:34 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:34 smsl-n100 volumio[981]: info: CoreCommandRouter::servicePause Oct 28 15:19:34 smsl-n100 volumio[981]: info: ControllerMpd::pause Oct 28 15:19:34 smsl-n100 volumio[981]: verbose: ControllerMpd::sendMpdCommand pause Oct 28 15:19:34 smsl-n100 volumio[981]: info: Discovery: adding 6968bc61-3bdd-4c38-92e9-08fbfdc5186d Oct 28 15:19:34 smsl-n100 volumio[981]: info: Discovery: Found device SMSL N100 Oct 28 15:19:34 smsl-n100 volumio[981]: info: CoreCommandRouter::volumioGetState Oct 28 15:19:34 smsl-n100 volumio[981]: info: CorePlayQueue::getTrack 7 Oct 28 15:19:34 smsl-n100 volumio[981]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 15:19:34 smsl-n100 volumio[981]: Error: The value NaN is not a number Oct 28 15:19:34 smsl-n100 volumio[981]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Oct 28 15:19:34 smsl-n100 volumio[981]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Oct 28 15:19:34 smsl-n100 volumio[981]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Oct 28 15:19:34 smsl-n100 volumio[981]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Oct 28 15:19:34 smsl-n100 volumio[981]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Oct 28 15:19:34 smsl-n100 volumio[981]: at Browser.emit (events.js:400:28) Oct 28 15:19:34 smsl-n100 volumio[981]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Oct 28 15:19:34 smsl-n100 volumio[981]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Oct 28 15:19:34 smsl-n100 volumio[981]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Oct 28 15:19:34 smsl-n100 volumio[981]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Oct 28 15:19:34 smsl-n100 volumio[981]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Oct 28 15:19:34 smsl-n100 volumio[981]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Oct 28 15:19:34 smsl-n100 volumio[981]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Oct 28 15:19:34 smsl-n100 volumio[981]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 15:19:35 smsl-n100 ntpd[1888]: Soliciting pool server 210.28.130.4 Oct 28 15:19:35 smsl-n100 sudo[1899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-28 15:18 Oct 28 15:19:35 smsl-n100 sudo[1899]: 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="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"