-- Logs begin at Thu 2019-02-14 12:11:58 EET, end at Sun 2025-03-02 09:22:45 EET. -- Mar 02 09:21:00 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:21:00 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:21:00 volumio volumio[1129]: info: Listing playlists Mar 02 09:21:00 volumio volumio[1129]: info: Listing playlists Mar 02 09:21:10 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:21:10 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:21:20 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:21:20 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:21:20 volumio volumio[1129]: info: Listing playlists Mar 02 09:21:20 volumio volumio[1129]: info: Listing playlists Mar 02 09:21:30 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:21:30 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:21:40 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:21:40 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:21:40 volumio volumio[1129]: info: Listing playlists Mar 02 09:21:50 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:21:50 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:00 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:22:00 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:01 volumio volumio[1129]: info: Listing playlists Mar 02 09:22:01 volumio volumio[1129]: info: Listing playlists Mar 02 09:22:10 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:22:10 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:22:11 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:22:11 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:11 volumio volumio[1129]: info: Currently active: webradio Mar 02 09:22:11 volumio volumio[1129]: info: Stopping currently active service Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::volumioStop Mar 02 09:22:11 volumio volumio[1129]: info: CoreStateMachine::stop Mar 02 09:22:11 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 02 09:22:11 volumio volumio[1129]: info: TidalConnect Active Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:22:11 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:11 volumio volumio[1129]: info: Currently active: webradio Mar 02 09:22:11 volumio volumio[1129]: info: Setting Volatile state to tidalconnect Mar 02 09:22:11 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:11 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:11 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:11 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:11 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:11 volumio volumio[1129]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:11 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:11 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:11 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:11 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:11 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:11 volumio volumio[1129]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Mar 02 09:22:11 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status Mar 02 09:22:11 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status undefined Mar 02 09:22:11 volumio volumio[1129]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7tAmOPXGKDgy4WzqnX8mXWtLyWM2.2faadeb16d0352eac21622e7dae3f7b0.state.status' Mar 02 09:22:12 volumio vtcs[2071]: [2025-03-02 09:22:12.437] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:1 Mar 02 09:22:12 volumio vtcs[2071]: [2025-03-02 09:22:12.438] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Mar 02 09:22:12 volumio volumio[1129]: info: Pushing metadata Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:12 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:12 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:12 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:12 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:12 volumio volumio[1129]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:12 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:12 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:12 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:12 volumio volumio[1129]: info: CorePlayQueue::getTrack 0 Mar 02 09:22:12 volumio volumio[1129]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:12 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:12 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:12 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:12 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:22:12 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:12 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:12 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:12 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status undefined Mar 02 09:22:12 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status undefined Mar 02 09:22:12 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status pause Mar 02 09:22:12 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 02 09:22:12 volumio sudo[3109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 02 09:22:12 volumio sudo[3109]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:22:12 volumio sudo[3113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 02 09:22:12 volumio sudo[3113]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:22:12 volumio volumio[1129]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.7tAmOPXGKDgy4WzqnX8mXWtLyWM2.2faadeb16d0352eac21622e7dae3f7b0.state.status' Mar 02 09:22:12 volumio sudo[3109]: pam_unix(sudo:session): session closed for user root Mar 02 09:22:12 volumio volumio[1129]: info: peppymeterbasic Daemon Stop Mar 02 09:22:12 volumio systemd[1]: Started peppymeterbasic Daemon. Mar 02 09:22:12 volumio sudo[3113]: pam_unix(sudo:session): session closed for user root Mar 02 09:22:12 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 02 09:22:12 volumio volumio[1129]: info: peppymeterbasic Daemon Started Mar 02 09:22:13 volumio volumio[1129]: info: Pushing metadata Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:13 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 02 09:22:13 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 02 09:22:13 volumio sudo[3122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 02 09:22:13 volumio sudo[3122]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:22:13 volumio sudo[3125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 02 09:22:13 volumio sudo[3125]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:22:13 volumio sudo[3122]: pam_unix(sudo:session): session closed for user root Mar 02 09:22:13 volumio volumio[1129]: info: peppymeterbasic Daemon Started Mar 02 09:22:13 volumio sudo[3125]: pam_unix(sudo:session): session closed for user root Mar 02 09:22:13 volumio volumio[1129]: info: peppymeterbasic Daemon Started Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:13 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 02 09:22:13 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 02 09:22:13 volumio sudo[3130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 02 09:22:13 volumio sudo[3130]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:22:13 volumio sudo[3130]: pam_unix(sudo:session): session closed for user root Mar 02 09:22:13 volumio volumio[1129]: info: FusionDsp - ---- read samplerate, raw: 96000,S32_LE,2,32 Mar 02 09:22:13 volumio volumio[1129]: info: FusionDsp - ---- read samplerate from file: 96000 Mar 02 09:22:13 volumio volumio[1129]: info: camilladsp stopping service pid 2153... Mar 02 09:22:13 volumio sudo[3133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 02 09:22:13 volumio sudo[3133]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:22:13 volumio volumio[1129]: info: camilladsp service terminated, instance 1 Mar 02 09:22:13 volumio volumio[1129]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 02 09:22:13 volumio volumio[1129]: info: camilladsp service started and running in background, instance 1 Mar 02 09:22:13 volumio volumio[1129]: info: peppymeterbasic Daemon Started Mar 02 09:22:13 volumio sudo[3133]: pam_unix(sudo:session): session closed for user root Mar 02 09:22:13 volumio volumio[1129]: info: camilladsp spawned new process with pid 3137, instance 1, run: true Mar 02 09:22:13 volumio volumio[1129]: info: peppymeterbasic Daemon Started Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::servicePushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreStateMachine::pushState Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:22:13 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output update for this device Mar 02 09:22:13 volumio volumio[1129]: info: MRS: Pushing multiroomSync output Mar 02 09:22:13 volumio volumio[1129]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 02 09:22:13 volumio sudo[3146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 02 09:22:13 volumio sudo[3146]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:22:13 volumio sudo[3146]: pam_unix(sudo:session): session closed for user root Mar 02 09:22:13 volumio volumio[1129]: info: peppymeterbasic Daemon Started Mar 02 09:22:14 volumio volumio[3115]: libpng warning: iCCP: known incorrect sRGB profile Mar 02 09:22:14 volumio volumio[3115]: libpng warning: iCCP: known incorrect sRGB profile Mar 02 09:22:14 volumio volumio[1129]: info: Executing endpoint metavolumio Mar 02 09:22:14 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 02 09:22:14 volumio volumio[1129]: info: Executing endpoint metavolumio Mar 02 09:22:14 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 02 09:22:14 volumio volumio[1129]: info: Executing endpoint metavolumio Mar 02 09:22:14 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 02 09:22:20 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:22:21 volumio volumio[1129]: info: Listing playlists Mar 02 09:22:21 volumio volumio[1129]: info: Listing playlists Mar 02 09:22:30 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:22:40 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 02 09:22:40 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 02 09:22:40 volumio volumio[1129]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 02 09:22:40 volumio volumio[1129]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 02 09:22:40 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState Mar 02 09:22:41 volumio volumio[1129]: info: Listing playlists Mar 02 09:22:45 volumio volumio[1129]: info: Stopping peppymeterbasic service Mar 02 09:22:45 volumio volumio[1129]: info: CoreStateMachine::stop Mar 02 09:22:45 volumio volumio[1129]: info: CoreStateMachine::serviceStop Mar 02 09:22:45 volumio volumio[1129]: info: CoreCommandRouter::serviceStop Mar 02 09:22:45 volumio volumio[1129]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 09:22:45 volumio volumio[1129]: TypeError: Cannot read property 'then' of undefined Mar 02 09:22:45 volumio volumio[1129]: at peppymeterbasic.onStop (/data/plugins/user_interface/peppymeterbasic/index.js:60:43) Mar 02 09:22:45 volumio volumio[1129]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Mar 02 09:22:45 volumio volumio[1129]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Mar 02 09:22:45 volumio volumio[1129]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Mar 02 09:22:45 volumio volumio[1129]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Mar 02 09:22:45 volumio volumio[1129]: at Socket.emit (events.js:315:20) Mar 02 09:22:45 volumio volumio[1129]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 02 09:22:45 volumio volumio[1129]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 02 09:22:45 volumio volumio[1129]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 09:22:45 volumio vtcs[2071]: [2025-03-02 09:22:45.047] [tisoc] [warning] [TidalEvents.cpp:446] Continue event sending result: 20 Mar 02 09:22:45 volumio vtcs[2071]: [2025-03-02 09:22:45.047] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:0 Mar 02 09:22:45 volumio sudo[3283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-02 09:21 Mar 02 09:22:45 volumio sudo[3283]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"