Jan 25 16:49:04 volumio vtcs[1780]: [close:85] Entering Jan 25 16:49:04 volumio vtcs[1780]: [close:100] Exiting Jan 25 16:49:04 volumio vtcs[1780]: [2026-01-25 16:49:04.504] [tisoc] [warning] [PlaybackControllerImpl.cpp:213] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio volumio[1023]: info: Pushing metadata Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio vtcs[1780]: [close:85] Entering Jan 25 16:49:04 volumio vtcs[1780]: [close:100] Exiting Jan 25 16:49:04 volumio volumio[1023]: info: Pushing metadata Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:04 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:04 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:05 volumio vtcs[1780]: [close:85] Entering Jan 25 16:49:05 volumio vtcs[1780]: [close:100] Exiting Jan 25 16:49:05 volumio vtcs[1780]: [open:50] Opening with sample rate: 44100, type: 0 Jan 25 16:49:05 volumio vtcs[1780]: [start:106] Entering Jan 25 16:49:05 volumio vtcs[1780]: [start:113] Reopening PCM device... Jan 25 16:49:05 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:05 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:05 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:05 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:05 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:05 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:05 volumio vtcs[1780]: [start:115] PCM opened successfully. Jan 25 16:49:05 volumio vtcs[1780]: [start:120] Exiting Jan 25 16:49:05 volumio vtcs[1780]: [feedThread:223] Entering Jan 25 16:49:05 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:05 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:05 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:05 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:05 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:05 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:49:06 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Jan 25 16:49:06 volumio volumio[1023]: info: CoreStateMachine::pushState Jan 25 16:49:06 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 16:49:06 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Jan 25 16:49:06 volumio volumio[1023]: info: MRS: Pushing multiroomSync output update for this device Jan 25 16:49:06 volumio volumio[1023]: info: MRS: Pushing multiroomSync output Jan 25 16:49:06 volumio volumio[1023]: info: CoreCommandRouter::volumioGetState Jan 25 16:50:35 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Jan 25 16:50:35 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Jan 25 16:50:35 volumio volumio[1023]: info: Prefetching next song Jan 25 16:50:35 volumio volumio[1023]: info: [1769377835959] ControllerTidal::prefetch Jan 25 16:50:35 volumio volumio[1023]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 16:50:36 volumio volumio[1023]: TypeError: Cannot read properties of undefined (reading 'highestSoundQuality') Jan 25 16:50:36 volumio volumio[1023]: at ControllerTidal.getProperSoundQuality (/myvolumio/plugins/music_service/tidal/tidal_real:1:19570) Jan 25 16:50:36 volumio volumio[1023]: at ControllerTidal.prefetch (/myvolumio/plugins/music_service/tidal/tidal_real:1:20274) Jan 25 16:50:36 volumio volumio[1023]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:464:18) Jan 25 16:50:36 volumio volumio[1023]: at listOnTimeout (node:internal/timers:573:17) Jan 25 16:50:36 volumio volumio[1023]: at process.processTimers (node:internal/timers:514:7) Jan 25 16:50:36 volumio volumio[1023]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 16:50:39 volumio sudo[2601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-25 16:49' Jan 25 16:50:39 volumio sudo[2601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"