-- Logs begin at Mon 2024-03-04 20:14:54 CET, end at Sun 2024-04-28 14:56:54 CEST. -- Apr 28 14:55:39 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 14:55:39 rivo volumio[23941]: info: Received Get System Info Apr 28 14:55:39 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 14:55:39 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 14:55:39 rivo volumio[23941]: info: Discovery: Getting this device information Apr 28 14:55:39 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:55:39 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 14:55:58 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 14:55:58 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 14:55:58 rivo volumio[23941]: info: Discovery: Getting this device information Apr 28 14:55:58 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:55:58 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 14:55:58 rivo volumio[23941]: verbose: New Socket.io Connection to 192.168.178.103 from 192.168.178.104 UA: okhttp/4.9.2 Total Clients: 8 Apr 28 14:55:58 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:55:58 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 28 14:55:58 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 28 14:56:01 rivo sudo[27319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 28 14:56:01 rivo sudo[27319]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 14:56:01 rivo sudo[27319]: pam_unix(sudo:session): session closed for user root Apr 28 14:56:01 rivo sudo[27322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 28 14:56:01 rivo sudo[27322]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 14:56:01 rivo sudo[27322]: pam_unix(sudo:session): session closed for user root Apr 28 14:56:01 rivo volumio[23941]: verbose: New Socket.io Connection to 192.168.178.103 from 192.168.178.104 UA: okhttp/4.9.2 Total Clients: 9 Apr 28 14:56:01 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 28 14:56:01 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 28 14:56:01 rivo volumio[23941]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 14:56:01 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 14:56:01 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:56:01 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 14:56:02 rivo volumio[23941]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 28 14:56:02 rivo volumio[23941]: info: Received Get System Info Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 14:56:02 rivo volumio[23941]: info: Discovery: Getting this device information Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:56:02 rivo volumio[23941]: info: Listing playlists Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 28 14:56:02 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 28 14:56:03 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 14:56:03 rivo volumio[23941]: info: Received Get System Info Apr 28 14:56:03 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 14:56:03 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 14:56:03 rivo volumio[23941]: info: Discovery: Getting this device information Apr 28 14:56:03 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:56:03 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 14:56:03 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 28 14:56:05 rivo volumio[23941]: info: CoreCommandRouter::volumioPlay Apr 28 14:56:05 rivo volumio[23941]: info: CoreStateMachine::play index undefined Apr 28 14:56:05 rivo volumio[23941]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 14:56:05 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:05 rivo volumio[23941]: info: CoreStateMachine::startPlaybackTimer Apr 28 14:56:05 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:05 rivo volumio[23941]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 14:56:05 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 14:56:05 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 28 14:56:05 rivo volumio[23941]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22h-yvQFVf_ZU%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22Beethoven%20Klaviersonate%20Nr.30%2C%20E-Dur%2C%20op.109%20Edoardo%20Torbianelli%22%2C%22artist%22%3A%22Classics%20from%20Vienna%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2Fh-yvQFVf_ZU%2Fhq720.jpg%3Fsqp%3D-oaymwEcCNAFEJQDSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLDoPutiE6ErgW8mLoKs6ivolkq1Fg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22h-yvQFVf_ZU%22%7D%7D%7D Apr 28 14:56:05 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:05 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 14:56:05 rivo volumio[23941]: info: sendMpdCommand stop took 8 milliseconds Apr 28 14:56:05 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: info: sendMpdCommand clear took 4 milliseconds Apr 28 14:56:05 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand addid "https://rr2---sn-xq2oxu-5ogl.googlevideo.com/videoplayback?expire=1714330565&ei=ZUcuZpOvF66XvdIPsfS0iAE&ip=213.219.144.153&id=o-AA-OSSqLZlc80xby5G30vBeaEBF5aMo4_CWNWrFP5Qo-&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=AJ&mm=31%2C29&mn=sn-xq2oxu-5ogl%2Csn-5hne6nsd&ms=au%2Crdu&mv=m&mvi=2&pcm2cms=yes&pl=21&initcwndbps=1518750&bui=AWRWj2Q9PDweXQxH9VU7-ix-Q5Pce_CAXa_FSqvagwVrEtABVfAvQG3bHbA-8tYczxxWOeHD2iLHrXe6&spc=UWF9fybUPMYXgyuFxJpBSLijvskbfaW6hrVlbIingTCC_BMMqQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=SCb9r4eBDWT-qUkgypm7aogQ&gir=yes&clen=19352257&dur=1109.461&lmt=1712675367336676&mt=1714308541&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=5318224&n=IaK0n0dpHxT27w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAPWYBwdIY3jZuuxYR7qcJXDYZ-1Dy10UjdfiiINlPPnZAiEAq-bR5ay0DsYBYPuU2DCB-T_9yiI6xUuHJTmHA9biByM%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAOznFvHN_kjf8mbYDnrb4hoTMbS2g-uHd3d8euC6yRG2AiAu_aYMtx2uvpg0aLDn3b-g7sZsGBoGdi0k671ApgAGKA%3D%3D&cver=2.20230104.01.00&t.YouTube" Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: error: updateQueue error: null Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 15ms Apr 28 14:56:05 rivo volumio[23941]: info: sendMpdCommand addid "https://rr2---sn-xq2oxu-5ogl.googlevideo.com/videoplayback?expire=1714330565&ei=ZUcuZpOvF66XvdIPsfS0iAE&ip=213.219.144.153&id=o-AA-OSSqLZlc80xby5G30vBeaEBF5aMo4_CWNWrFP5Qo-&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=AJ&mm=31%2C29&mn=sn-xq2oxu-5ogl%2Csn-5hne6nsd&ms=au%2Crdu&mv=m&mvi=2&pcm2cms=yes&pl=21&initcwndbps=1518750&bui=AWRWj2Q9PDweXQxH9VU7-ix-Q5Pce_CAXa_FSqvagwVrEtABVfAvQG3bHbA-8tYczxxWOeHD2iLHrXe6&spc=UWF9fybUPMYXgyuFxJpBSLijvskbfaW6hrVlbIingTCC_BMMqQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=SCb9r4eBDWT-qUkgypm7aogQ&gir=yes&clen=19352257&dur=1109.461&lmt=1712675367336676&mt=1714308541&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=5318224&n=IaK0n0dpHxT27w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAPWYBwdIY3jZuuxYR7qcJXDYZ-1Dy10UjdfiiINlPPnZAiEAq-bR5ay0DsYBYPuU2DCB-T_9yiI6xUuHJTmHA9biByM%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAOznFvHN_kjf8mbYDnrb4hoTMbS2g-uHd3d8euC6yRG2AiAu_aYMtx2uvpg0aLDn3b-g7sZsGBoGdi0k671ApgAGKA%3D%3D&cver=2.20230104.01.00&t.YouTube" took 12 milliseconds Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 10ms Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 10ms Apr 28 14:56:05 rivo volumio[23941]: verbose: MPD COMMAND [object Object] Apr 28 14:56:05 rivo volumio[23941]: verbose: MPD COMMAND [object Object] Apr 28 14:56:05 rivo volumio[23941]: verbose: MPD COMMAND [object Object] Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 15ms Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 6ms Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 5ms Apr 28 14:56:05 rivo volumio[23941]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 28 14:56:05 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand play Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: info: Apr 28 14:56:05 rivo volumio[23941]: ---------------------------- MPD announces system playlist update Apr 28 14:56:05 rivo volumio[23941]: info: Ignoring MPD Status Update Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 9ms Apr 28 14:56:05 rivo volumio[23941]: info: sendMpdCommand play took 7 milliseconds Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 17ms Apr 28 14:56:05 rivo volumio[23941]: info: ------------------------------ 16ms Apr 28 14:56:06 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 14:56:06 rivo volumio[23941]: info: Received Get System Info Apr 28 14:56:06 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 14:56:06 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 14:56:06 rivo volumio[23941]: info: Discovery: Getting this device information Apr 28 14:56:06 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:56:06 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 14:56:07 rivo volumio[23941]: info: Apr 28 14:56:07 rivo volumio[23941]: ---------------------------- MPD announces state update: player Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::getState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand status Apr 28 14:56:07 rivo kernel: aml_tdm_open Apr 28 14:56:07 rivo kernel: Not init audio effects Apr 28 14:56:07 rivo volumio[23941]: info: Apr 28 14:56:07 rivo volumio[23941]: ---------------------------- MPD announces state update: player Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::getState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand status Apr 28 14:56:07 rivo volumio[23941]: info: Apr 28 14:56:07 rivo volumio[23941]: ---------------------------- MPD announces state update: player Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::getState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand status Apr 28 14:56:07 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Apr 28 14:56:07 rivo kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 Apr 28 14:56:07 rivo kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc050e9f818, id(1), clksel(1) Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_fmt(), fmt not change Apr 28 14:56:07 rivo kernel: dump_pcm_setting(ffffffc050e9f818) Apr 28 14:56:07 rivo kernel: pcm_mode(1) Apr 28 14:56:07 rivo kernel: sysclk(12288000) Apr 28 14:56:07 rivo kernel: sysclk_bclk_ratio(4) Apr 28 14:56:07 rivo kernel: bclk(3072000) Apr 28 14:56:07 rivo kernel: bclk_lrclk_ratio(64) Apr 28 14:56:07 rivo kernel: lrclk(48000) Apr 28 14:56:07 rivo kernel: tx_mask(0x3) Apr 28 14:56:07 rivo kernel: rx_mask(0x3) Apr 28 14:56:07 rivo kernel: slots(2) Apr 28 14:56:07 rivo kernel: slot_width(32) Apr 28 14:56:07 rivo kernel: lane_mask_in(0x2) Apr 28 14:56:07 rivo kernel: lane_mask_out(0x1) Apr 28 14:56:07 rivo kernel: lane_oe_mask_in(0x0) Apr 28 14:56:07 rivo kernel: lane_oe_mask_out(0x0) Apr 28 14:56:07 rivo kernel: lane_lb_mask_in(0x0) Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Apr 28 14:56:07 rivo kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 Apr 28 14:56:07 rivo kernel: aml_dai_set_clkdiv, div 4, clksel(1) Apr 28 14:56:07 rivo kernel: aml_dai_set_bclk_ratio, select I2S mode Apr 28 14:56:07 rivo kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B Apr 28 14:56:07 rivo kernel: aml_tdm_prepare(), reset fddr Apr 28 14:56:07 rivo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Apr 28 14:56:07 rivo kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 Apr 28 14:56:07 rivo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Apr 28 14:56:07 rivo kernel: tdm playback mute: 0, lane_cnt = 8 Apr 28 14:56:07 rivo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Apr 28 14:56:07 rivo kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Apr 28 14:56:07 rivo kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 Apr 28 14:56:07 rivo kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc050e9f818, id(1), clksel(1) Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_fmt(), fmt not change Apr 28 14:56:07 rivo kernel: dump_pcm_setting(ffffffc050e9f818) Apr 28 14:56:07 rivo kernel: pcm_mode(1) Apr 28 14:56:07 rivo kernel: sysclk(12288000) Apr 28 14:56:07 rivo kernel: sysclk_bclk_ratio(4) Apr 28 14:56:07 rivo kernel: bclk(3072000) Apr 28 14:56:07 rivo kernel: bclk_lrclk_ratio(64) Apr 28 14:56:07 rivo kernel: lrclk(48000) Apr 28 14:56:07 rivo kernel: tx_mask(0x3) Apr 28 14:56:07 rivo kernel: rx_mask(0x3) Apr 28 14:56:07 rivo kernel: slots(2) Apr 28 14:56:07 rivo kernel: slot_width(32) Apr 28 14:56:07 rivo kernel: lane_mask_in(0x2) Apr 28 14:56:07 rivo kernel: lane_mask_out(0x1) Apr 28 14:56:07 rivo kernel: lane_oe_mask_in(0x0) Apr 28 14:56:07 rivo kernel: lane_oe_mask_out(0x0) Apr 28 14:56:07 rivo kernel: lane_lb_mask_in(0x0) Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Apr 28 14:56:07 rivo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Apr 28 14:56:07 rivo kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 Apr 28 14:56:07 rivo kernel: aml_dai_set_clkdiv, div 4, clksel(1) Apr 28 14:56:07 rivo kernel: aml_dai_set_bclk_ratio, select I2S mode Apr 28 14:56:07 rivo kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B Apr 28 14:56:07 rivo kernel: aml_tdm_prepare(), reset fddr Apr 28 14:56:07 rivo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Apr 28 14:56:07 rivo kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 Apr 28 14:56:07 rivo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Apr 28 14:56:07 rivo kernel: tdm playback mute: 0, lane_cnt = 8 Apr 28 14:56:07 rivo kernel: aml_tdm_prepare(), reset fddr Apr 28 14:56:07 rivo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Apr 28 14:56:07 rivo kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 Apr 28 14:56:07 rivo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Apr 28 14:56:07 rivo kernel: tdm playback mute: 0, lane_cnt = 8 Apr 28 14:56:07 rivo kernel: asoc-aml-card auge_sound: tdm playback enable Apr 28 14:56:07 rivo kernel: spdif_a is set to enable Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand status took 9 milliseconds Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 14:56:07 rivo volumio[23941]: info: Apr 28 14:56:07 rivo volumio[23941]: ---------------------------- MPD announces state update: player Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::getState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand status Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand status took 12 milliseconds Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand status took 11 milliseconds Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseTrackInfo Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::servicePushState Apr 28 14:56:07 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:07 rivo volumio[23941]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1109,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beethoven Klaviersonate Nr.30, E-Dur, op.109 Edoardo Torbianelli","artist":"Classics from Vienna","album":"YouTube","uri":"https://rr2---sn-xq2oxu-5ogl.googlevideo.com/videoplayback?expire=1714330565&ei=ZUcuZpOvF66XvdIPsfS0iAE&ip=213.219.144.153&id=o-AA-OSSqLZlc80xby5G30vBeaEBF5aMo4_CWNWrFP5Qo-&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=AJ&mm=31%2C29&mn=sn-xq2oxu-5ogl%2Csn-5hne6nsd&ms=au%2Crdu&mv=m&mvi=2&pcm2cms=yes&pl=21&initcwndbps=1518750&bui=AWRWj2Q9PDweXQxH9VU7-ix-Q5Pce_CAXa_FSqvagwVrEtABVfAvQG3bHbA-8tYczxxWOeHD2iLHrXe6&spc=UWF9fybUPMYXgyuFxJpBSLijvskbfaW6hrVlbIingTCC_BMMqQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=SCb9r4eBDWT-qUkgypm7aogQ&gir=yes&clen=19352257&dur=1109.461&lmt=1712675367336676&mt=1714308541&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=5318224&n=IaK0n0dpHxT27w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAPWYBwdIY3jZuuxYR7qcJXDYZ-1Dy10UjdfiiINlPPnZAiEAq-bR5ay0DsYBYPuU2DCB-T_9yiI6xUuHJTmHA9biByM%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAOznFvHN_kjf8mbYDnrb4hoTMbS2g-uHd3d8euC6yRG2AiAu_aYMtx2uvpg0aLDn3b-g7sZsGBoGdi0k671ApgAGKA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 28 14:56:07 rivo volumio[23941]: verbose: CURRENT POSITION 0 Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState stateService play Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState currentStatus stop Apr 28 14:56:07 rivo volumio[23941]: info: ------------------------------ 33ms Apr 28 14:56:07 rivo volumio[23941]: info: Apr 28 14:56:07 rivo volumio[23941]: ---------------------------- MPD announces state update: player Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::getState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand status Apr 28 14:56:07 rivo volumio[23941]: info: Apr 28 14:56:07 rivo volumio[23941]: ---------------------------- MPD announces state update: player Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::getState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand status Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand status took 21 milliseconds Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand playlistinfo took 18 milliseconds Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand status took 6 milliseconds Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand status took 4 milliseconds Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseTrackInfo Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseTrackInfo Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseState Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::servicePushState Apr 28 14:56:07 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:07 rivo volumio[23941]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1109,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beethoven Klaviersonate Nr.30, E-Dur, op.109 Edoardo Torbianelli","artist":"Classics from Vienna","album":"YouTube","uri":"https://rr2---sn-xq2oxu-5ogl.googlevideo.com/videoplayback?expire=1714330565&ei=ZUcuZpOvF66XvdIPsfS0iAE&ip=213.219.144.153&id=o-AA-OSSqLZlc80xby5G30vBeaEBF5aMo4_CWNWrFP5Qo-&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=AJ&mm=31%2C29&mn=sn-xq2oxu-5ogl%2Csn-5hne6nsd&ms=au%2Crdu&mv=m&mvi=2&pcm2cms=yes&pl=21&initcwndbps=1518750&bui=AWRWj2Q9PDweXQxH9VU7-ix-Q5Pce_CAXa_FSqvagwVrEtABVfAvQG3bHbA-8tYczxxWOeHD2iLHrXe6&spc=UWF9fybUPMYXgyuFxJpBSLijvskbfaW6hrVlbIingTCC_BMMqQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=SCb9r4eBDWT-qUkgypm7aogQ&gir=yes&clen=19352257&dur=1109.461&lmt=1712675367336676&mt=1714308541&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=5318224&n=IaK0n0dpHxT27w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAPWYBwdIY3jZuuxYR7qcJXDYZ-1Dy10UjdfiiINlPPnZAiEAq-bR5ay0DsYBYPuU2DCB-T_9yiI6xUuHJTmHA9biByM%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAOznFvHN_kjf8mbYDnrb4hoTMbS2g-uHd3d8euC6yRG2AiAu_aYMtx2uvpg0aLDn3b-g7sZsGBoGdi0k671ApgAGKA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 28 14:56:07 rivo volumio[23941]: verbose: CURRENT POSITION 0 Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState stateService play Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState currentStatus play Apr 28 14:56:07 rivo volumio[23941]: info: Received an update from plugin. extracting info from payload Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::servicePushState Apr 28 14:56:07 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:07 rivo volumio[23941]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1109,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beethoven Klaviersonate Nr.30, E-Dur, op.109 Edoardo Torbianelli","artist":"Classics from Vienna","album":"YouTube","uri":"https://rr2---sn-xq2oxu-5ogl.googlevideo.com/videoplayback?expire=1714330565&ei=ZUcuZpOvF66XvdIPsfS0iAE&ip=213.219.144.153&id=o-AA-OSSqLZlc80xby5G30vBeaEBF5aMo4_CWNWrFP5Qo-&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=AJ&mm=31%2C29&mn=sn-xq2oxu-5ogl%2Csn-5hne6nsd&ms=au%2Crdu&mv=m&mvi=2&pcm2cms=yes&pl=21&initcwndbps=1518750&bui=AWRWj2Q9PDweXQxH9VU7-ix-Q5Pce_CAXa_FSqvagwVrEtABVfAvQG3bHbA-8tYczxxWOeHD2iLHrXe6&spc=UWF9fybUPMYXgyuFxJpBSLijvskbfaW6hrVlbIingTCC_BMMqQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=SCb9r4eBDWT-qUkgypm7aogQ&gir=yes&clen=19352257&dur=1109.461&lmt=1712675367336676&mt=1714308541&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=5318224&n=IaK0n0dpHxT27w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAPWYBwdIY3jZuuxYR7qcJXDYZ-1Dy10UjdfiiINlPPnZAiEAq-bR5ay0DsYBYPuU2DCB-T_9yiI6xUuHJTmHA9biByM%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAOznFvHN_kjf8mbYDnrb4hoTMbS2g-uHd3d8euC6yRG2AiAu_aYMtx2uvpg0aLDn3b-g7sZsGBoGdi0k671ApgAGKA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 28 14:56:07 rivo volumio[23941]: verbose: CURRENT POSITION 0 Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState stateService play Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState currentStatus play Apr 28 14:56:07 rivo volumio[23941]: info: Received an update from plugin. extracting info from payload Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: ------------------------------ 98ms Apr 28 14:56:07 rivo volumio[23941]: info: ------------------------------ 98ms Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand playlistinfo took 67 milliseconds Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand playlistinfo took 66 milliseconds Apr 28 14:56:07 rivo volumio[23941]: info: sendMpdCommand playlistinfo took 66 milliseconds Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseTrackInfo Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseTrackInfo Apr 28 14:56:07 rivo volumio[23941]: verbose: ControllerMpd::parseTrackInfo Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::servicePushState Apr 28 14:56:07 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:07 rivo volumio[23941]: verbose: STATE SERVICE {"status":"play","position":0,"seek":231,"duration":1109,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beethoven Klaviersonate Nr.30, E-Dur, op.109 Edoardo Torbianelli","artist":"Classics from Vienna","album":"YouTube","uri":"https://rr2---sn-xq2oxu-5ogl.googlevideo.com/videoplayback?expire=1714330565&ei=ZUcuZpOvF66XvdIPsfS0iAE&ip=213.219.144.153&id=o-AA-OSSqLZlc80xby5G30vBeaEBF5aMo4_CWNWrFP5Qo-&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=AJ&mm=31%2C29&mn=sn-xq2oxu-5ogl%2Csn-5hne6nsd&ms=au%2Crdu&mv=m&mvi=2&pcm2cms=yes&pl=21&initcwndbps=1518750&bui=AWRWj2Q9PDweXQxH9VU7-ix-Q5Pce_CAXa_FSqvagwVrEtABVfAvQG3bHbA-8tYczxxWOeHD2iLHrXe6&spc=UWF9fybUPMYXgyuFxJpBSLijvskbfaW6hrVlbIingTCC_BMMqQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=SCb9r4eBDWT-qUkgypm7aogQ&gir=yes&clen=19352257&dur=1109.461&lmt=1712675367336676&mt=1714308541&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=5318224&n=IaK0n0dpHxT27w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAPWYBwdIY3jZuuxYR7qcJXDYZ-1Dy10UjdfiiINlPPnZAiEAq-bR5ay0DsYBYPuU2DCB-T_9yiI6xUuHJTmHA9biByM%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAOznFvHN_kjf8mbYDnrb4hoTMbS2g-uHd3d8euC6yRG2AiAu_aYMtx2uvpg0aLDn3b-g7sZsGBoGdi0k671ApgAGKA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 28 14:56:07 rivo volumio[23941]: verbose: CURRENT POSITION 0 Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState stateService play Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState currentStatus play Apr 28 14:56:07 rivo volumio[23941]: info: Received an update from plugin. extracting info from payload Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::servicePushState Apr 28 14:56:07 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:07 rivo volumio[23941]: verbose: STATE SERVICE {"status":"play","position":0,"seek":231,"duration":1109,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beethoven Klaviersonate Nr.30, E-Dur, op.109 Edoardo Torbianelli","artist":"Classics from Vienna","album":"YouTube","uri":"https://rr2---sn-xq2oxu-5ogl.googlevideo.com/videoplayback?expire=1714330565&ei=ZUcuZpOvF66XvdIPsfS0iAE&ip=213.219.144.153&id=o-AA-OSSqLZlc80xby5G30vBeaEBF5aMo4_CWNWrFP5Qo-&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=AJ&mm=31%2C29&mn=sn-xq2oxu-5ogl%2Csn-5hne6nsd&ms=au%2Crdu&mv=m&mvi=2&pcm2cms=yes&pl=21&initcwndbps=1518750&bui=AWRWj2Q9PDweXQxH9VU7-ix-Q5Pce_CAXa_FSqvagwVrEtABVfAvQG3bHbA-8tYczxxWOeHD2iLHrXe6&spc=UWF9fybUPMYXgyuFxJpBSLijvskbfaW6hrVlbIingTCC_BMMqQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=SCb9r4eBDWT-qUkgypm7aogQ&gir=yes&clen=19352257&dur=1109.461&lmt=1712675367336676&mt=1714308541&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=5318224&n=IaK0n0dpHxT27w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAPWYBwdIY3jZuuxYR7qcJXDYZ-1Dy10UjdfiiINlPPnZAiEAq-bR5ay0DsYBYPuU2DCB-T_9yiI6xUuHJTmHA9biByM%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAOznFvHN_kjf8mbYDnrb4hoTMbS2g-uHd3d8euC6yRG2AiAu_aYMtx2uvpg0aLDn3b-g7sZsGBoGdi0k671ApgAGKA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 28 14:56:07 rivo volumio[23941]: verbose: CURRENT POSITION 0 Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState stateService play Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState currentStatus play Apr 28 14:56:07 rivo volumio[23941]: info: Received an update from plugin. extracting info from payload Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: ControllerMpd::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::servicePushState Apr 28 14:56:07 rivo volumio[23941]: info: CorePlayQueue::getTrack 0 Apr 28 14:56:07 rivo volumio[23941]: verbose: STATE SERVICE {"status":"play","position":0,"seek":231,"duration":1109,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beethoven Klaviersonate Nr.30, E-Dur, op.109 Edoardo Torbianelli","artist":"Classics from Vienna","album":"YouTube","uri":"https://rr2---sn-xq2oxu-5ogl.googlevideo.com/videoplayback?expire=1714330565&ei=ZUcuZpOvF66XvdIPsfS0iAE&ip=213.219.144.153&id=o-AA-OSSqLZlc80xby5G30vBeaEBF5aMo4_CWNWrFP5Qo-&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=AJ&mm=31%2C29&mn=sn-xq2oxu-5ogl%2Csn-5hne6nsd&ms=au%2Crdu&mv=m&mvi=2&pcm2cms=yes&pl=21&initcwndbps=1518750&bui=AWRWj2Q9PDweXQxH9VU7-ix-Q5Pce_CAXa_FSqvagwVrEtABVfAvQG3bHbA-8tYczxxWOeHD2iLHrXe6&spc=UWF9fybUPMYXgyuFxJpBSLijvskbfaW6hrVlbIingTCC_BMMqQ&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=SCb9r4eBDWT-qUkgypm7aogQ&gir=yes&clen=19352257&dur=1109.461&lmt=1712675367336676&mt=1714308541&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=5318224&n=IaK0n0dpHxT27w&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AJfQdSswRgIhAPWYBwdIY3jZuuxYR7qcJXDYZ-1Dy10UjdfiiINlPPnZAiEAq-bR5ay0DsYBYPuU2DCB-T_9yiI6xUuHJTmHA9biByM%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpcm2cms%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAOznFvHN_kjf8mbYDnrb4hoTMbS2g-uHd3d8euC6yRG2AiAu_aYMtx2uvpg0aLDn3b-g7sZsGBoGdi0k671ApgAGKA%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} Apr 28 14:56:07 rivo volumio[23941]: verbose: CURRENT POSITION 0 Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState stateService play Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::syncState currentStatus play Apr 28 14:56:07 rivo volumio[23941]: info: Received an update from plugin. extracting info from payload Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:07 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:07 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:07 rivo volumio[23941]: info: ------------------------------ 146ms Apr 28 14:56:07 rivo volumio[23941]: info: ------------------------------ 130ms Apr 28 14:56:07 rivo volumio[23941]: info: ------------------------------ 128ms Apr 28 14:56:07 rivo volumio[23941]: info: Signalling Playback active due to playback status change Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo volumio[23941]: info: MCU Signalled Playback Active Apr 28 14:56:07 rivo volumio[23941]: info: MCU Signalled Sleep Mode Disabled Apr 28 14:56:07 rivo sudo[27334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Apr 28 14:56:07 rivo sudo[27334]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo kernel: fb: osd[0] enable: 1 (Xorg) Apr 28 14:56:07 rivo kernel: fb: osd[0] enable: 1 (Xorg) Apr 28 14:56:07 rivo sudo[27334]: pam_unix(sudo:session): session closed for user root Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:07 rivo volumio[23941]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 28 14:56:15 rivo volumio[23941]: info: VolumeController::SetAlsaVolume100 Apr 28 14:56:15 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:15 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 14:56:15 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:15 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:15 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:15 rivo volumio[23941]: info: Signalling Playback active due to playback status change Apr 28 14:56:15 rivo volumio[23941]: info: Updating RAAT Signal Path Apr 28 14:56:15 rivo volumio[23941]: info: VolumeController::SetAlsaVolume100 Apr 28 14:56:15 rivo volumio[23941]: info: CoreStateMachine::pushState Apr 28 14:56:15 rivo volumio[23941]: info: CoreCommandRouter::volumioPushState Apr 28 14:56:15 rivo volumio[23941]: info: MRS: Pushing multiroomSync output update for this device Apr 28 14:56:15 rivo volumio[23941]: info: MRS: Pushing multiroomSync output Apr 28 14:56:15 rivo volumio[23941]: info: Signalling Playback active due to playback status change Apr 28 14:56:15 rivo volumio[23941]: info: Updating RAAT Signal Path Apr 28 14:56:19 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 28 14:56:19 rivo volumio[23941]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 28 14:56:19 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 28 14:56:19 rivo volumio[23941]: info: Received Get System Version Apr 28 14:56:19 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 14:56:19 rivo volumio[23941]: info: Received Get System Info Apr 28 14:56:19 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 14:56:19 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 14:56:19 rivo volumio[23941]: info: Discovery: Getting this device information Apr 28 14:56:19 rivo volumio[23941]: info: CoreCommandRouter::volumioGetState Apr 28 14:56:19 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 28 14:56:38 rivo ntpd[27072]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 14:56:41 rivo volumio[23941]: info: Retrieving Cloud Streaming UI Apr 28 14:56:41 rivo volumio[23941]: info: Getting Tidal Cloud Configuration Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 14:56:41 rivo volumio[23941]: info: Getting Qobuz Cloud Configuration Apr 28 14:56:41 rivo volumio[23941]: info: Asking plugin for UI Config Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 14:56:41 rivo volumio[23941]: info: Getting Spotify Cloud Configuration Apr 28 14:56:41 rivo volumio[23941]: info: Asking plugin for UI Config Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 14:56:41 rivo volumio[23941]: info: Saving Spotify Acccount Apr 28 14:56:41 rivo volumio[23941]: info: Got it Apr 28 14:56:41 rivo volumio[23941]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 28 14:56:41 rivo volumio[23941]: info: Got Tidal Cloud Configuration Apr 28 14:56:41 rivo volumio[23941]: info: Got it Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::volumioGetBrowseSources Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::volumioGetBrowseSources Apr 28 14:56:41 rivo volumio[23941]: info: CoreCommandRouter::volumioGetBrowseSources Apr 28 14:56:42 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 14:56:42 rivo mpd[24208]: exception: No database Apr 28 14:56:42 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 28 14:56:46 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 14:56:46 rivo mpd[24208]: exception: No database Apr 28 14:56:48 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 28 14:56:48 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 28 14:56:50 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 14:56:50 rivo mpd[24208]: exception: No database Apr 28 14:56:51 rivo volumio[23941]: info: Error browsing device fritz-box for shares : Error: Command failed: echo volumio | smbclient -L fritz.box. Apr 28 14:56:51 rivo volumio[23941]: Unable to initialize messaging context Apr 28 14:56:51 rivo volumio[23941]: info: Error browsing device 192-168-178-1 for shares : Error: Command failed: echo volumio | smbclient -L fritz.box. Apr 28 14:56:51 rivo volumio[23941]: Unable to initialize messaging context Apr 28 14:56:51 rivo volumio[23941]: info: Error browsing device iMac van Michaël for shares : Error: Command failed: echo volumio | smbclient -L iMac-van-Michael.local. Apr 28 14:56:51 rivo volumio[23941]: Unable to initialize messaging context Apr 28 14:56:54 rivo volumio[23941]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 14:56:54 rivo mpd[24208]: exception: No database Apr 28 14:56:54 rivo volumio[23941]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 14:56:54 rivo volumio[23941]: Error: dns service error: unknown Apr 28 14:56:54 rivo volumio[23941]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Apr 28 14:56:54 rivo volumio[23941]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Apr 28 14:56:54 rivo volumio[23941]: errorCode: -65537 Apr 28 14:56:54 rivo volumio[23941]: } Apr 28 14:56:54 rivo volumio[23941]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 14:56:54 rivo sudo[27405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-28 14:55 Apr 28 14:56:54 rivo sudo[27405]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:41:55 AM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b0437c7088d6645a661a49f6d9fa596a"