-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2025-06-01 19:38:50 CST. -- Jun 01 19:37:16 volumio systemd-timedated[1088]: Changed local time to Sun Jun 1 19:37:16 2025 Jun 01 19:37:16 volumio sudo[1086]: pam_unix(sudo:session): session closed for user root Jun 01 19:37:16 volumio volumio-time-update[586]: volumio-time-update-util: System time updated successfully. Jun 01 19:37:16 volumio systemd[1]: Started Volumio Time Update Utility. Jun 01 19:37:16 volumio systemd[1]: Reached target Multi-User System. Jun 01 19:37:16 volumio systemd[1]: Reached target Graphical Interface. Jun 01 19:37:16 volumio kernel: cryptd: max_cpu_qlen set to 1000 Jun 01 19:37:16 volumio sudo[1090]: pam_unix(sudo:session): session closed for user root Jun 01 19:37:16 volumio kernel: CIFS: Attempting to mount //192.168.2.21/music Jun 01 19:37:16 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 01 19:37:16 volumio sudo[1092]: pam_unix(sudo:session): session closed for user root Jun 01 19:37:16 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 01 19:37:16 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 01 19:37:16 volumio systemd[1]: Startup finished in 12.258s (kernel) + 16.682s (userspace) = 28.940s. Jun 01 19:37:17 volumio volumio[783]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 01 19:37:19 volumio volumio[783]: info: Volumio Network Manager: Network status updated: 1 Jun 01 19:37:19 volumio sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 01 19:37:19 volumio sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 19:37:19 volumio sudo[1146]: pam_unix(sudo:session): session closed for user root Jun 01 19:37:19 volumio sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 01 19:37:19 volumio sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 19:37:19 volumio sudo[1148]: pam_unix(sudo:session): session closed for user root Jun 01 19:37:19 volumio sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 01 19:37:19 volumio sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 19:37:19 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 01 19:37:19 volumio sudo[1153]: pam_unix(sudo:session): session closed for user root Jun 01 19:37:19 volumio volumio[783]: info: Upmpdcli Daemon Started Jun 01 19:37:19 volumio volumio[1156]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 01 19:37:21 volumio volumio[783]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.812&uuid=d912844f528155b73a744cfe9061903a" http://updates.volumio.org/downloader-v1/track-device Jun 01 19:37:21 volumio volumio[783]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 01 19:37:21 volumio volumio[783]: Dload Upload Total Spent Left Speed Jun 01 19:37:21 volumio volumio[783]: [132B blob data] Jun 01 19:37:21 volumio volumio[783]: retrying in 5 seconds, trial 0 Jun 01 19:37:21 volumio volumio[783]: info: Volumio Calling Home Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 01 19:37:21 volumio volumio[783]: info: Adding plugin bluetooth to MyMusic Plugins Jun 01 19:37:21 volumio volumio[783]: info: Adding plugin multiroom to MyMusic Plugins Jun 01 19:37:21 volumio volumio[783]: info: Adding plugin metavolumio to MyMusic Plugins Jun 01 19:37:21 volumio volumio[783]: info: Adding plugin cd_controller to MyMusic Plugins Jun 01 19:37:21 volumio volumio[783]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 01 19:37:21 volumio volumio[783]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 01 19:37:21 volumio volumio[783]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 01 19:37:21 volumio volumio[783]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 01 19:37:22 volumio volumio[783]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 01 19:37:22 volumio volumio[783]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 01 19:37:22 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:37:22 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:37:22 volumio volumio[783]: info: Starting MyVolumio Remote Streaming Endpoints Jun 01 19:37:22 volumio volumio[783]: info: MyVolumio not started Jun 01 19:37:22 volumio volumio[783]: info: Initializing device activation check Jun 01 19:37:22 volumio volumio[783]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 01 19:37:22 volumio volumio[783]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 01 19:37:23 volumio volumio[1156]: ..........................................++++ Jun 01 19:37:23 volumio volumio[783]: info: Starting Streaming Service Transparent Proxy Jun 01 19:37:23 volumio volumio[783]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 01 19:37:23 volumio volumio[783]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 01 19:37:23 volumio volumio[783]: info: Streaming services startup Jun 01 19:37:23 volumio volumio[783]: info: Starting Streaming Daemon Jun 01 19:37:23 volumio sudo[1182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 01 19:37:23 volumio sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 01 19:37:23 volumio volumio[783]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 01 19:37:23 volumio sudo[1182]: pam_unix(sudo:session): session closed for user root Jun 01 19:37:23 volumio volumio[783]: error: Cannot start Volumio Streaming Daemon Jun 01 19:37:23 volumio volumio[783]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 01 19:37:23 volumio volumio[783]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 01 19:37:24 volumio volumio[783]: STREAMING PROXY: Starting server on port 3245 Jun 01 19:37:24 volumio volumio[783]: Node JS runtime: 14 Jun 01 19:37:24 volumio volumio[783]: info: Volumio called home Jun 01 19:37:25 volumio volumio[1156]: ........................++++ Jun 01 19:37:25 volumio volumio[1156]: e is 65537 (0x010001) Jun 01 19:37:25 volumio volumio[1156]: writing RSA key Jun 01 19:37:32 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jun 01 19:37:34 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jun 01 19:37:37 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 19:37:37 volumio volumio[783]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 01 19:37:37 volumio volumio[783]: info: CoreCommandRouter::volumioGetState Jun 01 19:37:37 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:37:41 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 19:37:41 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:37:41 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 19:37:41 volumio volumio-remote-updater[575]: No test mode Jun 01 19:37:41 volumio volumio-remote-updater[575]: No alpha test mode Jun 01 19:37:41 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::volumioGetBrowseSources Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 19:37:42 volumio volumio[783]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 01 19:37:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 01 19:37:43 volumio volumio[783]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jun 01 19:37:43 volumio volumio[783]: info: Completed starting MyVolumio Plugin Jun 01 19:37:43 volumio volumio[783]: [Metrics] CommandRouter: 36s 435.26ms Jun 01 19:37:43 volumio volumio[783]: info: CoreCommandRouter::volumiosetStartupVolume Jun 01 19:37:43 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:37:43 volumio volumio[783]: info: VolumeController:: Setting startup Volume 100 Jun 01 19:37:43 volumio volumio[783]: info: VolumeController::SetAlsaVolume100 Jun 01 19:37:43 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:37:43 volumio volumio[783]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:37:43 volumio volumio[783]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:37:43 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jun 01 19:37:43 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Jun 01 19:37:43 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jun 01 19:37:43 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:37:43 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:37:43 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:37:43 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:37:43 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jun 01 19:37:44 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 01 19:37:44 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 01 19:37:44 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 01 19:37:46 volumio systemd[1]: systemd-timedated.service: Succeeded. Jun 01 19:37:48 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jun 01 19:37:50 volumio volumio[783]: info: BOOT COMPLETED Jun 01 19:37:53 volumio volumio[783]: verbose: New Socket.io Connection to 192.168.2.76 from 192.168.2.163 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 4 Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::volumioGetVisibleSources Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::volumioGetState Jun 01 19:37:53 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 01 19:37:53 volumio volumio[783]: info: Received Get System Info Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 19:37:53 volumio volumio[783]: info: Discovery: Getting this device information Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::volumioGetState Jun 01 19:37:53 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::volumioGetState Jun 01 19:37:53 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:37:53 volumio volumio[783]: info: Listing playlists Jun 01 19:37:53 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 01 19:37:54 volumio volumio[783]: verbose: New Socket.io Connection to 192.168.2.76 from 192.168.2.163 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 5 Jun 01 19:37:54 volumio volumio[783]: info: CoreCommandRouter::volumioGetState Jun 01 19:37:54 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:37:54 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 19:37:54 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 19:37:54 volumio volumio[783]: info: CoreCommandRouter::volumioGetQueue Jun 01 19:37:54 volumio volumio[783]: info: CoreStateMachine::getQueue Jun 01 19:37:54 volumio volumio[783]: info: CorePlayQueue::getQueue Jun 01 19:37:56 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 19:37:56 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 19:37:56 volumio volumio[783]: info: Discovery: Getting this device information Jun 01 19:37:56 volumio volumio[783]: info: CoreCommandRouter::volumioGetState Jun 01 19:37:56 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:37:56 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 19:38:04 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 01 19:38:04 volumio volumio[783]: info: CURURI: music-library Jun 01 19:38:04 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:05 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 01 19:38:05 volumio volumio[783]: info: CURURI: music-library/NAS Jun 01 19:38:06 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:08 volumio ntpd[758]: Soliciting pool server 193.182.111.14 Jun 01 19:38:09 volumio ntpd[758]: Soliciting pool server 202.118.1.81 Jun 01 19:38:09 volumio ntpd[758]: Soliciting pool server 193.182.111.141 Jun 01 19:38:10 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 01 19:38:10 volumio volumio[783]: info: CURURI: music-library/NAS/share Jun 01 19:38:10 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:10 volumio ntpd[758]: Soliciting pool server 211.68.71.26 Jun 01 19:38:10 volumio ntpd[758]: Soliciting pool server 211.68.71.26 Jun 01 19:38:11 volumio ntpd[758]: Soliciting pool server 162.159.200.123 Jun 01 19:38:11 volumio ntpd[758]: Soliciting pool server 193.182.111.143 Jun 01 19:38:12 volumio ntpd[758]: Soliciting pool server 193.182.111.142 Jun 01 19:38:13 volumio ntpd[758]: Soliciting pool server 193.182.111.142 Jun 01 19:38:14 volumio ntpd[758]: Soliciting pool server 202.118.1.130 Jun 01 19:38:15 volumio ntpd[758]: Soliciting pool server 45.76.221.157 Jun 01 19:38:18 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 01 19:38:18 volumio volumio[783]: info: CURURI: music-library/NAS/tt Jun 01 19:38:18 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:18 volumio volumio[783]: info: Preloading song: music-library/NAS/tt/08.再吻我吧.wav Jun 01 19:38:18 volumio volumio[783]: info: Exploding uri music-library/NAS/tt/08.再吻我吧.wav in service mpd Jun 01 19:38:18 volumio ntpd[758]: receive: Unexpected origin timestamp 0xebe6ba28.f2dbd833 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xebe6ba2a.2dc57360 Jun 01 19:38:18 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FNAS%2Ftt%2F08.%E5%86%8D%E5%90%BB%E6%88%91%E5%90%A7.wav&metadata=false Jun 01 19:38:18 volumio volumio[783]: info: URI /mnt/NAS/tt/08.再吻我吧.wav Jun 01 19:38:18 volumio ntpd[758]: receive: Unexpected origin timestamp 0xebe6ba28.f2d57a31 does not match aorg 0000000000.00000000 from server@193.182.111.143 xmt 0xebe6ba2a.385a1f27 Jun 01 19:38:20 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 01 19:38:20 volumio volumio[783]: info: CURURI: music-library/NAS/tt/netgear_downloader Jun 01 19:38:20 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:20 volumio volumio[783]: info: Preloading song: music-library/NAS/tt/netgear_downloader/杜德伟 - 只想留下(华星金碟).wav Jun 01 19:38:21 volumio volumio[783]: info: Exploding uri music-library/NAS/tt/netgear_downloader/杜德伟 - 只想留下(华星金碟).wav in service mpd Jun 01 19:38:21 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=//extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2F%E6%9D%9C%E5%BE%B7%E4%BC%9F%20-%20%E5%8F%AA%E6%83%B3%E7%95%99%E4%B8%8B(%E5%8D%8E%E6%98%9F%E9%87%91%E7%A2%9F).wav&metadata=false Jun 01 19:38:21 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/杜德伟 - 只想留下(华星金碟).wav Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand update Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: info: Jun 01 19:38:28 volumio volumio[783]: ---------------------------- MPD announces state update: update Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand update took 8 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: info: Jun 01 19:38:28 volumio volumio[783]: ---------------------------- MPD announces state update: update Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: info: Jun 01 19:38:28 volumio volumio[783]: ---------------------------- MPD announces state update: update Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 17 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 12 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 11 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 9 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 8 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 6 milliseconds Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: info: Command Router : Notfying DB Updatetrue Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: info: Command Router : Notfying DB Updatetrue Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: info: Command Router : Notfying DB Updatetrue Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:38:28 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::syncState stateService stop Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: No code Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:38:28 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::syncState stateService stop Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: No code Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:38:28 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::syncState stateService stop Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: No code Jun 01 19:38:28 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:28 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:28 volumio volumio[783]: info: ------------------------------ 220ms Jun 01 19:38:28 volumio volumio[783]: info: ------------------------------ 215ms Jun 01 19:38:28 volumio volumio[783]: info: ------------------------------ 212ms Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: info: Jun 01 19:38:28 volumio volumio[783]: ---------------------------- MPD announces state update: update Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: info: Jun 01 19:38:28 volumio volumio[783]: ---------------------------- MPD announces state update: update Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: info: Jun 01 19:38:28 volumio volumio[783]: ---------------------------- MPD announces state update: update Jun 01 19:38:28 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 20 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 18 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 7 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 7 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 6 milliseconds Jun 01 19:38:28 volumio volumio[783]: info: sendMpdCommand status took 5 milliseconds Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: info: Command Router : Notfying DB Updatefalse Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: info: Command Router : Notfying DB Updatefalse Jun 01 19:38:28 volumio volumio[783]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:28 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:29 volumio volumio[783]: info: Command Router : Notfying DB Updatefalse Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:38:29 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:29 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:38:29 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::syncState stateService stop Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: No code Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:38:29 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::syncState stateService stop Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: No code Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:38:29 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::syncState stateService stop Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: No code Jun 01 19:38:29 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:29 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:29 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:29 volumio volumio[783]: info: ------------------------------ 147ms Jun 01 19:38:29 volumio volumio[783]: info: ------------------------------ 136ms Jun 01 19:38:29 volumio volumio[783]: info: ------------------------------ 135ms Jun 01 19:38:30 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 01 19:38:30 volumio volumio[783]: info: CURURI: music-library/NAS/tt/netgear_downloader/Secret Garden Jun 01 19:38:30 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:34 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::ClearQueue Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::stop Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::clearPlayQueue Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::saveQueue Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushQueue Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::addQueueItems Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::addQueueItems Jun 01 19:38:34 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:34 volumio volumio[783]: info: Adding Item to queue: music-library/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem Jun 01 19:38:34 volumio volumio[783]: info: Exploding uri music-library/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem in service mpd Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F01.%20Secret%20Garden%20-%20Make%20A%20Wish.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F02.%20Secret%20Garden%20-%20Song%20for%20a%20New%20Beginning.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/02. Secret Garden - Song for a New Beginning.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F03.%20Secret%20Garden%20-%20The%20Dream.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/03. Secret Garden - The Dream.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F04.%20Secret%20Garden%20-%20Frozen%20Time.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/04. Secret Garden - Frozen Time.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F05.%20Secret%20Garden%20-%20Anticipation.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/05. Secret Garden - Anticipation.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F06.%20Secret%20Garden%20-%20Fionnuala's%20Cookie%20Jar.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/06. Secret Garden - Fionnuala's Cookie Jar.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F07.%20Secret%20Garden%20-%20Mary's%20Lament.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/07. Secret Garden - Mary's Lament.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F08.%20Secret%20Garden%20-%20Song%20at%20the%20End%20of%20the%20Day.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/08. Secret Garden - Song at the End of the Day.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F09.%20Secret%20Garden%20-%20Lament%20for%20a%20Frozen%20Flower.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/09. Secret Garden - Lament for a Frozen Flower.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F10.%20Secret%20Garden%20-%20Powered%20By%20Nature.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/10. Secret Garden - Powered By Nature.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F11.%20Secret%20Garden%20-%20Suite_%20Prelude-Intermezzo-Polka-Air-Hymn.flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/11. Secret Garden - Suite_ Prelude-Intermezzo-Polka-Air-Hymn.flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F12.%20Secret%20Garden%20-%20Nocturne%20(Bonus%20Track).flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/12. Secret Garden - Nocturne (Bonus Track).flac Jun 01 19:38:34 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem%2F13.%20Secret%20Garden%20-%20You%20Raise%20Me%20Up%20(Bonus%20Track).flac&metadata=false Jun 01 19:38:34 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/13. Secret Garden - You Raise Me Up (Bonus Track).flac Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushQueue Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::saveQueue Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::updateTrackBlock Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrackBlock Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPlay Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::play index 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::stop Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::play index undefined Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::startPlaybackTimer Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::clearAddPlayTracks NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand stop Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand stop took 3 milliseconds Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand clear Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:34 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand clear took 7 milliseconds Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand add "NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac" Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:34 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:34 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:34 volumio volumio[783]: error: updateQueue error: null Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:34 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 11ms Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand add "NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac" took 9 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 6ms Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand play Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:34 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:34 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:34 volumio volumio[783]: error: Upnp client error: Error: This socket has been ended by the other party Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 12ms Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 9ms Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand play took 7 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 6ms Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 5ms Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand status took 38 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:34 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand status took 41 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand status took 39 milliseconds Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:34 volumio volumio[783]: info: Jun 01 19:38:34 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand status took 17 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand playlistinfo took 13 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand status took 13 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand status took 12 milliseconds Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"467 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:34 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"467 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:34 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:34 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"467 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:34 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:34 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 91ms Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 104ms Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 103ms Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand playlistinfo took 47 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand playlistinfo took 44 milliseconds Jun 01 19:38:34 volumio volumio[783]: info: sendMpdCommand playlistinfo took 45 milliseconds Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:34 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"496 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:34 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:34 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"633 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:34 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:34 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"633 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:34 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:34 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:34 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:34 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 112ms Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 105ms Jun 01 19:38:34 volumio volumio[783]: info: ------------------------------ 103ms Jun 01 19:38:34 volumio volumio[783]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Secret%20Garden/Winter%20Poem/71470b3e-35de-451d-a8e3-f320266c9df9.jpg' Jun 01 19:38:34 volumio volumio[783]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Secret%20Garden/Winter%20Poem/71470b3e-35de-451d-a8e3-f320266c9df9.jpg' Jun 01 19:38:34 volumio volumio[783]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Secret%20Garden/Winter%20Poem/71470b3e-35de-451d-a8e3-f320266c9df9.jpg' Jun 01 19:38:34 volumio volumio[783]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Secret%20Garden/Winter%20Poem/71470b3e-35de-451d-a8e3-f320266c9df9.jpg' Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::volumioSeek Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::seek Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: TRACKBLOCK {"uri":"mnt/NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","service":"mpd","name":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=487&web=Secret%20Garden/Winter%20Poem/extralarge&path=%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2011%20-%20Winter%20Poem&metadata=false","duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::startPlaybackTimer Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: ControllerMpd::seek Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:42 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jun 01 19:38:42 volumio volumio[783]: error: null Jun 01 19:38:42 volumio volumio[783]: info: Jun 01 19:38:42 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:42 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:42 volumio volumio[783]: info: Jun 01 19:38:42 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:42 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:42 volumio volumio[783]: info: Jun 01 19:38:42 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:42 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:42 volumio volumio[783]: info: sendMpdCommand status took 9 milliseconds Jun 01 19:38:42 volumio volumio[783]: info: sendMpdCommand status took 12 milliseconds Jun 01 19:38:42 volumio volumio[783]: info: sendMpdCommand status took 11 milliseconds Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:42 volumio volumio[783]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 01 19:38:42 volumio volumio[783]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 01 19:38:42 volumio volumio[783]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:42 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:42 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":76869,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"731 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:42 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:42 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:42 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":76869,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"751 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:42 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:42 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:42 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":76869,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"751 Kbps","isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:42 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:42 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:42 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:42 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:42 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:42 volumio volumio[783]: info: ------------------------------ 97ms Jun 01 19:38:42 volumio volumio[783]: info: ------------------------------ 95ms Jun 01 19:38:42 volumio volumio[783]: info: ------------------------------ 93ms Jun 01 19:38:49 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::ClearQueue Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::stop Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::stPlaybackTimer Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::updateTrackBlock Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrackBlock Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::serviceStop Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::serviceStop Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::stop Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand stop Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::clearPlayQueue Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::saveQueue Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushQueue Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::addQueueItems Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::addQueueItems Jun 01 19:38:49 volumio volumio[783]: info: Preload queue cleared Jun 01 19:38:49 volumio volumio[783]: info: Adding Item to queue: music-library/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs Jun 01 19:38:49 volumio volumio[783]: info: Exploding uri music-library/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs in service mpd Jun 01 19:38:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand stop took 28 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F01.%20Secret%20Garden%20-%20Sometimes%20When%20It%20Rains.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F02.%20Secret%20Garden%20-%20Fields%20of%20Fortune.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/02. Secret Garden - Fields of Fortune.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F03.%20Secret%20Garden%20-%20The%20Reel.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/03. Secret Garden - The Reel.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F04.%20Secret%20Garden%20-%20Always%20There.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/04. Secret Garden - Always There.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F05.%20Secret%20Garden%20-%20When%20Darkness%20Falls.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/05. Secret Garden - When Darkness Falls.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F06.%20Secret%20Garden%20-%20Sleepsong.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/06. Secret Garden - Sleepsong.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F07.%20Secret%20Garden%20-%20Lotus.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/07. Secret Garden - Lotus.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F08.%20Secret%20Garden%20-%20Searching%20for%20the%20Past.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/08. Secret Garden - Searching for the Past.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F09.%20Secret%20Garden%20-%20Daughters%20of%20Erin.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/09. Secret Garden - Daughters of Erin.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F10.%20Secret%20Garden%20-%20Half%20a%20World%20Away.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/10. Secret Garden - Half a World Away.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F11.%20Secret%20Garden%20-%20Grace.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/11. Secret Garden - Grace.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F12.%20Secret%20Garden%20-%20Raise%20Your%20Voices.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/12. Secret Garden - Raise Your Voices.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F13.%20Secret%20Garden%20-%20Silence%20Speaks.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/13. Secret Garden - Silence Speaks.flac Jun 01 19:38:49 volumio volumio[783]: info: ALBUMART /albumart?cacheid=487&web=Secret%20Garden/Earthsongs/extralarge&path=%2Fmnt%2FNAS%2Ftt%2Fnetgear_downloader%2FSecret%20Garden%2F2005%20-%20Earthsongs%2F14.%20Secret%20Garden%20-%20Canzona.flac&metadata=false Jun 01 19:38:49 volumio volumio[783]: info: URI /mnt/NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/14. Secret Garden - Canzona.flac Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushQueue Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::saveQueue Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::updateTrackBlock Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrackBlock Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPlay Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::play index 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::stop Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::play index undefined Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::startPlaybackTimer Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::clearAddPlayTracks NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand stop Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 20 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand stop took 6 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 4 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 4 milliseconds Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand clear Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:49 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand clear took 5 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand add "NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac" Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Make A Wish","artist":"Secret Garden","album":"Winter Poem","uri":"NAS/tt/netgear_downloader/Secret Garden/2011 - Winter Poem/01. Secret Garden - Make A Wish.flac","trackType":"flac"} Jun 01 19:38:49 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState stateService stop Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: No code Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 01 19:38:49 volumio volumio[783]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 68ms Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 42ms Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 41ms Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:49 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:49 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:49 volumio volumio[783]: error: updateQueue error: null Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:49 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 40ms Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand add "NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac" took 37 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 8ms Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 8ms Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand play Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:49 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces system playlist update Jun 01 19:38:49 volumio volumio[783]: info: Ignoring MPD Status Update Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 15ms Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand play took 12 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 11ms Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 78 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 78 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 76 milliseconds Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio volumio[783]: info: Jun 01 19:38:49 volumio volumio[783]: ---------------------------- MPD announces state update: player Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::getState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 6 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 4 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand status took 2 milliseconds Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseState Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":278,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"177 Kbps","isStreaming":false,"title":"Sometimes When It Rains","artist":"Secret Garden","album":"Earthsongs","uri":"NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac","trackType":"flac"} Jun 01 19:38:49 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":278,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"338 Kbps","isStreaming":false,"title":"Sometimes When It Rains","artist":"Secret Garden","album":"Earthsongs","uri":"NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac","trackType":"flac"} Jun 01 19:38:49 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:49 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":278,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"338 Kbps","isStreaming":false,"title":"Sometimes When It Rains","artist":"Secret Garden","album":"Earthsongs","uri":"NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac","trackType":"flac"} Jun 01 19:38:49 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:49 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 101ms Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 113ms Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 111ms Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 29 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 29 milliseconds Jun 01 19:38:49 volumio volumio[783]: info: sendMpdCommand playlistinfo took 28 milliseconds Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: verbose: ControllerMpd::parseTrackInfo Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":278,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"413 Kbps","isStreaming":false,"title":"Sometimes When It Rains","artist":"Secret Garden","album":"Earthsongs","uri":"NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac","trackType":"flac"} Jun 01 19:38:49 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:49 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":278,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"413 Kbps","isStreaming":false,"title":"Sometimes When It Rains","artist":"Secret Garden","album":"Earthsongs","uri":"NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac","trackType":"flac"} Jun 01 19:38:49 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:49 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: ControllerMpd::pushState Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::servicePushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":278,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"413 Kbps","isStreaming":false,"title":"Sometimes When It Rains","artist":"Secret Garden","album":"Earthsongs","uri":"NAS/tt/netgear_downloader/Secret Garden/2005 - Earthsongs/01. Secret Garden - Sometimes When It Rains.flac","trackType":"flac"} Jun 01 19:38:49 volumio volumio[783]: verbose: CURRENT POSITION 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState stateService play Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::syncState currentStatus play Jun 01 19:38:49 volumio volumio[783]: info: Received an update from plugin. extracting info from payload Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: CoreStateMachine::pushState Jun 01 19:38:49 volumio volumio[783]: info: CorePlayQueue::getTrack 0 Jun 01 19:38:49 volumio volumio[783]: info: CoreCommandRouter::volumioPushState Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 75ms Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 71ms Jun 01 19:38:49 volumio volumio[783]: info: ------------------------------ 71ms Jun 01 19:38:49 volumio volumio[783]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 19:38:49 volumio volumio[783]: Error: connect ECONNREFUSED 31.13.69.245:443 Jun 01 19:38:49 volumio volumio[783]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jun 01 19:38:49 volumio volumio[783]: errno: -111, Jun 01 19:38:49 volumio volumio[783]: code: 'ECONNREFUSED', Jun 01 19:38:49 volumio volumio[783]: syscall: 'connect', Jun 01 19:38:49 volumio volumio[783]: address: '31.13.69.245', Jun 01 19:38:49 volumio volumio[783]: port: 443 Jun 01 19:38:49 volumio volumio[783]: } Jun 01 19:38:49 volumio volumio[783]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 19:38:50 volumio sudo[1441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-01 19:37 Jun 01 19:38:50 volumio sudo[1441]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"