Dec 20 21:18:00 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:00 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:00 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:01 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:01 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:01 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:01 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:02 purenrgtransfer systemd[1]: systemd-fsckd.service: Deactivated successfully. Dec 20 21:18:02 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:02 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:02 purenrgtransfer kernel: applesmc applesmc.768: probe with driver applesmc failed with error -5 Dec 20 21:18:02 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:03 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:03 purenrgtransfer systemd[1]: systemd-hostnamed.service: Deactivated successfully. Dec 20 21:18:03 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:03 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:04 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:04 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:04 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:04 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:05 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:05 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:05 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:06 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:06 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:06 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:07 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:07 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:07 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:08 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:08 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:08 purenrgtransfer systemd-journald[610]: Suppressed 20941 messages from volumio.service Dec 20 21:18:08 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 21:18:08 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:08 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 21:18:08 purenrgtransfer volumio[1105]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Dec 20 21:18:08 purenrgtransfer volumio[1105]: info: ------------------------------------------- Dec 20 21:18:08 purenrgtransfer volumio[1105]: info: ----- MyVolumio plugins startup ---- Dec 20 21:18:08 purenrgtransfer volumio[1105]: info: ------------------------------------------- Dec 20 21:18:08 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 20 21:18:08 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:09 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:09 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:09 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:09 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:10 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:10 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:10 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:11 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:11 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:11 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:11 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:12 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:12 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:12 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:13 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:13 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:13 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:14 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:14 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:14 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:14 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:15 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:15 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:15 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:16 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:16 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:16 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:16 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Adding plugin bluetooth to MyMusic Plugins Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Adding plugin multiroom to MyMusic Plugins Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Adding plugin metavolumio to MyMusic Plugins Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Adding plugin cd_controller to MyMusic Plugins Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 20 21:18:17 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Starting MyVolumio Remote Streaming Endpoints Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: MyVolumio login type: Token Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 20 21:18:17 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Streaming services startup Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: Starting Streaming Daemon Dec 20 21:18:17 purenrgtransfer sudo[2032]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 20 21:18:17 purenrgtransfer sudo[2032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:17 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 20 21:18:17 purenrgtransfer sudo[2032]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:17 purenrgtransfer volumio[1105]: error: Cannot start Volumio Streaming Daemon Dec 20 21:18:17 purenrgtransfer volumio[1105]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 20 21:18:17 purenrgtransfer volumio[1105]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 20 21:18:17 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 20 21:18:18 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:18 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: MyVolumio token set successfully Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: MYVOLUMIO: Adding device Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: MYVOLUMIO: Evaluating Server Dec 20 21:18:18 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: MyVolumio Plan changed: premium Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: Removing browser output: myVolumio user plan is not superstar Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: Removing audio output: Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: MYVOLUMIO: Adding device Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: MYVOLUMIO: Evaluating Server Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: Remote config written successfully Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: Starting Tunnel 1 Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: Starting Tunnel Connection Checker Dec 20 21:18:18 purenrgtransfer volumio[1105]: info: Completed starting MyVolumio Plugin Dec 20 21:18:19 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MYVolumio Device enabled Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MyVolumio status changed Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Streaming services startup Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Starting Streaming Daemon Dec 20 21:18:19 purenrgtransfer sudo[2079]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 20 21:18:19 purenrgtransfer sudo[2079]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Dec 20 21:18:19 purenrgtransfer sudo[2079]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:19 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Dec 20 21:18:19 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Dec 20 21:18:19 purenrgtransfer sudo[2084]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Dec 20 21:18:19 purenrgtransfer sudo[2084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer sudo[2084]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: MultiRoom plugin initialized Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: STOPPING SNAPCLIENT Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: Snap server stop Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: STOPPING volumioStreaming Dec 20 21:18:19 purenrgtransfer sudo[2101]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Dec 20 21:18:19 purenrgtransfer sudo[2101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer sudo[2103]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Dec 20 21:18:19 purenrgtransfer sudo[2103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Dec 20 21:18:19 purenrgtransfer sudo[2106]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Dec 20 21:18:19 purenrgtransfer sudo[2106]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer sudo[2109]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 20 21:18:19 purenrgtransfer sudo[2109]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer sudo[2109]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Dec 20 21:18:19 purenrgtransfer sudo[2101]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Dec 20 21:18:19 purenrgtransfer sudo[2103]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Dec 20 21:18:19 purenrgtransfer sudo[2106]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Preparing to generate the ALSA configuration file Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Reading ALSA contributions from plugins. Dec 20 21:18:19 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Setting Geolocation for MyVolumio to eu2 Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Setting Geolocation for MyVolumio to eu2 Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: Removed streaming files Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: volumioStreaming STOPPED Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: SNAPSERVER STOPPED Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: SNAPCLIENT STOPPED Dec 20 21:18:19 purenrgtransfer volumio[1105]: error: Cannot start Volumio Streaming Daemon Dec 20 21:18:19 purenrgtransfer volumio[1105]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 20 21:18:19 purenrgtransfer volumio[1105]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Asound.conf file written Dec 20 21:18:19 purenrgtransfer sudo[2115]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 20 21:18:19 purenrgtransfer sudo[2115]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer sudo[2115]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Output device has changed, restarting MPD Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Output device has changed, restarting Shairport Sync Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:19 purenrgtransfer sudo[2122]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 20 21:18:19 purenrgtransfer sudo[2122]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer sudo[2122]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:19 purenrgtransfer sudo[2124]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 20 21:18:19 purenrgtransfer sudo[2124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Dec 20 21:18:19 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [FUNC] onStart Dec 20 21:18:19 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Dec 20 21:18:19 purenrgtransfer systemd[1]: mpd.socket: Deactivated successfully. Dec 20 21:18:19 purenrgtransfer systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 20 21:18:19 purenrgtransfer systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 20 21:18:19 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Dec 20 21:18:19 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [metaCache] Created directory: /tmp/bluetooth-cache/ Dec 20 21:18:19 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output for this device Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding audio output: Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding audio output: Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding METAVOLUMIO REST API Endpoints Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Preparing CD Folders Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding CD REST API Endpoints Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Starting UDEV Watcher for CD Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: Detecting CD presence with UDEV Dec 20 21:18:19 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Dec 20 21:18:19 purenrgtransfer bluetoothd[916]: Path / reserved for Adv Monitor app :1.18 Dec 20 21:18:19 purenrgtransfer bluetoothd[916]: Adv Monitor app :1.18 disconnected from D-Bus Dec 20 21:18:19 purenrgtransfer systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 20 21:18:19 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:20 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:20 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:20 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:21 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:21 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:21 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:22 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:22 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:22 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:22 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:23 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:23 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:23 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:24 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:24 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:24 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:24 purenrgtransfer volumio[1105]: warn: [cd-plugin] cdspeedctl: device or media not ready Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding inputs REST Endpoints Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Scanning Audio Inputs Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Checking against Known Cards name Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Checking against Known Cards name Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Checking against Known Cards name Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding Server instance for streaming Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Dec 20 21:18:24 purenrgtransfer volumio[1105]: error: Hi Res Audio Failed Login: Missing Login Data Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding HIGHRESAUDIO REST API Endpoints Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Dec 20 21:18:24 purenrgtransfer sudo[2151]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 20 21:18:24 purenrgtransfer sudo[2151]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: QobuzConnect: Starting Qobuz Connect socket and service Dec 20 21:18:24 purenrgtransfer sudo[2158]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 20 21:18:24 purenrgtransfer sudo[2158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding TIDAL REST API Endpoints Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Stopping AccessToken refresher cron for QOBUZ Dec 20 21:18:24 purenrgtransfer sudo[2151]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: AccessToken refresher cron started for QOBUZ Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding QOBUZ REST API Endpoints Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Updating MyVolumio device info Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Updating MyVolumio device info Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:24 purenrgtransfer sudo[2158]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: MRS: Getting audio outputs on start Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: MRS: Requesting all other devices output Dec 20 21:18:24 purenrgtransfer volumio[1105]: error: Upnp client error: Error: read ECONNRESET Dec 20 21:18:24 purenrgtransfer volumio[1105]: error: Upnp client error: Error: read ECONNRESET Dec 20 21:18:24 purenrgtransfer volumio[1105]: error: Upnp client error: Error: read ECONNRESET Dec 20 21:18:24 purenrgtransfer volumio[1105]: error: Upnp client error: Error: read ECONNRESET Dec 20 21:18:24 purenrgtransfer sudo[2161]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 20 21:18:24 purenrgtransfer sudo[2161]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Successfully Added MyVolumio device Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Successfully Added MyVolumio device Dec 20 21:18:24 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: MPD Permissions set Dec 20 21:18:24 purenrgtransfer sudo[2165]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Dec 20 21:18:24 purenrgtransfer sudo[2165]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:24 purenrgtransfer systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 20 21:18:24 purenrgtransfer sudo[2161]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Starting Shairport Sync Dec 20 21:18:24 purenrgtransfer sudo[2184]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 21:18:24 purenrgtransfer sudo[2184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:24 purenrgtransfer sudo[2186]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 20 21:18:24 purenrgtransfer sudo[2186]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:24 purenrgtransfer systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 20 21:18:24 purenrgtransfer systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 20 21:18:24 purenrgtransfer systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 20 21:18:24 purenrgtransfer sudo[2186]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Remote SSH Started Dec 20 21:18:24 purenrgtransfer autossh[2190]: port set to 0, monitoring disabled Dec 20 21:18:24 purenrgtransfer autossh[2190]: starting ssh (count 1) Dec 20 21:18:24 purenrgtransfer autossh[2190]: ssh child pid is 2193 Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: MRS: Found cast device: MOVE-OTT-Box-1-b9b0f168e24ae3cc8056e23104a874be Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding audio output: Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: MRS: Found cast device: MOVE-OTT-Box-1-4bacf51e819ca9574ad6c7a3ee6eb54f Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Adding audio output: Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: Executing endpoint qc_getconfig Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 20 21:18:24 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:24.978 [2163.2163] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 20 21:18:24 purenrgtransfer volumio[1105]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:24 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:25 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:25.005 [2163.2163] INFO VolumeManager: [0x5619cc91bff0]: Setting new playback volume: 75 Dec 20 21:18:25 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:25.005 [2163.2163] INFO VolumeManager: [0x5619cc91bff0]: Setting new mute state: 0 Dec 20 21:18:25 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:25.005 [2163.2163] INFO QobuzConnect: [0x5619cc91d210]: Client initialized! Dec 20 21:18:25 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:25.005 [2163.2163] INFO SampleApp: Starting Avahi advertising, name: PureNRGTransfer, service name: _qobuz-connect._tcp Dec 20 21:18:25 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:25.007 [2163.2163] INFO LocalConfigManager: [0x5619cc91b2e0]: Starting Local Configuration server Dec 20 21:18:25 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:25.007 [2163.2163] INFO SampleApp: Starting Local configuration server Dec 20 21:18:25 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:25.008 [2163.2163] INFO SampleApp: Connected to UNIX socket client 0x5619cc8f1bb0 Dec 20 21:18:25 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:25 purenrgtransfer volumiossh-tunnel[2193]: Warning: Permanently added '[eu2.myvolumio.org]:2222' (RSA) to the list of known hosts. Dec 20 21:18:25 purenrgtransfer volumio[1105]: info: Successfully Updated MyVolumio device Dec 20 21:18:25 purenrgtransfer qobuz-connect[2163]: 20251220 21:18:25.128 [2163.2163] INFO SampleApp: Playback volume changed: 75 Dec 20 21:18:25 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:25 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:25 purenrgtransfer volumio[1105]: info: Successfully Updated MyVolumio device Dec 20 21:18:25 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:25 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:25 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:26 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:26 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:26 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:27 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:27 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:27 purenrgtransfer volumio[1105]: info: TidalConnect service stoped! Dec 20 21:18:27 purenrgtransfer volumio[1105]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 20 21:18:27 purenrgtransfer volumio[1105]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 20 21:18:27 purenrgtransfer sudo[2225]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 20 21:18:27 purenrgtransfer sudo[2225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:27 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:27 purenrgtransfer systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 20 21:18:27 purenrgtransfer sudo[2225]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: Executing endpoint tc_getconfig Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 20 21:18:28 purenrgtransfer vtcs[2228]: STARTING TidalConnect services, version: 1.5.2.56 Dec 20 21:18:28 purenrgtransfer vtcs[2228]: STARTED TidalConnect services. Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: Executing endpoint tc_connect Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: Connecting to TidalConnect Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received tidalconnect Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:28 purenrgtransfer volumio[1105]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received tidalconnect Dec 20 21:18:28 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:28 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:28 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:28 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:28 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:29 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:29 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:29 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:29 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:30 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:30 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:30 purenrgtransfer volumio[1105]: info: TidalConnect service started! Dec 20 21:18:30 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:31 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:31 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:31 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:32 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:32 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 21:18:32 purenrgtransfer volumio[1105]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Dec 20 21:18:32 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:32 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:32 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:32 purenrgtransfer kernel: applesmc: #KEY: read data[0] fail Dec 20 21:18:32 purenrgtransfer systemd-udevd[635]: id: Worker [662] processing SEQNUM=3635 is taking a long time Dec 20 21:18:32 purenrgtransfer kernel: applesmc: driver init failed (ret=-5)! Dec 20 21:18:32 purenrgtransfer systemd[1]: Finished ifupdown-pre.service - Helper to synchronize boot up for ifupdown. Dec 20 21:18:32 purenrgtransfer systemd[1]: Starting networking.service - Raise network interfaces... Dec 20 21:18:33 purenrgtransfer systemd[1]: Finished networking.service - Raise network interfaces. Dec 20 21:18:33 purenrgtransfer systemd[1]: Reached target network.target - Network. Dec 20 21:18:33 purenrgtransfer systemd[1]: Reached target network-online.target - Network is Online. Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting mpd.service - Music Player Daemon... Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting ifplugd.service - LSB: Brings up/down network automatically... Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting nmbd.service - Samba NMB Daemon... Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting ntpsec.service - Network Time Service... Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting rc-local.service - /etc/rc.local Compatibility... Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting samba-ad-dc.service - Samba AD Daemon... Dec 20 21:18:33 purenrgtransfer sm-notify[2319]: Version 2.6.2 starting Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 20 21:18:33 purenrgtransfer systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 20 21:18:33 purenrgtransfer sudo[1817]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:33 purenrgtransfer sudo[1821]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:33 purenrgtransfer sudo[1819]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:33 purenrgtransfer volumio[1105]: info: Shairport-Sync Started Dec 20 21:18:33 purenrgtransfer sudo[2184]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:33 purenrgtransfer volumio[1105]: Error adding Membership: Error: addMembership EINVAL Dec 20 21:18:33 purenrgtransfer volumio[1105]: info: Shairport-Sync Started Dec 20 21:18:33 purenrgtransfer volumio[1105]: info: Shairport-Sync Started Dec 20 21:18:33 purenrgtransfer volumio[1105]: info: Shairport-Sync Started Dec 20 21:18:33 purenrgtransfer ntpd[2323]: INIT: ntpd ntpsec-1.2.2: Starting Dec 20 21:18:33 purenrgtransfer ntpd[2323]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Dec 20 21:18:33 purenrgtransfer ntp-systemd-wrapper[2323]: 2025-12-20T21:18:33 ntpd[2323]: INIT: ntpd ntpsec-1.2.2: Starting Dec 20 21:18:33 purenrgtransfer ntp-systemd-wrapper[2323]: 2025-12-20T21:18:33 ntpd[2323]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Dec 20 21:18:33 purenrgtransfer sudo[2341]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 20 21:18:33 purenrgtransfer ntpd[2331]: INIT: precision = 0.077 usec (-24) Dec 20 21:18:33 purenrgtransfer systemd[1]: Started volumio-ipchange.service - Volumio IP Change Monitor. Dec 20 21:18:33 purenrgtransfer sudo[2310]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 20 21:18:33 purenrgtransfer sudo[2310]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 20 21:18:33 purenrgtransfer ntpd[2331]: INIT: successfully locked into RAM Dec 20 21:18:33 purenrgtransfer sudo[2310]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:33 purenrgtransfer ntpd[2331]: CONFIG: readconfig: parsing file: /etc/ntpsec/ntp.conf Dec 20 21:18:33 purenrgtransfer welcome[2340]: Resolved ip:[1] 192.168.1.54 Dec 20 21:18:33 purenrgtransfer ntpd[2331]: CONFIG: restrict nopeer ignored Dec 20 21:18:33 purenrgtransfer ntpd[2331]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Dec 20 21:18:33 purenrgtransfer ntpd[2331]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2026-06-28T00:00Z last=2017-01-01T00:00Z ofs=37 Dec 20 21:18:33 purenrgtransfer ntpd[2331]: INIT: Using SO_TIMESTAMPNS(ns) Dec 20 21:18:33 purenrgtransfer ntpd[2331]: IO: Listen and drop on 0 v6wildcard [::]:123 Dec 20 21:18:33 purenrgtransfer ntpd[2331]: IO: Listen and drop on 1 v4wildcard 0.0.0.0:123 Dec 20 21:18:33 purenrgtransfer ntpd[2331]: IO: Listen normally on 2 lo 127.0.0.1:123 Dec 20 21:18:33 purenrgtransfer ntpd[2331]: IO: Listen normally on 3 eth0 192.168.1.54:123 Dec 20 21:18:33 purenrgtransfer ntpd[2331]: IO: Listening on routing socket on fd #20 for interface updates Dec 20 21:18:33 purenrgtransfer systemd[1]: Started ntpsec.service - Network Time Service. Dec 20 21:18:33 purenrgtransfer systemd[1]: Started rc-local.service - /etc/rc.local Compatibility. Dec 20 21:18:33 purenrgtransfer systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Dec 20 21:18:33 purenrgtransfer systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Dec 20 21:18:33 purenrgtransfer ntpd[2331]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Dec 20 21:18:33 purenrgtransfer ntpd[2331]: INIT: Built with OpenSSL 3.0.9 30 May 2023, 30000090 Dec 20 21:18:33 purenrgtransfer ntpd[2331]: INIT: Running with OpenSSL 3.0.17 1 Jul 2025, 30000110 Dec 20 21:18:33 purenrgtransfer ntpd[2331]: NTSc: Using system default root certificates. Dec 20 21:18:33 purenrgtransfer systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up... Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Dec 20 21:18:33 purenrgtransfer sshd[2355]: Server listening on 0.0.0.0 port 22. Dec 20 21:18:33 purenrgtransfer sshd[2355]: Server listening on :: port 22. Dec 20 21:18:33 purenrgtransfer systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Dec 20 21:18:33 purenrgtransfer systemd[1]: Received SIGRTMIN+21 from PID 469 (plymouthd). Dec 20 21:18:33 purenrgtransfer ifplugd[2311]: Network Interface Plugging Daemon... Dec 20 21:18:33 purenrgtransfer ifplugd[2375]: error: unexpectedly disconnected from boot status daemon Dec 20 21:18:33 purenrgtransfer systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Dec 20 21:18:33 purenrgtransfer systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Dec 20 21:18:33 purenrgtransfer systemd[1]: Received SIGRTMIN+21 from PID 469 (n/a). Dec 20 21:18:33 purenrgtransfer ifplugd(eth0)[2383]: ifplugd 0.28 initializing. Dec 20 21:18:33 purenrgtransfer ifplugd(eth0)[2383]: Using interface eth0/68:5B:35:AB:D2:66 with driver (version: 6.12.57-volumio) Dec 20 21:18:33 purenrgtransfer ifplugd(eth0)[2383]: Using detection mode: SIOCETHTOOL Dec 20 21:18:33 purenrgtransfer ifplugd(eth0)[2383]: Initialization complete, link beat detected. Dec 20 21:18:33 purenrgtransfer ntpd[2331]: statistics directory /var/log/ntpsec/ does not exist or is unwriteable, error No such file or directory Dec 20 21:18:33 purenrgtransfer systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 20 21:18:33 purenrgtransfer systemd[1]: Reached target getty.target - Login Prompts. Dec 20 21:18:33 purenrgtransfer ifplugd(eth0)[2383]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Dec 20 21:18:33 purenrgtransfer ifplugd(eth0)[2383]: client: ifup: interface eth0 already configured Dec 20 21:18:33 purenrgtransfer systemd[1]: samba-ad-dc.service: Skipped due to 'exec-condition'. Dec 20 21:18:33 purenrgtransfer systemd[1]: Condition check resulted in samba-ad-dc.service - Samba AD Daemon being skipped. Dec 20 21:18:33 purenrgtransfer ifplugd(eth0)[2383]: Program executed successfully. Dec 20 21:18:33 purenrgtransfer ifplugd[2311]: start eth0...done. Dec 20 21:18:33 purenrgtransfer systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. Dec 20 21:18:33 purenrgtransfer nmbd[2400]: [2025/12/20 21:18:33.429357, 0] ../../source3/nmbd/nmbd.c:901(main) Dec 20 21:18:33 purenrgtransfer nmbd[2400]: nmbd version 4.17.12-Debian started. Dec 20 21:18:33 purenrgtransfer nmbd[2400]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 20 21:18:33 purenrgtransfer nmbd[2400]: [2025/12/20 21:18:33.433005, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) Dec 20 21:18:33 purenrgtransfer nmbd[2400]: started asyncdns process 2402 Dec 20 21:18:33 purenrgtransfer systemd[1]: Started nmbd.service - Samba NMB Daemon. Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting winbind.service - Samba Winbind Daemon... Dec 20 21:18:33 purenrgtransfer systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 20 21:18:33 purenrgtransfer systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 20 21:18:33 purenrgtransfer winbindd[2410]: [2025/12/20 21:18:33.542721, 0] ../../source3/winbindd/winbindd.c:1440(main) Dec 20 21:18:33 purenrgtransfer winbindd[2410]: winbindd version 4.17.12-Debian started. Dec 20 21:18:33 purenrgtransfer winbindd[2410]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 20 21:18:33 purenrgtransfer winbindd[2410]: [2025/12/20 21:18:33.545720, 0] ../../source3/winbindd/winbindd_cache.c:3117(initialize_winbindd_cache) Dec 20 21:18:33 purenrgtransfer winbindd[2410]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 20 21:18:33 purenrgtransfer systemd[1]: Started winbind.service - Samba Winbind Daemon. Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting smbd.service - Samba SMB Daemon... Dec 20 21:18:33 purenrgtransfer smbd[2426]: [2025/12/20 21:18:33.710216, 0] ../../source3/smbd/server.c:1741(main) Dec 20 21:18:33 purenrgtransfer smbd[2426]: smbd version 4.17.12-Debian started. Dec 20 21:18:33 purenrgtransfer smbd[2426]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 20 21:18:33 purenrgtransfer systemd[1]: Started smbd.service - Samba SMB Daemon. Dec 20 21:18:33 purenrgtransfer mpd[2350]: 2025-12-20T21:18:33 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 20 21:18:33 purenrgtransfer systemd[1]: Started mpd.service - Music Player Daemon. Dec 20 21:18:33 purenrgtransfer sudo[1697]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:33 purenrgtransfer sudo[1708]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:33 purenrgtransfer sudo[2124]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:33 purenrgtransfer volumio[1105]: error: MPD error: The expression evaluated to a falsy value: Dec 20 21:18:33 purenrgtransfer volumio[1105]: assert.ok(self.idling) Dec 20 21:18:33 purenrgtransfer volumio[1105]: error: The expression evaluated to a falsy value: Dec 20 21:18:33 purenrgtransfer volumio[1105]: assert.ok(self.idling) Dec 20 21:18:33 purenrgtransfer volumio[1105]: error: MPD error: The expression evaluated to a falsy value: Dec 20 21:18:33 purenrgtransfer volumio[1105]: assert.ok(self.idling) Dec 20 21:18:33 purenrgtransfer volumio[1105]: error: The expression evaluated to a falsy value: Dec 20 21:18:33 purenrgtransfer volumio[1105]: assert.ok(self.idling) Dec 20 21:18:33 purenrgtransfer volumio[1105]: info: MPD running with PID2350 Dec 20 21:18:33 purenrgtransfer volumio[1105]: ,establishing connection Dec 20 21:18:33 purenrgtransfer volumio[1105]: error: updateQueue error: null Dec 20 21:18:33 purenrgtransfer volumio[1105]: error: updateQueue error: null Dec 20 21:18:33 purenrgtransfer systemd[1]: Starting musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Dec 20 21:18:34 purenrgtransfer bash[2450]: mount: /cpusets: unknown filesystem type 'cpuset'. Dec 20 21:18:34 purenrgtransfer bash[2450]: dmesg(1) may have more information after failed mount system call. Dec 20 21:18:34 purenrgtransfer bash[2456]: mount: /cpusets: unknown filesystem type 'cpuset'. Dec 20 21:18:34 purenrgtransfer bash[2456]: dmesg(1) may have more information after failed mount system call. Dec 20 21:18:34 purenrgtransfer bash[2462]: mount: /cpusets: unknown filesystem type 'cpuset'. Dec 20 21:18:34 purenrgtransfer bash[2462]: dmesg(1) may have more information after failed mount system call. Dec 20 21:18:34 purenrgtransfer bash[2460]: cset: **> mount of cpuset filesystem failed, do you have permission? Dec 20 21:18:34 purenrgtransfer systemd[1]: Finished musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Dec 20 21:18:34 purenrgtransfer systemd[1]: Reached target multi-user.target - Multi-User System. Dec 20 21:18:34 purenrgtransfer systemd[1]: Reached target graphical.target - Graphical Interface. Dec 20 21:18:34 purenrgtransfer ntpd[2331]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 20 21:18:34 purenrgtransfer ntpd[2331]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Dec 20 21:18:34 purenrgtransfer ntpd[2331]: DNS: Pool taking: 147.91.26.20 Dec 20 21:18:34 purenrgtransfer ntpd[2331]: DNS: Pool taking: 195.178.58.245 Dec 20 21:18:34 purenrgtransfer ntpd[2331]: DNS: Pool taking: 195.252.108.16 Dec 20 21:18:34 purenrgtransfer ntpd[2331]: DNS: Pool taking: 217.24.20.5 Dec 20 21:18:34 purenrgtransfer ntpd[2331]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Dec 20 21:18:34 purenrgtransfer systemd[1]: Starting irqaffinity.service - IRQ CPU Affinity Setup... Dec 20 21:18:34 purenrgtransfer systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Dec 20 21:18:34 purenrgtransfer systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Dec 20 21:18:34 purenrgtransfer sudo[2165]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:34 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioStop Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreStateMachine::stop Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 21:18:34 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 21:18:34 purenrgtransfer systemd[1]: irqaffinity.service: Deactivated successfully. Dec 20 21:18:34 purenrgtransfer systemd[1]: Finished irqaffinity.service - IRQ CPU Affinity Setup. Dec 20 21:18:34 purenrgtransfer volumio[1105]: [Metrics] CommandRouter: 59s 804.29ms Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumiosetStartupVolume Dec 20 21:18:34 purenrgtransfer volumiobt[2469]: INFO [BTSTART] Ensuring Bluetooth directory exists... Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 21:18:34 purenrgtransfer systemd[1]: Reloading. Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreCommandRouter::Close All Modals sent Dec 20 21:18:34 purenrgtransfer sudo[2470]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Dec 20 21:18:34 purenrgtransfer sudo[2470]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: CoreCommandRouter::Close All Modals sent Dec 20 21:18:34 purenrgtransfer sudo[2470]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:34 purenrgtransfer sudo[2474]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Dec 20 21:18:34 purenrgtransfer sudo[2474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:34 purenrgtransfer sudo[2474]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:34 purenrgtransfer volumiobt[2476]: INFO [BTSTART] Powering on Bluetooth if needed... Dec 20 21:18:34 purenrgtransfer bluetoothd[916]: Adv Monitor app :1.26 disconnected from D-Bus Dec 20 21:18:34 purenrgtransfer volumiobt[2483]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Dec 20 21:18:34 purenrgtransfer systemd-gpt-auto-generator[2487]: EFI loader partition unknown, exiting. Dec 20 21:18:34 purenrgtransfer systemd-gpt-auto-generator[2487]: (The boot loader did not set EFI variable LoaderDevicePartUUID.) Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: [176B blob data] Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: [157B blob data] Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: [157B blob data] Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: [157B blob data] Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: [113B blob data] Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: [bluetoothctl]> discoverable on Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: [bluetoothctl]> pairable on Dec 20 21:18:34 purenrgtransfer bluetoothd[916]: Path / reserved for Adv Monitor app :1.27 Dec 20 21:18:34 purenrgtransfer bluetoothd[916]: Adv Monitor app :1.27 disconnected from D-Bus Dec 20 21:18:34 purenrgtransfer volumiobt[2495]: [bluetoothctl]> Dec 20 21:18:34 purenrgtransfer volumiobt[2496]: INFO [BTSTART] Registering Bluetooth agent... Dec 20 21:18:34 purenrgtransfer volumiobt[2497]: [NEW] Media /org/bluez/hci0 Dec 20 21:18:34 purenrgtransfer volumiobt[2497]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Dec 20 21:18:34 purenrgtransfer volumiobt[2497]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Dec 20 21:18:34 purenrgtransfer volumiobt[2497]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Dec 20 21:18:34 purenrgtransfer bluetoothd[916]: Adv Monitor app :1.28 disconnected from D-Bus Dec 20 21:18:34 purenrgtransfer volumiobt[2498]: No agent is registered Dec 20 21:18:34 purenrgtransfer volumiobt[2498]: [NEW] Media /org/bluez/hci0 Dec 20 21:18:34 purenrgtransfer volumiobt[2498]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Dec 20 21:18:34 purenrgtransfer volumiobt[2498]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Dec 20 21:18:34 purenrgtransfer volumiobt[2498]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Dec 20 21:18:34 purenrgtransfer bluetoothd[916]: Adv Monitor app :1.29 disconnected from D-Bus Dec 20 21:18:34 purenrgtransfer volumiobt[2499]: INFO [BTSTART] Agent registered successfully. Dec 20 21:18:34 purenrgtransfer volumiobt[2500]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Dec 20 21:18:34 purenrgtransfer systemd[1]: /etc/systemd/system/musicservicesshield.service:14: Failed to parse output specifier, ignoring: jouurnal Dec 20 21:18:34 purenrgtransfer systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 20 21:18:34 purenrgtransfer systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 20 21:18:34 purenrgtransfer systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 20 21:18:34 purenrgtransfer systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 20 21:18:34 purenrgtransfer sudo[1830]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:34 purenrgtransfer volumio[1105]: info: succeeded Dec 20 21:18:34 purenrgtransfer systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 20 21:18:34 purenrgtransfer systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Dec 20 21:18:34 purenrgtransfer systemd[1]: Startup finished in 31.060s (kernel) + 1min 3.648s (userspace) = 1min 34.709s. Dec 20 21:18:34 purenrgtransfer volumiobt[2501]: INFO:a2dp-agent:Connecting to system bus. Dec 20 21:18:34 purenrgtransfer volumiobt[2501]: INFO:a2dp-agent:Found Bluetooth adapter at: /org/bluez/hci0 Dec 20 21:18:34 purenrgtransfer volumiobt[2501]: INFO:a2dp-agent:Enabling infinite discovery on adapter. Dec 20 21:18:34 purenrgtransfer volumiobt[2501]: INFO:a2dp-agent:Registering agent. Dec 20 21:18:34 purenrgtransfer volumiobt[2501]: INFO:a2dp-agent:Searching for MediaPlayer1 interface... Dec 20 21:18:34 purenrgtransfer volumiobt[2501]: WARNING:a2dp-agent:No active MediaPlayer1 found. Metadata updates won't work. Dec 20 21:18:35 purenrgtransfer ntpd[2331]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 20 21:18:35 purenrgtransfer ntpd[2331]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Dec 20 21:18:35 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 147.91.26.20 Dec 20 21:18:35 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 195.252.108.16 Dec 20 21:18:35 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 217.24.20.5 Dec 20 21:18:35 purenrgtransfer ntpd[2331]: DNS: Pool taking: 195.250.114.105 Dec 20 21:18:35 purenrgtransfer ntpd[2331]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Dec 20 21:18:35 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 20 21:18:35 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 20 21:18:35 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 217.24.20.5 Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 195.178.58.245 Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 147.91.26.20 Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 195.252.108.16 Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: Pool taking: 2001:ac8:7d:42:0:2:0:10 Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: Pool taking: 2001:ac8:7d:42:0:2:0:20 Dec 20 21:18:36 purenrgtransfer ntpd[2331]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Dec 20 21:18:36 purenrgtransfer sudo[2525]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 20 21:18:36 purenrgtransfer sudo[2525]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:36 purenrgtransfer sudo[2527]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 20 21:18:36 purenrgtransfer sudo[2527]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:36 purenrgtransfer sudo[2530]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 20 21:18:36 purenrgtransfer sudo[2530]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 21:18:36 purenrgtransfer systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 20 21:18:36 purenrgtransfer sudo[2525]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:36 purenrgtransfer volumio[1105]: info: Successfully started MPD Monitor Dec 20 21:18:36 purenrgtransfer mpd_monitor.sh[2533]: MPD Monitor Service: Starting MPD Monitor Service Dec 20 21:18:36 purenrgtransfer systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 20 21:18:36 purenrgtransfer systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 20 21:18:36 purenrgtransfer systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 20 21:18:36 purenrgtransfer systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 20 21:18:36 purenrgtransfer sudo[2527]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:36 purenrgtransfer mpd_monitor.sh[2536]: MPD Monitor Service: Starting MPD Monitor Service Dec 20 21:18:36 purenrgtransfer volumio[1105]: info: Successfully started MPD Monitor Dec 20 21:18:36 purenrgtransfer sudo[2530]: pam_unix(sudo:session): session closed for user root Dec 20 21:18:36 purenrgtransfer volumio[1105]: info: Successfully started MPD Monitor Dec 20 21:18:37 purenrgtransfer ntpd[2331]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 20 21:18:37 purenrgtransfer ntpd[2331]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Dec 20 21:18:37 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 217.24.20.5 Dec 20 21:18:37 purenrgtransfer ntpd[2331]: DNS: Pool taking: 147.91.8.1 Dec 20 21:18:37 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 147.91.26.20 Dec 20 21:18:37 purenrgtransfer ntpd[2331]: DNS: Pool skipping: 195.252.108.16 Dec 20 21:18:37 purenrgtransfer ntpd[2331]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Dec 20 21:18:37 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:37 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 21:18:37 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 20 21:18:37 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 20 21:18:37 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 20 21:18:37 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 21:18:37 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 21:18:39 purenrgtransfer volumio[1105]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 20 21:18:40 purenrgtransfer ntpd[2331]: CLOCK: time stepped by 0.170146 Dec 20 21:18:40 purenrgtransfer ntpd[2331]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Dec 20 21:18:41 purenrgtransfer volumio[1105]: info: BOOT COMPLETED Dec 20 21:18:45 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 21:18:45 purenrgtransfer volumio[1105]: info: CURURI: music-library Dec 20 21:18:45 purenrgtransfer volumio[1105]: info: Preload queue cleared Dec 20 21:18:46 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 21:18:46 purenrgtransfer volumio[1105]: info: CURURI: music-library/INTERNAL Dec 20 21:18:46 purenrgtransfer volumio[1105]: info: Preload queue cleared Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: Preload queue cleared Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::ClearQueue Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::stop Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::serviceStop Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreCommandRouter::serviceStop Dec 20 21:18:53 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [FUNC] stop Dec 20 21:18:53 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Dec 20 21:18:53 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CorePlayQueue::clearPlayQueue Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CorePlayQueue::saveQueue Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushQueue Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::addQueueItems Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CorePlayQueue::addQueueItems Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: Preload queue cleared Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: Adding Item to queue: music-library/INTERNAL/AML Test CD + Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: Exploding uri music-library/INTERNAL/AML Test CD + in service mpd Dec 20 21:18:53 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: Bluetooth audio output stopped Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%90%D0%BD%D1%82%D0%BE%D0%BD%D0%B8%D0%BD%D0%B0%20%D0%9D%D0%B5%D0%B6%D0%B4%D0%B0%D0%BD%D0%BE%D0%B2%D0%B0%20(%D1%81%D0%BE%D0%BF%D1%80%D0%B0%D0%BD%D0%BE)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F01%20-%20%D0%90%D0%BD%D1%82%D0%BE%D0%BD%D0%B8%D0%BD%D0%B0%20%D0%9D%D0%B5%D0%B6%D0%B4%D0%B0%D0%BD%D0%BE%D0%B2%D0%B0%20(%D1%81%D0%BE%D0%BF%D1%80%D0%B0%D0%BD%D0%BE).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%9F%D0%B0%D0%B1%D0%BB%D0%BE%20%D0%9A%D0%B0%D0%B7%D0%B0%D0%BB%D1%8C%D1%81%20(%D0%B2%D0%B8%D0%BE%D0%BB%D0%BE%D0%BD%D1%87%D0%B5%D0%BB%D1%8C)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F02%20-%20%D0%9F%D0%B0%D0%B1%D0%BB%D0%BE%20%D0%9A%D0%B0%D0%B7%D0%B0%D0%BB%D1%8C%D1%81%20(%D0%B2%D0%B8%D0%BE%D0%BB%D0%BE%D0%BD%D1%87%D0%B5%D0%BB%D1%8C).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/02 - Пабло Казальс (виолончель).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%90%D0%BB%D1%8C%D1%84%D1%80%D0%B5%D0%B4%20%D0%9A%D0%BE%D1%80%D1%82%D0%BE%20(%D1%84%D0%BE%D1%80%D1%82%D0%B5%D0%BF%D0%B8%D0%B0%D0%BD%D0%BE)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F03%20-%20%D0%90%D0%BB%D1%8C%D1%84%D1%80%D0%B5%D0%B4%20%D0%9A%D0%BE%D1%80%D1%82%D0%BE%20(%D1%84%D0%BE%D1%80%D1%82%D0%B5%D0%BF%D0%B8%D0%B0%D0%BD%D0%BE).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/03 - Альфред Корто (фортепиано).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%9C%D1%83%D0%BD%D0%B8%D1%86%D0%B8%D0%BF%D0%B0%D0%BB%D1%8C%D0%BD%D1%8B%D0%B9%20%D0%B4%D1%83%D1%85%D0%BE%D0%B2%D0%BE%D0%B9%20%D0%BE%D1%80%D0%BA%D0%B5%D1%81%D1%82%D1%80%20%D0%B3.%20%D0%9C%D0%B8%D0%BB%D0%B0%D0%BD%D0%B0%20(%D0%B4%D0%B8%D1%80.%20%D0%9F.%20%D0%9D%D0%B5%D0%B2%D0%B8)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F04%20-%20%D0%94%D1%83%D1%85%D0%BE%D0%B2%D0%BE%D0%B9%20%D0%BE%D1%80%D0%BA%D0%B5%D1%81%D1%82%D1%80%20%D0%B3.%20%D0%9C%D0%B8%D0%BB%D0%B0%D0%BD%D0%B0%20(%D0%B4%D0%B8%D1%80.%20%D0%9F.%20%D0%9D%D0%B5%D0%B2%D0%B8).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/04 - Духовой оркестр г. Милана (дир. П. Неви).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%A5%D0%BE%D1%80%20%D0%BF%D0%BE%D0%B4%20%D1%83%D0%BF%D1%80%D0%B0%D0%B2%D0%BB%D0%B5%D0%BD%D0%B8%D0%B5%D0%BC%20%D0%98.%20%D0%9A.%20%D0%9B%D0%B8%D0%BD%D1%81%D0%BA%D0%BE%D0%B3%D0%BE/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F05%20-%20%D0%A5%D0%BE%D1%80%20%D0%BF%D0%BE%D0%B4%20%D1%83%D0%BF%D1%80%D0%B0%D0%B2%D0%BB%D0%B5%D0%BD%D0%B8%D0%B5%D0%BC%20%D0%98.%20%D0%9A.%20%D0%9B%D0%B8%D0%BD%D1%81%D0%BA%D0%BE%D0%B3%D0%BE.ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/05 - Хор под управлением И. К. Линского.ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%94%D0%B8%D1%80%D0%B8%D0%B6%D0%B8%D1%80%D1%83%D0%B5%D1%82%20%D0%92%D0%B8%D0%BB%D1%8C%D0%B3%D0%B5%D0%BB%D1%8C%D0%BC%20%D0%A4%D1%83%D1%80%D1%82%D0%B2%D0%B5%D0%BD%D0%B3%D0%BB%D0%B5%D1%80/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F06%20-%20%D0%94%D0%B8%D1%80%D0%B8%D0%B6%D0%B8%D1%80%D1%83%D0%B5%D1%82%20%D0%92%D0%B8%D0%BB%D1%8C%D0%B3%D0%B5%D0%BB%D1%8C%D0%BC%20%D0%A4%D1%83%D1%80%D1%82%D0%B2%D0%B5%D0%BD%D0%B3%D0%BB%D0%B5%D1%80.ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/06 - Дирижирует Вильгельм Фуртвенглер.ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%90%D0%BB%D1%8C%D0%B1%D0%B5%D1%80%D1%82%20%D0%A8%D0%B2%D0%B5%D0%B9%D1%86%D0%B5%D1%80%20(%D0%BE%D1%80%D0%B3%D0%B0%D0%BD)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F07%20-%20%D0%90%D0%BB%D1%8C%D0%B1%D0%B5%D1%80%D1%82%20%D0%A8%D0%B2%D0%B5%D0%B9%D1%86%D0%B5%D1%80%20(%D0%BE%D1%80%D0%B3%D0%B0%D0%BD).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/07 - Альберт Швейцер (орган).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%98%D0%B3%D0%BD%D0%B0%D1%86%D1%8B%20%D0%AF%D0%BD%20%D0%9F%D0%B0%D0%B4%D0%B5%D1%80%D0%B5%D0%B2%D1%81%D0%BA%D0%B8%D0%B9%20(%D1%84%D0%BE%D1%80%D1%82%D0%B5%D0%BF%D0%B8%D0%B0%D0%BD%D0%BE)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F08%20-%20%D0%98%D0%B3%D0%BD%D0%B0%D1%86%D1%8B%20%D0%AF%D0%BD%20%D0%9F%D0%B0%D0%B4%D0%B5%D1%80%D0%B5%D0%B2%D1%81%D0%BA%D0%B8%D0%B9%20(%D1%84%D0%BE%D1%80%D1%82%D0%B5%D0%BF%D0%B8%D0%B0%D0%BD%D0%BE).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/08 - Игнацы Ян Падеревский (фортепиано).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%90%D0%BD%D0%B4%D1%80%D0%B5%D0%B0%D1%81%20%D0%A1%D0%B5%D0%B3%D0%BE%D0%B2%D0%B8%D1%8F%20(%D0%B3%D0%B8%D1%82%D0%B0%D1%80%D0%B0)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F09%20-%20%D0%90%D0%BD%D0%B4%D1%80%D0%B5%D0%B0%D1%81%20%D0%A1%D0%B5%D0%B3%D0%BE%D0%B2%D0%B8%D1%8F%20(%D0%B3%D0%B8%D1%82%D0%B0%D1%80%D0%B0).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/09 - Андреас Сеговия (гитара).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%90%D0%BD%D0%B4%D1%80%D0%B5%D0%B0%D1%81%20%D0%A1%D0%B5%D0%B3%D0%BE%D0%B2%D0%B8%D1%8F%20(%D0%B3%D0%B8%D1%82%D0%B0%D1%80%D0%B0)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F10%20-%20%D0%90%D0%BD%D0%B4%D1%80%D0%B5%D0%B0%D1%81%20%D0%A1%D0%B5%D0%B3%D0%BE%D0%B2%D0%B8%D1%8F%20(%D0%B3%D0%B8%D1%82%D0%B0%D1%80%D0%B0)%2C%20%D1%84%D0%B8%D0%BB%D1%8C%D1%82%D1%80.ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/10 - Андреас Сеговия (гитара), фильтр.ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%AF%D1%88%D0%B0%20%D0%A5%D0%B5%D0%B9%D1%84%D0%B5%D1%86%20(%D1%81%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F11%20-%20%D0%AF%D1%88%D0%B0%20%D0%A5%D0%B5%D0%B9%D1%84%D0%B5%D1%86%20(%D1%81%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/11 - Яша Хейфец (скрипка).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%A4%D1%80%D0%B8%D1%86%20%D0%9A%D1%80%D0%B5%D0%B9%D1%81%D0%BB%D0%B5%D1%80%20(%D1%81%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F12a%20-%20%D0%A4%D1%80%D0%B8%D1%86%20%D0%9A%D1%80%D0%B5%D0%B9%D1%81%D0%BB%D0%B5%D1%80%20(%D1%81%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0)%2C%20%D1%84-%D0%BD%D0%BE%20%D0%9A.%20%D0%9B%D0%B0%D0%BC%D1%81%D0%BE%D0%BD.ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/12a - Фриц Крейслер (скрипка), ф-но К. Ламсон.ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%A4%D1%80%D0%B8%D1%86%20%D0%9A%D1%80%D0%B5%D0%B9%D1%81%D0%BB%D0%B5%D1%80%20(%D1%81%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F12b%20-%20%D0%A4%D1%80%D0%B8%D1%86%20%D0%9A%D1%80%D0%B5%D0%B9%D1%81%D0%BB%D0%B5%D1%80%20(%D1%81%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0)%2C%20%D1%84-%D0%BD%D0%BE%20%D0%A4.%20%D0%A0%D0%B0%D0%BF%D0%BF.ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/12b - Фриц Крейслер (скрипка), ф-но Ф. Рапп.ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%A4%D1%80%D0%B8%D1%86%20%D0%9A%D1%80%D0%B5%D0%B9%D1%81%D0%BB%D0%B5%D1%80%20(%D1%81%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F13%20-%20%D0%A4%D1%80%D0%B8%D1%86%20%D0%9A%D1%80%D0%B5%D0%B9%D1%81%D0%BB%D0%B5%D1%80%20(%D1%81%D0%BA%D1%80%D0%B8%D0%BF%D0%BA%D0%B0)%2C%20%D1%84-%D0%BD%D0%BE%20%D0%93.%20%D0%A4%D0%B0%D0%BB%D1%8C%D0%BA%D0%B5%D0%BD%D1%88%D1%82%D0%B5%D0%B9%D0%BD.ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/13 - Фриц Крейслер (скрипка), ф-но Г. Фалькенштейн.ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%A4%D1%91%D0%B4%D0%BE%D1%80%20%D0%A8%D0%B0%D0%BB%D1%8F%D0%BF%D0%B8%D0%BD%20(%D0%B1%D0%B0%D1%81)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F14%20-%20%D0%A4%D1%91%D0%B4%D0%BE%D1%80%20%D0%A8%D0%B0%D0%BB%D1%8F%D0%BF%D0%B8%D0%BD%20(%D0%B1%D0%B0%D1%81).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/14 - Фёдор Шаляпин (бас).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%9C%D0%B0%D1%82%D1%82%D0%B8%D0%B0%20%D0%91%D0%B0%D1%82%D1%82%D0%B8%D1%81%D1%82%D0%B8%D0%BD%D0%B8%20(%D0%B1%D0%B0%D1%80%D0%B8%D1%82%D0%BE%D0%BD)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F15%20-%20%D0%9C%D0%B0%D1%82%D1%82%D0%B8%D0%B0%20%D0%91%D0%B0%D1%82%D1%82%D0%B8%D1%81%D1%82%D0%B8%D0%BD%D0%B8%20(%D0%B1%D0%B0%D1%80%D0%B8%D1%82%D0%BE%D0%BD).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/15 - Маттиа Баттистини (баритон).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%AD%D0%BD%D1%80%D0%B8%D0%BA%D0%BE%20%D0%9A%D0%B0%D1%80%D1%83%D0%B7%D0%BE%20(%D1%82%D0%B5%D0%BD%D0%BE%D1%80)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F16%20-%20%D0%AD%D0%BD%D1%80%D0%B8%D0%BA%D0%BE%20%D0%9A%D0%B0%D1%80%D1%83%D0%B7%D0%BE%20(%D1%82%D0%B5%D0%BD%D0%BE%D1%80).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/16 - Энрико Карузо (тенор).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%91%D0%B5%D0%BD%D1%8C%D1%8F%D0%BC%D0%B8%D0%BD%D0%BE%20%D0%94%D0%B6%D0%B8%D0%BB%D1%8C%D0%B8%20(%D1%82%D0%B5%D0%BD%D0%BE%D1%80)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F17%20-%20%D0%91%D0%B5%D0%BD%D1%8C%D1%8F%D0%BC%D0%B8%D0%BD%D0%BE%20%D0%94%D0%B6%D0%B8%D0%BB%D1%8C%D0%B8%20(%D1%82%D0%B5%D0%BD%D0%BE%D1%80).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/17 - Беньямино Джильи (тенор).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%9B%D0%B8%D0%BB%D0%B8%20%D0%9F%D0%BE%D0%BD%D1%81%20(%D1%81%D0%BE%D0%BF%D1%80%D0%B0%D0%BD%D0%BE)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F18%20-%20%D0%9B%D0%B8%D0%BB%D0%B8%20%D0%9F%D0%BE%D0%BD%D1%81%20(%D1%81%D0%BE%D0%BF%D1%80%D0%B0%D0%BD%D0%BE).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/18 - Лили Понс (сопрано).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%94%D0%B8%D1%80%D0%B8%D0%B6%D0%B8%D1%80%D1%83%D0%B5%D1%82%20%D0%90%D1%80%D1%82%D1%83%D1%80%D0%BE%20%D0%A2%D0%BE%D1%81%D0%BA%D0%B0%D0%BD%D0%B8%D0%BD%D0%B8/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F19%20-%20%D0%94%D0%B8%D1%80%D0%B8%D0%B6%D0%B8%D1%80%D1%83%D0%B5%D1%82%20%D0%90%D1%80%D1%82%D1%83%D1%80%D0%BE%20%D0%A2%D0%BE%D1%81%D0%BA%D0%B0%D0%BD%D0%B8%D0%BD%D0%B8.ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/19 - Дирижирует Артуро Тосканини.ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%A2%D0%B8%D1%82%D1%82%D0%B0%20%D0%A0%D1%83%D1%84%D1%84%D0%BE%20(%D0%B1%D0%B0%D1%80%D0%B8%D1%82%D0%BE%D0%BD)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F20%20-%20%D0%A2%D0%B8%D1%82%D1%82%D0%B0%20%D0%A0%D1%83%D1%84%D1%84%D0%BE%20(%D0%B1%D0%B0%D1%80%D0%B8%D1%82%D0%BE%D0%BD).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/20 - Титта Руффо (баритон).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=%D0%A2%D0%B8%D1%82%D0%BE%20%D0%A1%D0%BA%D0%B8%D0%BF%D0%B0%20(%D1%82%D0%B5%D0%BD%D0%BE%D1%80)/%D0%90%D0%9C%D0%9B%20%D0%A2%D0%B5%D1%81%D1%82%20CD%2B/extralarge&path=%2Fmnt%2FINTERNAL%2FAML%20Test%20CD%20%2B%2F21%20-%20%D0%A2%D0%B8%D1%82%D0%BE%20%D0%A1%D0%BA%D0%B8%D0%BF%D0%B0%20(%D1%82%D0%B5%D0%BD%D0%BE%D1%80).ape&metadata=false Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/AML Test CD +/21 - Тито Скипа (тенор).ape Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushQueue Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CorePlayQueue::saveQueue Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::updateTrackBlock Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrackBlock Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPlay Dec 20 21:18:53 purenrgtransfer volumio[1105]: verbose: UNSET VOLATILE: Service: bluetooth Dec 20 21:18:53 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [FUNC] detachBluetooth Dec 20 21:18:53 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Dec 20 21:18:53 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::play index 0 Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 21:18:53 purenrgtransfer volumio[1105]: ------------------------------------ BT MESSAGE: Bluetooth audio output disabled. Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::stop Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::resetVolumioState Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreStateMachine::getcurrentVolume Dec 20 21:18:53 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioRetrievevolume Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::play index undefined Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioStop Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::stop Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::startPlaybackTimer Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand stop took 2 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand clear took 1 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape" Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces system playlist update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Ignoring MPD Status Update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces system playlist update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Ignoring MPD Status Update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces system playlist update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Ignoring MPD Status Update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces system playlist update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Ignoring MPD Status Update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand add "INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape" took 2 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 2ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces system playlist update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Ignoring MPD Status Update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces system playlist update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Ignoring MPD Status Update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces system playlist update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Ignoring MPD Status Update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 8ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 8ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 7ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand play took 6 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 6ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 6ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces system playlist update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Ignoring MPD Status Update Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 2ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 1ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: VolumeController:: Volume=82 Mute =false Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::updateTrackBlock Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrackBlock Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioRetrievevolume Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: VolumeController:: Volume=82 Mute =false Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 2 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 2 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 1 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 3 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 2 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus stop Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Received an update from plugin. extracting info from payload Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Received an update from plugin. extracting info from payload Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 13ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 26ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 26ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Dec 20 21:18:54 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 23 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 23 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 1 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 1 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Received an update from plugin. extracting info from payload Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Received an update from plugin. extracting info from payload Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 48ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 47ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Received an update from plugin. extracting info from payload Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Received an update from plugin. extracting info from payload Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:54 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus play Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: Received an update from plugin. extracting info from payload Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 91ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 69ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: info: ------------------------------ 68ms Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:54 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::stPlaybackTimer Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::servicePause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: Dec 20 21:18:57 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand pause took 1 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: Dec 20 21:18:57 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: Dec 20 21:18:57 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: Dec 20 21:18:57 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::getState Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand status Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 2 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 2 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 1 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand status took 3 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseState Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4471,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::stPlaybackTimer Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4471,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::stPlaybackTimer Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4471,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::stPlaybackTimer Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ------------------------------ 37ms Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ------------------------------ 36ms Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ------------------------------ 36ms Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: sendMpdCommand playlistinfo took 33 milliseconds Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: ControllerMpd::parseTrackInfo Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ControllerMpd::pushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::servicePushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4471,"duration":141,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Дева Мария (акустическая запись)","artist":"Антонина Нежданова (сопрано)","album":"АМЛ Тест CD+","uri":"INTERNAL/AML Test CD +/01 - Антонина Нежданова (сопрано).ape","trackType":"ape"} Dec 20 21:18:57 purenrgtransfer volumio[1105]: verbose: CURRENT POSITION 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState stateService pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::syncState currentStatus pause Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: CoreStateMachine::stPlaybackTimer Dec 20 21:18:57 purenrgtransfer volumio[1105]: info: ------------------------------ 41ms Dec 20 21:18:57 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:57 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:57 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:18:57 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: Preload queue cleared Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreStateMachine::ClearQueue Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreStateMachine::stop Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreStateMachine::updateTrackBlock Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrackBlock Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreStateMachine::stPlaybackTimer Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreStateMachine::pushState Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushState Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output update for this device Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: MRS: Pushing multiroomSync output Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioGetState Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreStateMachine::serviceStop Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CorePlayQueue::getTrack 0 Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreCommandRouter::serviceStop Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: ControllerMpd::stop Dec 20 21:19:00 purenrgtransfer volumio[1105]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CorePlayQueue::clearPlayQueue Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CorePlayQueue::saveQueue Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreCommandRouter::volumioPushQueue Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CoreStateMachine::addQueueItems Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: CorePlayQueue::addQueueItems Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: Preload queue cleared Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: Adding Item to queue: music-library/INTERNAL/Audiophile from FOCAL JMlab - 1996-2009 8CD (Malestrom) Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: Exploding uri music-library/INTERNAL/Audiophile from FOCAL JMlab - 1996-2009 8CD (Malestrom) in service mpd Dec 20 21:19:00 purenrgtransfer volumio[1105]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: Dec 20 21:19:00 purenrgtransfer volumio[1105]: ---------------------------- MPD announces state update: player Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=Michael%20Ruff/Focal%20JMlab%20CD%20%E2%84%961%2F7/extralarge&path=%2Fmnt%2FINTERNAL%2FAudiophile%20from%20FOCAL%20JMlab%20-%201996-2009%208CD%20(Malestrom)%2FCD%20No%201%20(1996)%2FVarious%20-%20Focal%20JMlab%20CD%201.flac&metadata=false Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/Audiophile from FOCAL JMlab - 1996-2009 8CD (Malestrom)/CD No 1 (1996)/Various - Focal JMlab CD 1.flac Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=Left%20and%20right%20channels%20test/Focal%20JMlab%20CD%20%3F2%2F7/extralarge&path=%2Fmnt%2FINTERNAL%2FAudiophile%20from%20FOCAL%20JMlab%20-%201996-2009%208CD%20(Malestrom)%2FCD%20No%202%20(1997)%2FVarious%20-%20Focal%20JMlab%20CD%202.cue&metadata=false Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/Audiophile from FOCAL JMlab - 1996-2009 8CD (Malestrom)/CD No 2 (1997)/Various - Focal JMlab CD 2.cue Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: ALBUMART /albumart?cacheid=201&web=Pink%20noise%3A%20Ref.%20-14dB%20Fs/Focal%20JMlab%20CD%20%3F2%2F7/extralarge&path=%2Fmnt%2FINTERNAL%2FAudiophile%20from%20FOCAL%20JMlab%20-%201996-2009%208CD%20(Malestrom)%2FCD%20No%202%20(1997)%2FVarious%20-%20Focal%20JMlab%20CD%202.cue&metadata=false Dec 20 21:19:00 purenrgtransfer volumio[1105]: info: URI /mnt/INTERNAL/Audiophile from FOCAL JMlab - 1996-2009 8CD (Malestrom)/CD No 2 (1997)/Various - Focal JMlab CD 2.cue Dec 20 21:19:00 purenrgtransfer volumio[1105]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 21:19:00 purenrgtransfer volumio[1105]: Error: Unable to resolve or reject the same promise twice Dec 20 21:19:00 purenrgtransfer volumio[1105]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Dec 20 21:19:00 purenrgtransfer volumio[1105]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Dec 20 21:19:00 purenrgtransfer volumio[1105]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Dec 20 21:19:00 purenrgtransfer volumio[1105]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Dec 20 21:19:00 purenrgtransfer volumio[1105]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Dec 20 21:19:00 purenrgtransfer volumio[1105]: at Socket.emit (node:events:514:28) Dec 20 21:19:00 purenrgtransfer volumio[1105]: at addChunk (node:internal/streams/readable:343:12) Dec 20 21:19:00 purenrgtransfer volumio[1105]: at readableAddChunk (node:internal/streams/readable:312:11) Dec 20 21:19:00 purenrgtransfer volumio[1105]: at Readable.push (node:internal/streams/readable:253:10) Dec 20 21:19:00 purenrgtransfer volumio[1105]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Dec 20 21:19:00 purenrgtransfer volumio[1105]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 21:19:00 purenrgtransfer sudo[2635]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-20 21:18' Dec 20 21:19:00 purenrgtransfer sudo[2635]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"