-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-05-11 17:52:20 CEST. -- May 11 17:51:41 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" but was never pressed. Did you set the correct Push Button logic? May 11 17:51:41 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 1 released after 1715442701863ms. May 11 17:51:41 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 released after 1715442701863ms. Seems quite long, maybe you have a wrong button logic level setting or bouncy button? May 11 17:51:43 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. May 11 17:51:43 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 1 released after 1715442703379ms. May 11 17:51:43 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 released after 1715442703379ms. Seems quite long, maybe you have a wrong button logic level setting or bouncy button? May 11 17:51:45 minerva volumio[897]: verbose: New Socket.io Connection to 192.168.1.167 from 192.168.1.211 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 9 May 11 17:51:55 minerva volumio[897]: verbose: New Socket.io Connection to 192.168.1.167 from 192.168.1.211 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 10 May 11 17:51:55 minerva volumio[897]: verbose: New Socket.io Connection to 192.168.1.167 from 192.168.1.211 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 11 May 11 17:51:59 minerva volumio[897]: verbose: New Socket.io Connection to 192.168.1.167 from 192.168.1.211 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 12 May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 17:51:59 minerva volumio[897]: info: Received Get System Info May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 17:51:59 minerva volumio[897]: info: Discovery: Getting this device information May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::volumioGetState May 11 17:51:59 minerva volumio[897]: info: CorePlayQueue::getTrack 0 May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::volumioGetVisibleSources May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::volumioGetState May 11 17:51:59 minerva volumio[897]: info: CorePlayQueue::getTrack 0 May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::volumioGetState May 11 17:51:59 minerva volumio[897]: info: CorePlayQueue::getTrack 0 May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 17:51:59 minerva volumio[897]: info: Received Get System Info May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 17:51:59 minerva volumio[897]: info: Discovery: Getting this device information May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::volumioGetState May 11 17:51:59 minerva volumio[897]: info: CorePlayQueue::getTrack 0 May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::volumioGetState May 11 17:51:59 minerva volumio[897]: info: CorePlayQueue::getTrack 0 May 11 17:51:59 minerva volumio[897]: info: Listing playlists May 11 17:51:59 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 11 17:52:10 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. May 11 17:52:10 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 1 released after 1715442730870ms. May 11 17:52:10 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 released after 1715442730870ms. Seems quite long, maybe you have a wrong button logic level setting or bouncy button? May 11 17:52:11 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 pressed. May 11 17:52:11 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 starting timers. May 11 17:52:12 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 released after 675ms. May 11 17:52:12 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 doublepush timer elapsed. (false, 1) May 11 17:52:12 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 sending single push command. May 11 17:52:12 minerva volumio[897]: info: [ROTARYENCODER2] emitPushCommand: 10for Rotary: 2 May 11 17:52:12 minerva volumio[897]: info: VolumeController::SetAlsaVolumemute May 11 17:52:12 minerva volumio[897]: info: CoreStateMachine::pushState May 11 17:52:12 minerva volumio[897]: info: CorePlayQueue::getTrack 0 May 11 17:52:12 minerva volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 17:52:12 minerva volumio[897]: info: CoreCommandRouter::volumioPushState May 11 17:52:12 minerva volumio[897]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 May 11 17:52:12 minerva volumio[897]: SPOTIFY: SPOTIFY VOLUME 29 May 11 17:52:12 minerva volumio[897]: SPOTIFY: VOLUMIO VOLUME 0 May 11 17:52:12 minerva volumio[897]: SPOTIFY: DELTA VOLUME ENOUGH: true May 11 17:52:12 minerva volumio[897]: info: Setting Spotify Volume from Volumio: 0 May 11 17:52:13 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. May 11 17:52:13 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 1 released after 1715442733264ms. May 11 17:52:13 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 released after 1715442733264ms. Seems quite long, maybe you have a wrong button logic level setting or bouncy button? May 11 17:52:13 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 2 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. May 11 17:52:13 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 released after 1339ms. May 11 17:52:14 minerva volumio[897]: SPOTIFY: SETTING SPOTIFY VOLUME 0 May 11 17:52:14 minerva volumio[897]: info: Sending Spotify command with payload to local API: /player/volume May 11 17:52:14 minerva go-librespot[1167]: time="2024-05-11T17:52:14+02:00" level=debug msg="update volume to 0/65535" May 11 17:52:14 minerva go-librespot[1167]: time="2024-05-11T17:52:14+02:00" level=debug msg="put connect state because VOLUME_CHANGED" May 11 17:52:14 minerva go-librespot[1167]: time="2024-05-11T17:52:14+02:00" level=trace msg="emitting websocket event: volume" May 11 17:52:14 minerva volumio[897]: SPOTIFY: received: {"type":"volume","data":{"value":0,"max":100}} May 11 17:52:14 minerva volumio[897]: SPOTIFY: RECEIVED SPOTIFY VOLUME 0 May 11 17:52:15 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. May 11 17:52:15 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 1 released after 1715442735122ms. May 11 17:52:15 minerva volumio[897]: warn: [ROTARYENCODER2] Push Button 1 released after 1715442735122ms. Seems quite long, maybe you have a wrong button logic level setting or bouncy button? May 11 17:52:18 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 pressed. May 11 17:52:18 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 starting timers. May 11 17:52:19 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 doublepush timer elapsed. (true, 1) May 11 17:52:19 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 longpush timer elapsed. (true, 1) May 11 17:52:19 minerva volumio[897]: info: [ROTARYENCODER2] Push Button 2 sending long push command. May 11 17:52:19 minerva volumio[897]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 17:52:19 minerva volumio[897]: SyntaxError: Unexpected end of JSON input May 11 17:52:19 minerva volumio[897]: at JSON.parse () May 11 17:52:19 minerva volumio[897]: at rotaryencoder2.emitPushCommand (/data/plugins/system_hardware/rotaryencoder2/index.js:751:17) May 11 17:52:19 minerva volumio[897]: at Timeout._onTimeout (/data/plugins/system_hardware/rotaryencoder2/index.js:553:18) May 11 17:52:19 minerva volumio[897]: at listOnTimeout (internal/timers.js:554:17) May 11 17:52:19 minerva volumio[897]: at processTimers (internal/timers.js:497:7) May 11 17:52:19 minerva volumio[897]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 17:52:20 minerva sudo[1905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-11 17:51 May 11 17:52:20 minerva sudo[1905]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"