-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Wed 2023-09-20 22:41:25 UTC. -- Sep 20 22:41:15 player-etaj volumio[5225]: info: MRS: Updating multiroomSync output Sep 20 22:41:17 player-etaj volumio[5225]: info: MRS: Updating multiroomSync output Sep 20 22:41:21 player-etaj volumio[5225]: info: Airplay started streaming, receiving metadatas Sep 20 22:41:21 player-etaj volumio[5225]: info: Airplay started streaming, receiving metadatas Sep 20 22:41:21 player-etaj volumio[5225]: info: Airplay started streaming, receiving metadatas Sep 20 22:41:21 player-etaj shairport-sync[6241]: {"time":1693400501070,"response":"stopAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Sep 20 22:41:21 player-etaj shairport-sync[6241]: Dload Upload Total Spent Left Speed Sep 20 22:41:21 player-etaj volumio[5225]: info: Sep 20 22:41:21 player-etaj volumio[5225]: ---------------------------- Client requests Start Airplay PlaybackRoutine Sep 20 22:41:21 player-etaj volumio[5225]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Sep 20 22:41:21 player-etaj volumio[5225]: info: Airplay playback start Sep 20 22:41:21 player-etaj shairport-sync[6241]: [158B blob data] Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:22 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:22 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:22 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:22 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:22 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:22 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:22 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:22 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:22 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:22 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:22 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:22 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:22 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:23 player-etaj shairport-sync[6241]: {"time":1695249681145,"response":"startAirplayPlayback Success"}ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:294:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 65536 Sep 20 22:41:23 player-etaj shairport-sync[6241]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:305:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 65536 Sep 20 22:41:23 player-etaj kernel: aml_tdm_open Sep 20 22:41:23 player-etaj kernel: Not init audio effects Sep 20 22:41:23 player-etaj kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Sep 20 22:41:23 player-etaj kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Sep 20 22:41:23 player-etaj kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Sep 20 22:41:23 player-etaj kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Sep 20 22:41:23 player-etaj kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc0503a8618, id(1), clksel(1) Sep 20 22:41:23 player-etaj kernel: aml_dai_set_tdm_fmt(), fmt not change Sep 20 22:41:23 player-etaj kernel: dump_pcm_setting(ffffffc0503a8618) Sep 20 22:41:23 player-etaj kernel: pcm_mode(1) Sep 20 22:41:23 player-etaj kernel: sysclk(11289600) Sep 20 22:41:23 player-etaj kernel: sysclk_bclk_ratio(4) Sep 20 22:41:23 player-etaj kernel: bclk(2822400) Sep 20 22:41:23 player-etaj kernel: bclk_lrclk_ratio(64) Sep 20 22:41:23 player-etaj kernel: lrclk(44100) Sep 20 22:41:23 player-etaj kernel: tx_mask(0x3) Sep 20 22:41:23 player-etaj kernel: rx_mask(0x3) Sep 20 22:41:23 player-etaj kernel: slots(2) Sep 20 22:41:23 player-etaj kernel: slot_width(32) Sep 20 22:41:23 player-etaj kernel: lane_mask_in(0x2) Sep 20 22:41:23 player-etaj kernel: lane_mask_out(0x1) Sep 20 22:41:23 player-etaj kernel: lane_oe_mask_in(0x0) Sep 20 22:41:23 player-etaj kernel: lane_oe_mask_out(0x0) Sep 20 22:41:23 player-etaj kernel: lane_lb_mask_in(0x0) Sep 20 22:41:23 player-etaj kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Sep 20 22:41:23 player-etaj kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Sep 20 22:41:23 player-etaj kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Sep 20 22:41:23 player-etaj kernel: aml_dai_set_clkdiv, div 4, clksel(1) Sep 20 22:41:23 player-etaj kernel: aml_dai_set_bclk_ratio, select I2S mode Sep 20 22:41:23 player-etaj kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B Sep 20 22:41:23 player-etaj kernel: aml_tdm_prepare(), reset fddr Sep 20 22:41:23 player-etaj kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Sep 20 22:41:23 player-etaj kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Sep 20 22:41:23 player-etaj kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Sep 20 22:41:23 player-etaj kernel: tdm playback mute: 0, lane_cnt = 8 Sep 20 22:41:23 player-etaj kernel: aml_tdm_prepare(), reset fddr Sep 20 22:41:23 player-etaj kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Sep 20 22:41:23 player-etaj kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Sep 20 22:41:23 player-etaj kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Sep 20 22:41:23 player-etaj kernel: tdm playback mute: 0, lane_cnt = 8 Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:23 player-etaj kernel: asoc-aml-card auge_sound: tdm playback enable Sep 20 22:41:23 player-etaj kernel: spdif_a is set to enable Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::servicePushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreStateMachine::pushState Sep 20 22:41:23 player-etaj volumio[5225]: info: CoreCommandRouter::volumioPushState Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output update for this device Sep 20 22:41:23 player-etaj volumio[5225]: info: MRS: Pushing multiroomSync output Sep 20 22:41:23 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:23 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:23 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:23 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:23 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:23 player-etaj volumio[5225]: info: Updating RAAT Signal Path Sep 20 22:41:24 player-etaj volumio[5225]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 20 22:41:24 player-etaj volumio[5225]: Error: certificate is not yet valid Sep 20 22:41:24 player-etaj volumio[5225]: at TLSSocket.onConnectSecure (_tls_wrap.js:1515:34) Sep 20 22:41:24 player-etaj volumio[5225]: at TLSSocket.emit (events.js:400:28) Sep 20 22:41:24 player-etaj volumio[5225]: at TLSSocket._finishInit (_tls_wrap.js:937:8) Sep 20 22:41:24 player-etaj volumio[5225]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:709:12) { Sep 20 22:41:24 player-etaj volumio[5225]: code: 'CERT_NOT_YET_VALID' Sep 20 22:41:24 player-etaj volumio[5225]: } Sep 20 22:41:24 player-etaj volumio[5225]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 20 22:41:25 player-etaj sudo[4966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-09-20 22:40 Sep 20 22:41:25 player-etaj sudo[4966]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="8e6823482d6af342172ec9fdc1c15b0dd02653d2" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="primo2rev2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 04 Dec 2022 09:59:37 PM CET" VOLUMIO_VERSION="3.396" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Primo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Primo" VOLUMIO_HASH="b826d64016be7ccf4914ae3c553cf7c9"