-- Logs begin at Sat 2024-11-23 11:23:28 CET, end at Sat 2024-11-23 12:31:24 CET. -- Nov 23 12:30:00 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:04 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:08 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:12 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:16 rivo volumio[15181]: error: error Nov 23 12:30:16 rivo volumio[15181]: error: error Nov 23 12:30:16 rivo volumio[15181]: error: error Nov 23 12:30:16 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:20 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:24 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:28 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:32 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:36 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:40 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:44 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:48 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:52 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:30:55 rivo volumio[15181]: info: CALLMETHOD: miscellanea my_music updateMusicLibrarySupersearchSources [object Object] Nov 23 12:30:55 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibrarySupersearchSources Nov 23 12:30:55 rivo volumio[15181]: info: CoreCommandRouter::volumioGetBrowseSources Nov 23 12:30:55 rivo volumio[15181]: info: CoreCommandRouter::volumioGetBrowseSources Nov 23 12:30:56 rivo volumio[15181]: info: CoreCommandRouter::updateGlobalSearchableBrowseSources Nov 23 12:30:56 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:31:00 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:31:04 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:31:08 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::sendMpdCommand update Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::sendMpdCommand status Nov 23 12:31:12 rivo volumio[15181]: info: Nov 23 12:31:12 rivo volumio[15181]: ---------------------------- MPD announces state update: update Nov 23 12:31:12 rivo volumio[15181]: info: sendMpdCommand update took 14 milliseconds Nov 23 12:31:12 rivo volumio[15181]: info: ControllerMpd::getState Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::sendMpdCommand status Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::sendMpdCommand status Nov 23 12:31:12 rivo volumio[15181]: info: Nov 23 12:31:12 rivo volumio[15181]: ---------------------------- MPD announces state update: update Nov 23 12:31:12 rivo volumio[15181]: info: ControllerMpd::getState Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::sendMpdCommand status Nov 23 12:31:12 rivo volumio[15181]: info: sendMpdCommand status took 9 milliseconds Nov 23 12:31:12 rivo volumio[15181]: info: sendMpdCommand status took 7 milliseconds Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::parseState Nov 23 12:31:12 rivo volumio[15181]: info: Command Router : Notfying DB Updatefalse Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::Close All Modals sent Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::parseState Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 12:31:12 rivo volumio[15181]: info: sendMpdCommand status took 72 milliseconds Nov 23 12:31:12 rivo volumio[15181]: info: sendMpdCommand status took 70 milliseconds Nov 23 12:31:12 rivo volumio[15181]: info: sendMpdCommand playlistinfo took 13 milliseconds Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::parseState Nov 23 12:31:12 rivo volumio[15181]: info: Command Router : Notfying DB Updatefalse Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::Close All Modals sent Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::parseState Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::parseTrackInfo Nov 23 12:31:12 rivo volumio[15181]: info: ControllerMpd::pushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::servicePushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::pushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::volumioPushState Nov 23 12:31:12 rivo volumio[15181]: info: CorePlayQueue::getTrack 1 Nov 23 12:31:12 rivo volumio[15181]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"O0$1$8I16230657.flac","artist":null,"album":null,"uri":"http://192.168.0.110:9000/disk/NON-DLNA-OP01-FLAGS01700000/O0$1$8I16230657.flac","trackType":"flac"} Nov 23 12:31:12 rivo volumio[15181]: verbose: CURRENT POSITION 1 Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::syncState stateService stop Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::syncState currentStatus stop Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::pushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::volumioPushState Nov 23 12:31:12 rivo volumio[15181]: info: No code Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::pushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::volumioPushState Nov 23 12:31:12 rivo volumio[15181]: info: ------------------------------ 174ms Nov 23 12:31:12 rivo volumio[15181]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Nov 23 12:31:12 rivo volumio[15181]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Nov 23 12:31:12 rivo volumio[15181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 23 12:31:12 rivo volumio[15181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 23 12:31:12 rivo volumio[15181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 23 12:31:12 rivo volumio[15181]: info: sendMpdCommand playlistinfo took 102 milliseconds Nov 23 12:31:12 rivo volumio[15181]: verbose: ControllerMpd::parseTrackInfo Nov 23 12:31:12 rivo volumio[15181]: info: ControllerMpd::pushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::servicePushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::pushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::volumioPushState Nov 23 12:31:12 rivo volumio[15181]: info: CorePlayQueue::getTrack 1 Nov 23 12:31:12 rivo volumio[15181]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"O0$1$8I16230657.flac","artist":null,"album":null,"uri":"http://192.168.0.110:9000/disk/NON-DLNA-OP01-FLAGS01700000/O0$1$8I16230657.flac","trackType":"flac"} Nov 23 12:31:12 rivo volumio[15181]: verbose: CURRENT POSITION 1 Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::syncState stateService stop Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::syncState currentStatus stop Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::pushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::volumioPushState Nov 23 12:31:12 rivo volumio[15181]: info: No code Nov 23 12:31:12 rivo volumio[15181]: info: CoreStateMachine::pushState Nov 23 12:31:12 rivo volumio[15181]: info: CoreCommandRouter::volumioPushState Nov 23 12:31:12 rivo volumio[15181]: info: ------------------------------ 273ms Nov 23 12:31:12 rivo volumio[15181]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Nov 23 12:31:12 rivo volumio[15181]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Nov 23 12:31:12 rivo volumio[15181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 23 12:31:12 rivo volumio[15181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 23 12:31:12 rivo volumio[15181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 23 12:31:14 rivo volumio[15181]: info: Executing endpoint metavolumio Nov 23 12:31:14 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 23 12:31:16 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:31:20 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 23 12:31:22 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 23 12:31:22 rivo volumio[15181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 23 12:31:23 rivo volumio[15181]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 12:31:23 rivo volumio[15181]: Error: getaddrinfo -3007 Nov 23 12:31:23 rivo volumio[15181]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Nov 23 12:31:23 rivo volumio[15181]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Nov 23 12:31:23 rivo volumio[15181]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Nov 23 12:31:23 rivo volumio[15181]: code: -3007, Nov 23 12:31:23 rivo volumio[15181]: errno: -3007, Nov 23 12:31:23 rivo volumio[15181]: syscall: 'getaddrinfo' Nov 23 12:31:23 rivo volumio[15181]: } Nov 23 12:31:23 rivo volumio[15181]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 23 12:31:24 rivo sudo[16237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-23 12:30 Nov 23 12:31:24 rivo sudo[16237]: 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"