-- Logs begin at Sat 2024-10-26 17:02:48 CEST, end at Sun 2024-10-27 00:12:56 CEST. -- Oct 27 00:12:38 jukebox volumio[973]: verbose: New Socket.io Connection to 192.168.10.111:3000 from 192.168.11.118 UA: Dalvik/2.1.0 (Linux; U; Android 14; SM-S901B Build/UP1A.231005.007) Engine version: 3 Transport: polling Total Clients: 7 Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::volumioGetQueue Oct 27 00:12:38 jukebox volumio[973]: info: CoreStateMachine::getQueue Oct 27 00:12:38 jukebox volumio[973]: info: CorePlayQueue::getQueue Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 27 00:12:38 jukebox volumio[973]: info: In handleBrowseUri, curUri=spotify/myalbums Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::volumioGetState Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::volumioGetState Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::volumioGetVisibleSources Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 27 00:12:38 jukebox volumio[973]: info: Getting Alsa Cards List without I2S DAC Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 27 00:12:38 jukebox volumio[973]: info: In handleBrowseUri, curUri=spotify/myalbums Oct 27 00:12:38 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 27 00:12:52 jukebox volumio[973]: info: Oct 27 00:12:52 jukebox volumio[973]: ---------------------------- MPD announces system playlist update Oct 27 00:12:52 jukebox volumio[973]: info: Ignoring MPD Status Update Oct 27 00:12:52 jukebox volumio[973]: info: Oct 27 00:12:52 jukebox volumio[973]: ---------------------------- MPD announces state update: player Oct 27 00:12:52 jukebox volumio[973]: info: ControllerMpd::getState Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Oct 27 00:12:52 jukebox volumio[973]: info: Oct 27 00:12:52 jukebox volumio[973]: ---------------------------- MPD announces system playlist update Oct 27 00:12:52 jukebox volumio[973]: info: Ignoring MPD Status Update Oct 27 00:12:52 jukebox volumio[973]: info: Oct 27 00:12:52 jukebox volumio[973]: ---------------------------- MPD announces state update: player Oct 27 00:12:52 jukebox volumio[973]: info: ControllerMpd::getState Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Oct 27 00:12:52 jukebox volumio[973]: info: Oct 27 00:12:52 jukebox volumio[973]: ---------------------------- MPD announces system playlist update Oct 27 00:12:52 jukebox volumio[973]: info: Ignoring MPD Status Update Oct 27 00:12:52 jukebox volumio[973]: info: Oct 27 00:12:52 jukebox volumio[973]: ---------------------------- MPD announces state update: player Oct 27 00:12:52 jukebox volumio[973]: info: ControllerMpd::getState Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Oct 27 00:12:52 jukebox volumio[973]: info: Oct 27 00:12:52 jukebox volumio[973]: ---------------------------- MPD announces system playlist update Oct 27 00:12:52 jukebox volumio[973]: info: Ignoring MPD Status Update Oct 27 00:12:52 jukebox volumio[973]: info: Oct 27 00:12:52 jukebox volumio[973]: ---------------------------- MPD announces state update: player Oct 27 00:12:52 jukebox volumio[973]: info: ControllerMpd::getState Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::sendMpdCommand status Oct 27 00:12:52 jukebox volumio[973]: info: ------------------------------ 9ms Oct 27 00:12:52 jukebox volumio[973]: info: sendMpdCommand status took 8 milliseconds Oct 27 00:12:52 jukebox volumio[973]: info: ------------------------------ 7ms Oct 27 00:12:52 jukebox volumio[973]: info: sendMpdCommand status took 6 milliseconds Oct 27 00:12:52 jukebox volumio[973]: info: ------------------------------ 6ms Oct 27 00:12:52 jukebox volumio[973]: info: sendMpdCommand status took 6 milliseconds Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::parseState Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::parseState Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::parseState Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 00:12:52 jukebox volumio[973]: info: ------------------------------ 7ms Oct 27 00:12:52 jukebox volumio[973]: info: sendMpdCommand status took 7 milliseconds Oct 27 00:12:52 jukebox volumio[973]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 00:12:52 jukebox volumio[973]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 00:12:52 jukebox volumio[973]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::parseState Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::parseTrackInfo Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::parseTrackInfo Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::parseTrackInfo Oct 27 00:12:52 jukebox volumio[973]: info: ControllerMpd::pushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::servicePushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreStateMachine::pushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::volumioPushState Oct 27 00:12:52 jukebox volumio[973]: info: ControllerMpd::pushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::servicePushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreStateMachine::pushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::volumioPushState Oct 27 00:12:52 jukebox volumio[973]: info: ControllerMpd::pushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::servicePushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreStateMachine::pushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::volumioPushState Oct 27 00:12:52 jukebox volumio[973]: info: ------------------------------ 24ms Oct 27 00:12:52 jukebox volumio[973]: info: ------------------------------ 23ms Oct 27 00:12:52 jukebox volumio[973]: info: ------------------------------ 21ms Oct 27 00:12:52 jukebox volumio[973]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 27 00:12:52 jukebox volumio[973]: verbose: ControllerMpd::parseTrackInfo Oct 27 00:12:52 jukebox volumio[973]: info: ControllerMpd::pushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::servicePushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreStateMachine::pushState Oct 27 00:12:52 jukebox volumio[973]: info: CoreCommandRouter::volumioPushState Oct 27 00:12:52 jukebox volumio[973]: info: ------------------------------ 25ms Oct 27 00:12:52 jukebox volumio[973]: info: FusionDsp - volume level for loudness 31 gain applied 9.71 Oct 27 00:12:52 jukebox volumio[973]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 27 00:12:52 jukebox volumio[973]: info: FusionDsp - crossfeed jameier Oct 27 00:12:52 jukebox volumio[973]: info: FusionDsp - Loudness is ON true Oct 27 00:12:52 jukebox volumio[973]: info: FusionDsp - volume level for loudness 31 gain applied 9.71 Oct 27 00:12:52 jukebox volumio[973]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 27 00:12:52 jukebox volumio[973]: info: FusionDsp - crossfeed jameier Oct 27 00:12:52 jukebox volumio[973]: info: FusionDsp - Loudness is ON true Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - volume level for loudness 31 gain applied 9.71 Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - crossfeed jameier Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - Loudness is ON true Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - volume level for loudness 31 gain applied 9.71 Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - crossfeed jameier Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - Loudness is ON true Oct 27 00:12:53 jukebox volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Oct 27 00:12:53 jukebox volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Oct 27 00:12:53 jukebox volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Oct 27 00:12:53 jukebox volumio[973]: SPOTIFY: RECEIVED VOLUMIO VOLUME 31 Oct 27 00:12:53 jukebox volumio[973]: verbose: New Socket.io Connection to 192.168.10.111:3000 from 192.168.11.118 UA: Dalvik/2.1.0 (Linux; U; Android 14; SM-S901B Build/UP1A.231005.007) Engine version: 3 Transport: polling Total Clients: 7 Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 27 00:12:53 jukebox volumio[973]: info: FusionDsp - {"Reload":{"result":"Ok"}} Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::volumioGetQueue Oct 27 00:12:53 jukebox volumio[973]: info: CoreStateMachine::getQueue Oct 27 00:12:53 jukebox volumio[973]: info: CorePlayQueue::getQueue Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 27 00:12:53 jukebox volumio[973]: info: In handleBrowseUri, curUri=spotify/myalbums Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::volumioGetState Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::volumioGetState Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::volumioGetState Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::volumioGetState Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::volumioGetVisibleSources Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 27 00:12:53 jukebox volumio[973]: info: Getting Alsa Cards List without I2S DAC Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Oct 27 00:12:53 jukebox volumio[973]: info: In handleBrowseUri, curUri=spotify/myalbums Oct 27 00:12:53 jukebox volumio[973]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 27 00:12:55 jukebox volumio[973]: info: [1729980775671] [80s80s] Pushing the next song state Texas - Summer Son and getting next track. Oct 27 00:12:55 jukebox volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 00:12:55 jukebox volumio[973]: TypeError: Cannot set property 'name' of undefined Oct 27 00:12:55 jukebox volumio[973]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Oct 27 00:12:55 jukebox volumio[973]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Oct 27 00:12:55 jukebox volumio[973]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Oct 27 00:12:55 jukebox volumio[973]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Oct 27 00:12:55 jukebox volumio[973]: at processImmediate (internal/timers.js:461:21) Oct 27 00:12:55 jukebox volumio[973]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 00:12:56 jukebox sudo[23794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-27 00:11 Oct 27 00:12:56 jukebox sudo[23794]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"