-- Logs begin at Thu 2024-11-28 12:40:32 CET, end at Thu 2024-11-28 14:08:05 CET. -- Nov 28 14:07:20 rivo volumio[3113]: info: Adding http://192.168.50.1:8200/MediaItems/2222.flac to favourites using generic method Nov 28 14:07:20 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , lsInfo Nov 28 14:07:20 rivo volumio[3113]: error: Failed LSINFO: Error: [52@0] {lsinfo} Failed to access /192.168.50.1:8200/MediaItems/2222.flac: No such file or directory Nov 28 14:07:20 rivo volumio[3113]: info: Saving local item favourites Nov 28 14:07:20 rivo volumio[3113]: info: Pushing Favourites {"uri":"http://192.168.50.1:8200/MediaItems/2222.flac","favourite":false} Nov 28 14:07:20 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 14:07:20 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 14:07:20 rivo volumio[3113]: info: Discovery: Getting this device information Nov 28 14:07:20 rivo volumio[3113]: info: CoreCommandRouter::volumioGetState Nov 28 14:07:20 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::volumioPause Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::pause Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::stPlaybackTimer Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::servicePause Nov 28 14:07:23 rivo volumio[3113]: info: CorePlayQueue::getTrack 0 Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::servicePause Nov 28 14:07:23 rivo volumio[3113]: info: [1732799243514] ControllerUPNPBrowser::pause Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::sendMpdCommand pause Nov 28 14:07:23 rivo volumio[3113]: info: Nov 28 14:07:23 rivo volumio[3113]: ---------------------------- MPD announces state update: player Nov 28 14:07:23 rivo kernel: asoc-aml-card auge_sound: S/PDIF Playback disable Nov 28 14:07:23 rivo kernel: spdif_a keep clk continuous Nov 28 14:07:23 rivo kernel: aml_spdif_close Nov 28 14:07:23 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Nov 28 14:07:23 rivo volumio[3113]: info: sendMpdCommand pause took 5 milliseconds Nov 28 14:07:23 rivo volumio[3113]: info: ControllerMpd::getState Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Nov 28 14:07:23 rivo volumio[3113]: info: Nov 28 14:07:23 rivo volumio[3113]: ---------------------------- MPD announces state update: player Nov 28 14:07:23 rivo volumio[3113]: info: ControllerMpd::getState Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Nov 28 14:07:23 rivo volumio[3113]: info: Nov 28 14:07:23 rivo volumio[3113]: ---------------------------- MPD announces state update: player Nov 28 14:07:23 rivo volumio[3113]: info: ControllerMpd::getState Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::sendMpdCommand status Nov 28 14:07:23 rivo volumio[3113]: info: sendMpdCommand status took 5 milliseconds Nov 28 14:07:23 rivo volumio[3113]: info: sendMpdCommand status took 4 milliseconds Nov 28 14:07:23 rivo volumio[3113]: info: sendMpdCommand status took 2 milliseconds Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::parseState Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::parseState Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::parseState Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 28 14:07:23 rivo volumio[3113]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 28 14:07:23 rivo volumio[3113]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 28 14:07:23 rivo volumio[3113]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::parseTrackInfo Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::parseTrackInfo Nov 28 14:07:23 rivo volumio[3113]: verbose: ControllerMpd::parseTrackInfo Nov 28 14:07:23 rivo volumio[3113]: info: ControllerMpd::pushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::servicePushState Nov 28 14:07:23 rivo volumio[3113]: info: CorePlayQueue::getTrack 0 Nov 28 14:07:23 rivo volumio[3113]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":139469,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"795 Kbps","isStreaming":false,"title":"Stone, River & Shadow","artist":"Bluetech","album":"Holotrope","uri":"http://192.168.50.1:8200/MediaItems/2222.flac","trackType":"flac"} Nov 28 14:07:23 rivo volumio[3113]: verbose: CURRENT POSITION 0 Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::syncState stateService pause Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::syncState currentStatus pause Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::pushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::volumioPushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::stPlaybackTimer Nov 28 14:07:23 rivo volumio[3113]: info: ControllerMpd::pushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::servicePushState Nov 28 14:07:23 rivo volumio[3113]: info: CorePlayQueue::getTrack 0 Nov 28 14:07:23 rivo volumio[3113]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":139469,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"795 Kbps","isStreaming":false,"title":"Stone, River & Shadow","artist":"Bluetech","album":"Holotrope","uri":"http://192.168.50.1:8200/MediaItems/2222.flac","trackType":"flac"} Nov 28 14:07:23 rivo volumio[3113]: verbose: CURRENT POSITION 0 Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::syncState stateService pause Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::syncState currentStatus pause Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::pushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::volumioPushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::stPlaybackTimer Nov 28 14:07:23 rivo volumio[3113]: info: ControllerMpd::pushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::servicePushState Nov 28 14:07:23 rivo volumio[3113]: info: CorePlayQueue::getTrack 0 Nov 28 14:07:23 rivo volumio[3113]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":139469,"duration":313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"795 Kbps","isStreaming":false,"title":"Stone, River & Shadow","artist":"Bluetech","album":"Holotrope","uri":"http://192.168.50.1:8200/MediaItems/2222.flac","trackType":"flac"} Nov 28 14:07:23 rivo volumio[3113]: verbose: CURRENT POSITION 0 Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::syncState stateService pause Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::syncState currentStatus pause Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::pushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::volumioPushState Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::stPlaybackTimer Nov 28 14:07:23 rivo volumio[3113]: info: ------------------------------ 70ms Nov 28 14:07:23 rivo volumio[3113]: info: ------------------------------ 68ms Nov 28 14:07:23 rivo volumio[3113]: info: ------------------------------ 66ms Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::volumioGetQueue Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::getQueue Nov 28 14:07:23 rivo volumio[3113]: info: CorePlayQueue::getQueue Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::volumioGetQueue Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::getQueue Nov 28 14:07:23 rivo volumio[3113]: info: CorePlayQueue::getQueue Nov 28 14:07:23 rivo volumio[3113]: info: CoreCommandRouter::volumioGetQueue Nov 28 14:07:23 rivo volumio[3113]: info: CoreStateMachine::getQueue Nov 28 14:07:23 rivo volumio[3113]: info: CorePlayQueue::getQueue Nov 28 14:07:23 rivo volumio[3113]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 28 14:07:23 rivo volumio[3113]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 28 14:07:23 rivo volumio[3113]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 28 14:07:23 rivo volumio[3113]: info: MCU Signalled Playback Inactive Nov 28 14:07:29 rivo volumio[3113]: info: Preload queue cleared Nov 28 14:07:50 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 14:07:50 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 14:07:50 rivo volumio[3113]: info: Discovery: Getting this device information Nov 28 14:07:50 rivo volumio[3113]: info: CoreCommandRouter::volumioGetState Nov 28 14:07:50 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 14:08:01 rivo ntpd[3311]: 194.58.205.148 local addr 192.168.50.249 -> Nov 28 14:08:04 rivo volumio[3113]: Searching all installed plugins Nov 28 14:08:04 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 14:08:04 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: , search Nov 28 14:08:04 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , search Nov 28 14:08:04 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Nov 28 14:08:04 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Nov 28 14:08:04 rivo volumio[3113]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Nov 28 14:08:04 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: webradio , search Nov 28 14:08:04 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: bandcamp , search Nov 28 14:08:05 rivo volumio[3113]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Nov 28 14:08:05 rivo volumio[3113]: info: [1732799285007] ControllerCalmRadio::searchCategories Nov 28 14:08:05 rivo volumio[3113]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 14:08:05 rivo volumio[3113]: TypeError: Cannot read property 'cats' of undefined Nov 28 14:08:05 rivo volumio[3113]: at ControllerCalmRadio.searchCategories (/data/plugins/music_service/calmradio/index.js:615:42) Nov 28 14:08:05 rivo volumio[3113]: at ControllerCalmRadio.search (/data/plugins/music_service/calmradio/index.js:665:28) Nov 28 14:08:05 rivo volumio[3113]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1097:32) Nov 28 14:08:05 rivo volumio[3113]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44) Nov 28 14:08:05 rivo volumio[3113]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27) Nov 28 14:08:05 rivo volumio[3113]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Nov 28 14:08:05 rivo volumio[3113]: at Socket.emit (events.js:400:28) Nov 28 14:08:05 rivo volumio[3113]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 28 14:08:05 rivo volumio[3113]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Nov 28 14:08:05 rivo volumio[3113]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 14:08:05 rivo sudo[5938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-28 14:07 Nov 28 14:08:05 rivo sudo[5938]: 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"