-- Logs begin at Sat 2024-11-02 17:49:31 CET, end at Sat 2024-11-02 18:05:46 CET. -- Nov 02 18:05:32 volumio volumio[966]: info: CorePlayQueue::getTrack 10 Nov 02 18:05:32 volumio volumio[966]: info: CorePlayQueue::getTrack 11 Nov 02 18:05:32 volumio volumio[966]: info: Prefetching next song Nov 02 18:05:32 volumio volumio[966]: info: DOING PREFETCH IN MPD Nov 02 18:05:32 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIK/ANALOGIE - BACK TO THE PASAT_MP3s/Analogie XIV.mp3" Nov 02 18:05:32 volumio volumio[966]: info: Nov 02 18:05:32 volumio volumio[966]: ---------------------------- MPD announces system playlist update Nov 02 18:05:32 volumio volumio[966]: info: Ignoring MPD Status Update Nov 02 18:05:32 volumio volumio[966]: info: sendMpdCommand add "USB/MUSIK/ANALOGIE - BACK TO THE PASAT_MP3s/Analogie XIV.mp3" took 2 milliseconds Nov 02 18:05:32 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand consume 1 Nov 02 18:05:32 volumio volumio[966]: info: ------------------------------ 2ms Nov 02 18:05:32 volumio volumio[966]: info: sendMpdCommand consume 1 took 1 milliseconds Nov 02 18:05:35 volumio volumio[966]: info: Nov 02 18:05:35 volumio volumio[966]: ---------------------------- MPD announces system playlist update Nov 02 18:05:35 volumio volumio[966]: info: Ignoring MPD Status Update Nov 02 18:05:35 volumio volumio[966]: info: Nov 02 18:05:35 volumio volumio[966]: ---------------------------- MPD announces state update: player Nov 02 18:05:35 volumio volumio[966]: info: ControllerMpd::getState Nov 02 18:05:35 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand status Nov 02 18:05:35 volumio volumio[966]: info: ------------------------------ 1ms Nov 02 18:05:35 volumio volumio[966]: info: sendMpdCommand status took 1 milliseconds Nov 02 18:05:35 volumio volumio[966]: verbose: ControllerMpd::parseState Nov 02 18:05:35 volumio volumio[966]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 18:05:35 volumio volumio[966]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 02 18:05:35 volumio volumio[966]: verbose: ControllerMpd::parseTrackInfo Nov 02 18:05:35 volumio volumio[966]: info: ControllerMpd::pushState Nov 02 18:05:35 volumio volumio[966]: info: CoreCommandRouter::servicePushState Nov 02 18:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 10 Nov 02 18:05:35 volumio volumio[966]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":284,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Analogie XIV","artist":"RAINER BECHTOLD","album":"ANALOGIE - BACK TO THE PAST","uri":"USB/MUSIK/ANALOGIE - BACK TO THE PASAT_MP3s/Analogie XIV.mp3","trackType":"mp3"} Nov 02 18:05:35 volumio volumio[966]: verbose: CURRENT POSITION 10 Nov 02 18:05:35 volumio volumio[966]: info: CoreStateMachine::syncState stateService play Nov 02 18:05:35 volumio volumio[966]: info: CoreStateMachine::syncState currentStatus play Nov 02 18:05:35 volumio volumio[966]: info: Received an update from plugin. extracting info from payload Nov 02 18:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Nov 02 18:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 10 Nov 02 18:05:35 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 18:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Nov 02 18:05:35 volumio volumio[966]: info: MRS: Pushing multiroomSync output update for this device Nov 02 18:05:35 volumio volumio[966]: info: MRS: Pushing multiroomSync output Nov 02 18:05:35 volumio volumio[966]: info: CoreStateMachine::pushState Nov 02 18:05:35 volumio volumio[966]: info: CorePlayQueue::getTrack 10 Nov 02 18:05:35 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Nov 02 18:05:35 volumio volumio[966]: info: MRS: Pushing multiroomSync output update for this device Nov 02 18:05:35 volumio volumio[966]: info: MRS: Pushing multiroomSync output Nov 02 18:05:35 volumio volumio[966]: info: ------------------------------ 19ms Nov 02 18:05:35 volumio volumio[966]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Nov 02 18:05:35 volumio volumio[966]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Nov 02 18:05:35 volumio volumio[966]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] Nov 02 18:05:35 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder Nov 02 18:05:36 volumio sudo[2741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Nov 02 18:05:36 volumio sudo[2741]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 18:05:36 volumio sudo[2741]: pam_unix(sudo:session): session closed for user root Nov 02 18:05:36 volumio sudo[2744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 1 Nov 02 18:05:36 volumio sudo[2744]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 18:05:36 volumio kernel: OF: ERROR: memory leak, expected refcount 1 instead of 2, of_node_get()/of_node_put() unbalanced - destroy cset entry: attach overlay node /rotary@1b Nov 02 18:05:36 volumio kernel: OF: ERROR: memory leak before free overlay changeset, /rotary@1b Nov 02 18:05:36 volumio sudo[2744]: pam_unix(sudo:session): session closed for user root Nov 02 18:05:36 volumio sudo[2755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Nov 02 18:05:36 volumio sudo[2755]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 18:05:36 volumio sudo[2755]: pam_unix(sudo:session): session closed for user root Nov 02 18:05:36 volumio sudo[2758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Nov 02 18:05:36 volumio sudo[2758]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 18:05:36 volumio sudo[2758]: pam_unix(sudo:session): session closed for user root Nov 02 18:05:36 volumio sudo[2761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Nov 02 18:05:36 volumio sudo[2761]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 18:05:36 volumio kernel: OF: ERROR: memory leak, expected refcount 1 instead of 2, of_node_get()/of_node_put() unbalanced - destroy cset entry: attach overlay node /rotary@17 Nov 02 18:05:36 volumio kernel: OF: ERROR: memory leak before free overlay changeset, /rotary@17 Nov 02 18:05:36 volumio sudo[2761]: pam_unix(sudo:session): session closed for user root Nov 02 18:05:36 volumio sudo[2771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Nov 02 18:05:36 volumio sudo[2771]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 18:05:36 volumio sudo[2771]: pam_unix(sudo:session): session closed for user root Nov 02 18:05:36 volumio sudo[2774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=2 Nov 02 18:05:36 volumio sudo[2774]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 18:05:36 volumio kernel: rotary-encoder rotary@17: gray Nov 02 18:05:36 volumio kernel: input: rotary@17 as /devices/platform/rotary@17/input/input8 Nov 02 18:05:36 volumio sudo[2774]: pam_unix(sudo:session): session closed for user root Nov 02 18:05:36 volumio systemd-udevd[2750]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 02 18:05:37 volumio volumio[966]: info: CoreStateMachine::startPlaybackTimer Nov 02 18:05:37 volumio volumio[966]: info: CorePlayQueue::getTrack 11 Nov 02 18:05:37 volumio sudo[2788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=22 pin_b=27 relative_axis=true steps-per-period=2 Nov 02 18:05:37 volumio sudo[2788]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 02 18:05:37 volumio volumio[966]: info: CoreStateMachine::pushState Nov 02 18:05:37 volumio volumio[966]: info: CorePlayQueue::getTrack 11 Nov 02 18:05:37 volumio volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 18:05:37 volumio volumio[966]: info: CoreCommandRouter::volumioPushState Nov 02 18:05:37 volumio kernel: rotary-encoder rotary@16: gray Nov 02 18:05:37 volumio kernel: input: rotary@16 as /devices/platform/rotary@16/input/input9 Nov 02 18:05:37 volumio volumio[966]: info: MRS: Pushing multiroomSync output update for this device Nov 02 18:05:37 volumio volumio[966]: info: MRS: Pushing multiroomSync output Nov 02 18:05:37 volumio sudo[2788]: pam_unix(sudo:session): session closed for user root Nov 02 18:05:37 volumio volumio[966]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Nov 02 18:05:37 volumio systemd-udevd[2750]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 02 18:05:45 volumio volumio[966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 18:05:45 volumio volumio[966]: SyntaxError: Unexpected token + in JSON at position 0 Nov 02 18:05:45 volumio volumio[966]: at JSON.parse () Nov 02 18:05:45 volumio volumio[966]: at rotaryencoder2.emitPushCommand (/data/plugins/system_hardware/rotaryencoder2/index.js:743:17) Nov 02 18:05:45 volumio volumio[966]: at Timeout._onTimeout (/data/plugins/system_hardware/rotaryencoder2/index.js:544:18) Nov 02 18:05:45 volumio volumio[966]: at listOnTimeout (internal/timers.js:554:17) Nov 02 18:05:45 volumio volumio[966]: at processTimers (internal/timers.js:497:7) Nov 02 18:05:45 volumio volumio[966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 18:05:46 volumio sudo[2822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-02 18:04 Nov 02 18:05:46 volumio sudo[2822]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"