-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2024-11-27 11:12:56 CET. -- Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:33 hsrivo volumio[3427]: xcb_connection_has_error() returned true Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 27 11:11:33 hsrivo volumio[3427]: xcb_connection_has_error() returned true Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 27 11:11:33 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 27 11:11:42 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:42 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 27 11:11:42 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 27 11:11:42 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 27 11:11:42 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 27 11:11:42 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Nov 27 11:11:42 hsrivo volumio[3427]: info: Received Get System Version Nov 27 11:11:42 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 11:11:42 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Nov 27 11:11:47 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:51 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:51 hsrivo volumio[3427]: xcb_connection_has_error() returned true Nov 27 11:11:51 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 27 11:11:51 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 11:11:51 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 27 11:11:51 hsrivo volumio[3427]: xcb_connection_has_error() returned true Nov 27 11:11:51 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:51 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 27 11:11:51 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:55 hsrivo volumio[3427]: info: Retrieving Cloud Streaming UI Nov 27 11:11:55 hsrivo volumio[3427]: info: Getting Tidal Cloud Configuration Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:55 hsrivo volumio[3427]: info: Getting Qobuz Cloud Configuration Nov 27 11:11:55 hsrivo volumio[3427]: info: Asking plugin for UI Config Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:55 hsrivo volumio[3427]: info: Getting Spotify Cloud Configuration Nov 27 11:11:55 hsrivo volumio[3427]: info: Asking plugin for UI Config Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:55 hsrivo volumio[3427]: info: Saving Spotify Acccount Nov 27 11:11:55 hsrivo volumio[3427]: info: Got it Nov 27 11:11:55 hsrivo volumio[3427]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 27 11:11:55 hsrivo volumio[3427]: info: Got Tidal Cloud Configuration Nov 27 11:11:55 hsrivo volumio[3427]: info: Got it Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::volumioGetBrowseSources Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::volumioGetBrowseSources Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::volumioGetBrowseSources Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 11:11:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 27 11:11:59 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 11:12:03 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 11:12:07 hsrivo volumio[3427]: info: Disabling MyMusic plugin multiroom Nov 27 11:12:07 hsrivo volumio[3427]: info: Disabling plugin multiroom Nov 27 11:12:07 hsrivo volumio[3427]: info: Preparing to generate the ALSA configuration file Nov 27 11:12:07 hsrivo volumio[3427]: info: Asound.conf file written Nov 27 11:12:07 hsrivo sudo[4458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 27 11:12:07 hsrivo sudo[4458]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 11:12:07 hsrivo sudo[4458]: pam_unix(sudo:session): session closed for user root Nov 27 11:12:07 hsrivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Nov 27 11:12:07 hsrivo kernel: Err: can not set rate to 4278967296! Nov 27 11:12:07 hsrivo kernel: Range[3920000 - 500000000] Nov 27 11:12:07 hsrivo kernel: out of value, fixed it Nov 27 11:12:07 hsrivo kernel: id=0 set inskew=0 Nov 27 11:12:07 hsrivo volumio[3427]: xcb_connection_has_error() returned true Nov 27 11:12:07 hsrivo volumio[3427]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Nov 27 11:12:07 hsrivo volumio[3427]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Nov 27 11:12:07 hsrivo volumio[3427]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Nov 27 11:12:07 hsrivo volumio[3427]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Nov 27 11:12:07 hsrivo volumio[3427]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPL Internal Clock Validity:0' : Operation not permitted Nov 27 11:12:07 hsrivo volumio[3427]: info: Output device has changed, restarting MPD Nov 27 11:12:07 hsrivo sudo[4463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 27 11:12:07 hsrivo sudo[4463]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 11:12:07 hsrivo volumio[3427]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 27 11:12:07 hsrivo sudo[4463]: pam_unix(sudo:session): session closed for user root Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo sudo[4466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 27 11:12:07 hsrivo sudo[4466]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: Done. Nov 27 11:12:07 hsrivo systemd[1]: Stopping Music Player Daemon... Nov 27 11:12:07 hsrivo volumio[3427]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 27 11:12:07 hsrivo volumio[3427]: info: MPD Permissions set Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 11:12:07 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 11:12:07 hsrivo volumio[3427]: error: MPD error: Error: read ECONNRESET Nov 27 11:12:07 hsrivo systemd[1]: mpd.service: Succeeded. Nov 27 11:12:07 hsrivo systemd[1]: Stopped Music Player Daemon. Nov 27 11:12:07 hsrivo systemd[1]: Starting Music Player Daemon... Nov 27 11:12:07 hsrivo volumio[3427]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 27 11:12:07 hsrivo volumio[3427]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 27 11:12:08 hsrivo sudo[4476]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 27 11:12:08 hsrivo sudo[4476]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 11:12:08 hsrivo sudo[4476]: pam_unix(sudo:session): session closed for user root Nov 27 11:12:09 hsrivo mpd[4485]: Nov 27 11:12 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 27 11:12:10 hsrivo systemd[1]: Started Music Player Daemon. Nov 27 11:12:10 hsrivo sudo[4466]: pam_unix(sudo:session): session closed for user root Nov 27 11:12:10 hsrivo volumio[3427]: error: updateQueue error: null Nov 27 11:12:11 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 11:12:12 hsrivo volumio[3427]: error: updateQueue error: null Nov 27 11:12:15 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 11:12:19 hsrivo volumio[3427]: verbose: New Socket.io Connection to 192.168.2.66 from 192.168.2.15 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6 Nov 27 11:12:19 hsrivo volumio[3427]: info: CoreCommandRouter::volumioGetVisibleSources Nov 27 11:12:19 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 11:12:19 hsrivo volumio[3427]: info: CoreCommandRouter::volumioGetState Nov 27 11:12:19 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:19 hsrivo volumio[3427]: info: CoreCommandRouter::volumioGetQueue Nov 27 11:12:19 hsrivo volumio[3427]: info: CoreStateMachine::getQueue Nov 27 11:12:19 hsrivo volumio[3427]: info: CorePlayQueue::getQueue Nov 27 11:12:19 hsrivo volumio[3427]: info: Listing playlists Nov 27 11:12:19 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 27 11:12:19 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 11:12:21 hsrivo volumio[3427]: info: CoreCommandRouter::volumioSeek Nov 27 11:12:21 hsrivo volumio[3427]: info: CoreStateMachine::seek Nov 27 11:12:21 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:21 hsrivo volumio[3427]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","service":"mpd","name":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=96&web=Jens%20Kr%C3%BCger/70er%20Jahre%20Junge/large&path=%2FINTERNAL%2FJens%20Kr%C3%BCger%2F70er%20Jahre%20Junge&metadata=false","duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"m4a","channels":2} Nov 27 11:12:21 hsrivo volumio[3427]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:12:21 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:21 hsrivo volumio[3427]: info: ControllerMpd::seek Nov 27 11:12:21 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:21 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:21 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:21 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:21 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:21 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:21 hsrivo volumio[3427]: error: [2@0] {seek} Bad song index Nov 27 11:12:22 hsrivo volumio[3427]: info: CoreCommandRouter::volumioSeek Nov 27 11:12:22 hsrivo volumio[3427]: info: CoreStateMachine::seek Nov 27 11:12:22 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:22 hsrivo volumio[3427]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","service":"mpd","name":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=96&web=Jens%20Kr%C3%BCger/70er%20Jahre%20Junge/large&path=%2FINTERNAL%2FJens%20Kr%C3%BCger%2F70er%20Jahre%20Junge&metadata=false","duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"m4a","channels":2} Nov 27 11:12:22 hsrivo volumio[3427]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:12:22 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:22 hsrivo volumio[3427]: info: ControllerMpd::seek Nov 27 11:12:22 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:22 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:22 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:22 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:22 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:22 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:22 hsrivo volumio[3427]: error: [2@0] {seek} Bad song index Nov 27 11:12:23 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPause Nov 27 11:12:23 hsrivo volumio[3427]: info: CoreStateMachine::pause Nov 27 11:12:23 hsrivo volumio[3427]: info: CoreStateMachine::stPlaybackTimer Nov 27 11:12:23 hsrivo volumio[3427]: info: CoreStateMachine::servicePause Nov 27 11:12:23 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:23 hsrivo volumio[3427]: info: CoreCommandRouter::servicePause Nov 27 11:12:23 hsrivo volumio[3427]: info: ControllerMpd::pause Nov 27 11:12:23 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand pause Nov 27 11:12:23 hsrivo volumio[3427]: info: sendMpdCommand pause took 2 milliseconds Nov 27 11:12:23 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 11:12:26 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 27 11:12:26 hsrivo volumio[3427]: info: CURURI: artists:// Nov 27 11:12:26 hsrivo volumio[3427]: info: Preload queue cleared Nov 27 11:12:35 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:35 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: mpd , goto Nov 27 11:12:35 hsrivo volumio[3427]: info: Executing endpoint metavolumio Nov 27 11:12:35 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 27 11:12:35 hsrivo volumio[3427]: info: Executing endpoint metavolumio Nov 27 11:12:35 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 27 11:12:35 hsrivo volumio[3427]: info: Executing endpoint metavolumio Nov 27 11:12:35 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 27 11:12:35 hsrivo volumio[3427]: info: Executing endpoint metavolumio Nov 27 11:12:35 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 27 11:12:37 hsrivo volumio[3427]: info: Preload queue cleared Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::ClearQueue Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::stop Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::stPlaybackTimer Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::serviceStop Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::serviceStop Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::stop Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::clearPlayQueue Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::saveQueue Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::addQueueItems Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::addQueueItems Nov 27 11:12:37 hsrivo volumio[3427]: info: Preload queue cleared Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/01 Was ich will.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/01 Was ich will.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/02 Fieberträume.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/02 Fieberträume.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/03 70Er Jahre Junge.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/03 70Er Jahre Junge.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/04 In deiner Umlaufbahn.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/04 In deiner Umlaufbahn.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/05 Du bist du.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/05 Du bist du.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::saveQueue Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPlay Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::play index 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::addQueueItems Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::addQueueItems Nov 27 11:12:37 hsrivo volumio[3427]: info: Preload queue cleared Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/07 Der Letzte deiner Art.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/07 Der Letzte deiner Art.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/08 Der Finger von Et.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/08 Der Finger von Et.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/09 Salz.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/09 Salz.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/10 Krieger auf Diclofenac.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/10 Krieger auf Diclofenac.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/11 Senor Velazquez.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/11 Senor Velazquez.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Adding Item to queue: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/12 Das Glasbodenboot.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: Using cached record of: music-library/INTERNAL/Jens Krüger/70er Jahre Junge/12 Das Glasbodenboot.m4a Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::stop Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::saveQueue Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::play index undefined Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand stop took 74 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand stop took 17 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 11:12:37 hsrivo volumio[3427]: info: Nov 27 11:12:37 hsrivo volumio[3427]: ---------------------------- MPD announces system playlist update Nov 27 11:12:37 hsrivo volumio[3427]: info: Ignoring MPD Status Update Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand clear took 2 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a" Nov 27 11:12:37 hsrivo volumio[3427]: info: Nov 27 11:12:37 hsrivo volumio[3427]: ---------------------------- MPD announces system playlist update Nov 27 11:12:37 hsrivo volumio[3427]: info: Ignoring MPD Status Update Nov 27 11:12:37 hsrivo volumio[3427]: error: updateQueue error: null Nov 27 11:12:37 hsrivo volumio[3427]: info: Nov 27 11:12:37 hsrivo volumio[3427]: ---------------------------- MPD announces system playlist update Nov 27 11:12:37 hsrivo volumio[3427]: info: Ignoring MPD Status Update Nov 27 11:12:37 hsrivo volumio[3427]: info: ------------------------------ 11ms Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand add "INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a" took 9 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: info: ------------------------------ 6ms Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand play Nov 27 11:12:37 hsrivo volumio[3427]: info: Nov 27 11:12:37 hsrivo volumio[3427]: ---------------------------- MPD announces system playlist update Nov 27 11:12:37 hsrivo volumio[3427]: info: Ignoring MPD Status Update Nov 27 11:12:37 hsrivo volumio[3427]: info: ------------------------------ 7ms Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand play took 5 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: info: ------------------------------ 4ms Nov 27 11:12:37 hsrivo volumio[3427]: info: Nov 27 11:12:37 hsrivo volumio[3427]: ---------------------------- MPD announces state update: player Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::getState Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:37 hsrivo volumio[3427]: info: Nov 27 11:12:37 hsrivo volumio[3427]: ---------------------------- MPD announces state update: player Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::getState Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:37 hsrivo volumio[3427]: info: Nov 27 11:12:37 hsrivo volumio[3427]: ---------------------------- MPD announces state update: player Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand status took 12 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::getState Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::parseState Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand status took 13 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand status took 3 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::parseState Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::parseState Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::servicePushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","uri":"INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","trackType":"m4a"} Nov 27 11:12:37 hsrivo volumio[3427]: verbose: CURRENT POSITION 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:12:37 hsrivo volumio[3427]: info: ------------------------------ 26ms Nov 27 11:12:37 hsrivo volumio[3427]: info: Nov 27 11:12:37 hsrivo volumio[3427]: ---------------------------- MPD announces state update: player Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::getState Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand status took 3 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::parseState Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::servicePushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","uri":"INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","trackType":"m4a"} Nov 27 11:12:37 hsrivo volumio[3427]: verbose: CURRENT POSITION 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:37 hsrivo volumio[3427]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::servicePushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","uri":"INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","trackType":"m4a"} Nov 27 11:12:37 hsrivo volumio[3427]: verbose: CURRENT POSITION 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:37 hsrivo volumio[3427]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:37 hsrivo volumio[3427]: info: ------------------------------ 121ms Nov 27 11:12:37 hsrivo volumio[3427]: info: ------------------------------ 112ms Nov 27 11:12:37 hsrivo volumio[3427]: info: sendMpdCommand playlistinfo took 95 milliseconds Nov 27 11:12:37 hsrivo volumio[3427]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:37 hsrivo volumio[3427]: info: ControllerMpd::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::servicePushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"939 Kbps","isStreaming":false,"title":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","uri":"INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","trackType":"m4a"} Nov 27 11:12:37 hsrivo volumio[3427]: verbose: CURRENT POSITION 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:37 hsrivo volumio[3427]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:37 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:37 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:37 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:37 hsrivo volumio[3427]: info: ------------------------------ 152ms Nov 27 11:12:37 hsrivo volumio[3427]: info: Signalling Playback active due to playback status change Nov 27 11:12:37 hsrivo volumio[3427]: info: MCU Signalled Playback Inactive Nov 27 11:12:37 hsrivo volumio[3427]: info: MCU Signalled Playback Active Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::volumioSeek Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::seek Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","service":"mpd","name":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=96&web=Jens%20Kr%C3%BCger/70er%20Jahre%20Junge/large&path=%2FINTERNAL%2FJens%20Kr%C3%BCger%2F70er%20Jahre%20Junge&metadata=false","duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"m4a","channels":2} Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: ControllerMpd::seek Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:39 hsrivo volumio[3427]: error: null Nov 27 11:12:39 hsrivo volumio[3427]: info: Nov 27 11:12:39 hsrivo volumio[3427]: ---------------------------- MPD announces state update: player Nov 27 11:12:39 hsrivo volumio[3427]: info: ControllerMpd::getState Nov 27 11:12:39 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:39 hsrivo volumio[3427]: info: Nov 27 11:12:39 hsrivo volumio[3427]: ---------------------------- MPD announces state update: player Nov 27 11:12:39 hsrivo volumio[3427]: info: ControllerMpd::getState Nov 27 11:12:39 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:39 hsrivo volumio[3427]: info: sendMpdCommand status took 13 milliseconds Nov 27 11:12:39 hsrivo volumio[3427]: info: sendMpdCommand status took 10 milliseconds Nov 27 11:12:39 hsrivo volumio[3427]: verbose: ControllerMpd::parseState Nov 27 11:12:39 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:39 hsrivo volumio[3427]: verbose: ControllerMpd::parseState Nov 27 11:12:39 hsrivo volumio[3427]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:39 hsrivo volumio[3427]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 27 11:12:39 hsrivo volumio[3427]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 27 11:12:39 hsrivo volumio[3427]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:39 hsrivo volumio[3427]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:39 hsrivo volumio[3427]: info: ControllerMpd::pushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::servicePushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40846,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"939 Kbps","isStreaming":false,"title":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","uri":"INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","trackType":"m4a"} Nov 27 11:12:39 hsrivo volumio[3427]: verbose: CURRENT POSITION 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:39 hsrivo volumio[3427]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:39 hsrivo volumio[3427]: info: ControllerMpd::pushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::servicePushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40846,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"939 Kbps","isStreaming":false,"title":"Frag nicht, sag nichts","artist":"Jens Krüger","album":"70er Jahre Junge","uri":"INTERNAL/Jens Krüger/70er Jahre Junge/06 Frag nicht, sag nichts.m4a","trackType":"m4a"} Nov 27 11:12:39 hsrivo volumio[3427]: verbose: CURRENT POSITION 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:39 hsrivo volumio[3427]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreStateMachine::pushState Nov 27 11:12:39 hsrivo volumio[3427]: info: CorePlayQueue::getTrack 5 Nov 27 11:12:39 hsrivo volumio[3427]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output update for this device Nov 27 11:12:39 hsrivo volumio[3427]: info: MRS: Pushing multiroomSync output Nov 27 11:12:40 hsrivo volumio[3427]: info: ------------------------------ 115ms Nov 27 11:12:40 hsrivo volumio[3427]: info: ------------------------------ 112ms Nov 27 11:12:55 hsrivo volumio[3427]: info: CoreCommandRouter::executeOnPlugin: multiroom , setAudioOutputVolume Nov 27 11:12:55 hsrivo volumio[3427]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 11:12:55 hsrivo volumio[3427]: TypeError: Cannot read property 'then' of undefined Nov 27 11:12:55 hsrivo volumio[3427]: at outputs.setAudioOutputVolume (/volumio/app/plugins/audio_interface/outputs/index.js:314:11) Nov 27 11:12:55 hsrivo volumio[3427]: at CoreCommandRouter.setAudioOutputVolume (/volumio/app/index.js:2263:30) Nov 27 11:12:55 hsrivo volumio[3427]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1444:26) Nov 27 11:12:55 hsrivo volumio[3427]: at Socket.emit (events.js:400:28) Nov 27 11:12:55 hsrivo volumio[3427]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 27 11:12:55 hsrivo volumio[3427]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Nov 27 11:12:55 hsrivo volumio[3427]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 11:12:56 hsrivo sudo[4641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 11:11 Nov 27 11:12:56 hsrivo sudo[4641]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 05:04:03 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b3e66dc85ea2c87aca7db72b97d00dff"