-- Logs begin at Thu 2024-08-08 17:39:07 UTC, end at Sun 2024-09-01 12:20:58 UTC. -- Sep 01 12:19:00 integro wpa_supplicant[3161]: wlan0: WPA: Group rekeying completed with d4:24:dd:1e:0d:5b [GTK=CCMP] Sep 01 12:20:04 integro volumio[3260]: info: CorePlayQueue::getTrack 11 Sep 01 12:20:04 integro volumio[3260]: info: CorePlayQueue::getTrack 12 Sep 01 12:20:20 integro kernel: asoc-aml-card auge_sound: tdm playback stop Sep 01 12:20:20 integro kernel: spdif_a is set to disable Sep 01 12:20:20 integro kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Sep 01 12:20:20 integro kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B Sep 01 12:20:20 integro kernel: tdm playback mute: 1, lane_cnt = 8 Sep 01 12:20:20 integro kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Sep 01 12:20:20 integro volumio[3260]: info: Sep 01 12:20:20 integro volumio[3260]: ---------------------------- MPD announces system playlist update Sep 01 12:20:20 integro volumio[3260]: info: Ignoring MPD Status Update Sep 01 12:20:20 integro volumio[3260]: info: Sep 01 12:20:20 integro volumio[3260]: ---------------------------- MPD announces state update: player Sep 01 12:20:20 integro volumio[3260]: info: ControllerMpd::getState Sep 01 12:20:20 integro volumio[3260]: verbose: ControllerMpd::sendMpdCommand status Sep 01 12:20:20 integro volumio[3260]: error: updateQueue error: null Sep 01 12:20:20 integro volumio[3260]: info: ------------------------------ 3ms Sep 01 12:20:20 integro volumio[3260]: info: sendMpdCommand status took 2 milliseconds Sep 01 12:20:20 integro volumio[3260]: verbose: ControllerMpd::parseState Sep 01 12:20:20 integro volumio[3260]: info: ControllerMpd::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::servicePushState Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::volumioPushState Sep 01 12:20:20 integro volumio[3260]: info: CorePlayQueue::getTrack 11 Sep 01 12:20:20 integro volumio[3260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 01 12:20:20 integro volumio[3260]: verbose: CURRENT POSITION 11 Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::syncState stateService stop Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::syncState currentStatus play Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::volumioPushState Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::stPlaybackTimer Sep 01 12:20:20 integro volumio[3260]: info: ------------------------------ 25ms Sep 01 12:20:20 integro volumio[3260]: info: Sep 01 12:20:20 integro volumio[3260]: ---------------------------- MPD announces system playlist update Sep 01 12:20:20 integro volumio[3260]: info: Ignoring MPD Status Update Sep 01 12:20:20 integro volumio[3260]: info: Sep 01 12:20:20 integro volumio[3260]: ---------------------------- MPD announces state update: player Sep 01 12:20:20 integro volumio[3260]: info: ControllerMpd::getState Sep 01 12:20:20 integro volumio[3260]: verbose: ControllerMpd::sendMpdCommand status Sep 01 12:20:20 integro volumio[3260]: info: Sep 01 12:20:20 integro volumio[3260]: ---------------------------- MPD announces system playlist update Sep 01 12:20:20 integro volumio[3260]: info: Ignoring MPD Status Update Sep 01 12:20:20 integro volumio[3260]: info: Sep 01 12:20:20 integro volumio[3260]: ---------------------------- MPD announces state update: player Sep 01 12:20:20 integro volumio[3260]: info: ControllerMpd::getState Sep 01 12:20:20 integro volumio[3260]: verbose: ControllerMpd::sendMpdCommand status Sep 01 12:20:20 integro volumio[3260]: error: updateQueue error: null Sep 01 12:20:20 integro volumio[3260]: error: updateQueue error: null Sep 01 12:20:20 integro volumio[3260]: info: ------------------------------ 6ms Sep 01 12:20:20 integro volumio[3260]: info: sendMpdCommand status took 5 milliseconds Sep 01 12:20:20 integro volumio[3260]: info: ------------------------------ 4ms Sep 01 12:20:20 integro volumio[3260]: info: sendMpdCommand status took 2 milliseconds Sep 01 12:20:20 integro volumio[3260]: verbose: ControllerMpd::parseState Sep 01 12:20:20 integro volumio[3260]: verbose: ControllerMpd::parseState Sep 01 12:20:20 integro volumio[3260]: info: ControllerMpd::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::servicePushState Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::volumioPushState Sep 01 12:20:20 integro volumio[3260]: info: CorePlayQueue::getTrack 0 Sep 01 12:20:20 integro volumio[3260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 01 12:20:20 integro volumio[3260]: verbose: CURRENT POSITION 0 Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::syncState stateService stop Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::syncState currentStatus stop Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::volumioPushState Sep 01 12:20:20 integro volumio[3260]: info: No code Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::volumioPushState Sep 01 12:20:20 integro volumio[3260]: info: ControllerMpd::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::servicePushState Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::volumioPushState Sep 01 12:20:20 integro volumio[3260]: info: CorePlayQueue::getTrack 0 Sep 01 12:20:20 integro volumio[3260]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 01 12:20:20 integro volumio[3260]: verbose: CURRENT POSITION 0 Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::syncState stateService stop Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::syncState currentStatus stop Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::volumioPushState Sep 01 12:20:20 integro volumio[3260]: info: No code Sep 01 12:20:20 integro volumio[3260]: info: CoreStateMachine::pushState Sep 01 12:20:20 integro volumio[3260]: info: CoreCommandRouter::volumioPushState Sep 01 12:20:20 integro volumio[3260]: info: ------------------------------ 63ms Sep 01 12:20:20 integro volumio[3260]: info: ------------------------------ 62ms Sep 01 12:20:20 integro volumio[3260]: info: Signalling Playback active due to playback status change Sep 01 12:20:20 integro volumio[3260]: info: MCU Signalled Playback Inactive Sep 01 12:20:24 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 01 12:20:24 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 01 12:20:24 integro volumio[3260]: info: Discovery: Getting this device information Sep 01 12:20:24 integro volumio[3260]: info: CoreCommandRouter::volumioGetState Sep 01 12:20:24 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 01 12:20:24 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 01 12:20:24 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 01 12:20:24 integro volumio[3260]: info: Discovery: Getting this device information Sep 01 12:20:24 integro volumio[3260]: info: CoreCommandRouter::volumioGetState Sep 01 12:20:24 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 01 12:20:24 integro volumio[3260]: verbose: New Socket.io Connection to 192.168.3.190:3000 from 192.168.3.198 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Sep 01 12:20:25 integro volumio[3260]: verbose: New Socket.io Connection to 192.168.3.190 from 192.168.3.198 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_6_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::volumioGetVisibleSources Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::volumioGetState Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::volumioGetQueue Sep 01 12:20:25 integro volumio[3260]: info: CoreStateMachine::getQueue Sep 01 12:20:25 integro volumio[3260]: info: CorePlayQueue::getQueue Sep 01 12:20:25 integro volumio[3260]: info: Listing playlists Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Sep 01 12:20:25 integro volumio[3260]: info: Received Get System Info Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 01 12:20:25 integro volumio[3260]: info: Discovery: Getting this device information Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::volumioGetState Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::volumioGetState Sep 01 12:20:25 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 01 12:20:30 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 01 12:20:30 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 01 12:20:30 integro volumio[3260]: info: Discovery: Getting this device information Sep 01 12:20:30 integro volumio[3260]: info: CoreCommandRouter::volumioGetState Sep 01 12:20:30 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 01 12:20:46 integro ntpd[3253]: 31.209.85.242 local addr 192.168.3.190 -> Sep 01 12:20:54 integro ntpd[3253]: 176.9.157.155 local addr 192.168.3.190 -> Sep 01 12:20:58 integro volumio[3260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Sep 01 12:20:58 integro volumio[3260]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 12:20:58 integro volumio[3260]: TypeError: Cannot read property 'then' of undefined Sep 01 12:20:58 integro volumio[3260]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:498:20) Sep 01 12:20:58 integro volumio[3260]: at Socket.emit (events.js:400:28) Sep 01 12:20:58 integro volumio[3260]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Sep 01 12:20:58 integro volumio[3260]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Sep 01 12:20:58 integro volumio[3260]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 12:20:58 integro sudo[5548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 12:19 Sep 01 12:20:58 integro sudo[5548]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="integro" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 01 Aug 2024 05:17:04 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Integro" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Integro" VOLUMIO_HASH="56b9d3932cd0f553ab78e4b3e169d42c"