-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2025-03-10 19:57:17 CET. -- Mar 10 19:56:00 volumio volumio[14292]: info: Loading plugin "alarm-clock"... Mar 10 19:56:00 volumio sudo[14329]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:00 volumio volumio-remote-updater[614]: [2025-03-10 19:56:00] [connect] Successful connection Mar 10 19:56:00 volumio volumio[14292]: info: Loading plugin "airplay_emulation"... Mar 10 19:56:00 volumio volumio[14292]: info: Starting Shairport Sync Mar 10 19:56:00 volumio volumio[14292]: info: Loading plugin "last_100"... Mar 10 19:56:00 volumio volumio[14292]: info: Loading plugin "webradio"... Mar 10 19:56:00 volumio volumio[14292]: info: Loading plugin "i2s_dacs"... Mar 10 19:56:00 volumio volumio[14292]: info: Loading plugin "volumiodiscovery"... Mar 10 19:56:00 volumio volumio[14292]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 10 19:56:00 volumio volumio[14292]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 19:56:00 volumio volumio[14292]: *** WARNING *** For more information see Mar 10 19:56:00 volumio node[14292]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 10 19:56:00 volumio volumio[14292]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 10 19:56:00 volumio volumio[14292]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 19:56:00 volumio volumio[14292]: *** WARNING *** For more information see Mar 10 19:56:00 volumio node[14292]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 19:56:00 volumio node[14292]: *** WARNING *** For more information see Mar 10 19:56:00 volumio node[14292]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 10 19:56:00 volumio node[14292]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 19:56:00 volumio node[14292]: *** WARNING *** For more information see Mar 10 19:56:00 volumio volumio[14292]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 10 19:56:00 volumio volumio[14292]: info: Discovery: Started advertising with name: Volumio Mar 10 19:56:00 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 19:56:00 volumio volumio[14292]: info: Loading plugin "spop"... Mar 10 19:56:01 volumio volumio[14292]: info: Loading plugin "gpio-buttons"... Mar 10 19:56:02 volumio volumio[14292]: info: GPIO-Buttons initialized Mar 10 19:56:02 volumio volumio[14292]: info: Loading plugin "outputs"... Mar 10 19:56:02 volumio volumio[14292]: info: Loading plugin "albumart"... Mar 10 19:56:02 volumio volumio[14292]: info: Plugin example_plugin is not enabled Mar 10 19:56:02 volumio volumio[14292]: info: Loading plugin "inputs"... Mar 10 19:56:02 volumio volumio[14292]: info: Loading plugin "updater_comm"... Mar 10 19:56:02 volumio volumio[14292]: info: Plugin mpdemulation is not enabled Mar 10 19:56:02 volumio volumio[14292]: info: Loading plugin "rest_api"... Mar 10 19:56:02 volumio volumio[14292]: info: Loading plugin "websocket"... Mar 10 19:56:02 volumio volumio[14292]: info: Starting Socket.io Server version 2.3.0 Mar 10 19:56:02 volumio volumio[14292]: info: Loading plugin "rotaryencoder2"... Mar 10 19:56:02 volumio volumio[14292]: Forking 3 albumart workers Mar 10 19:56:03 volumio volumio[14292]: info: Loading i18n strings for locale en Mar 10 19:56:03 volumio volumio[14292]: Updating browse sources language Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::initPlayerControls Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: Express server listening on port 3000 Mar 10 19:56:03 volumio volumio[14292]: [Metrics] WebUI: 6s 361.08ms Mar 10 19:56:03 volumio volumio[14292]: info: CoreStateMachine::resetVolumioState Mar 10 19:56:03 volumio volumio[14292]: info: CoreStateMachine::getcurrentVolume Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 19:56:03 volumio volumio[14292]: info: Cannot read play queue from file Mar 10 19:56:03 volumio volumio[14292]: info: Volumio Network Manager: Network status updated: 2 Mar 10 19:56:03 volumio volumio[14292]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.72 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 10 19:56:03 volumio volumio-remote-updater[614]: [2025-03-10 19:56:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741632960 101 Mar 10 19:56:03 volumio volumio[14292]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Mar 10 19:56:03 volumio volumio[14292]: verbose: New Socket.io Connection to volumio.local from 192.168.178.72 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 3 Mar 10 19:56:03 volumio volumio[14292]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.72 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 4 Mar 10 19:56:03 volumio volumio[14292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:03 volumio volumio[14292]: Starting albumart workers Mar 10 19:56:03 volumio volumio[14292]: Starting albumart workers Mar 10 19:56:03 volumio go-librespot[1195]: time="2025-03-10T19:56:03+01:00" level=trace msg="sent dealer ping" Mar 10 19:56:03 volumio volumio[14292]: Starting albumart workers Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:03 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:03 volumio go-librespot[1195]: time="2025-03-10T19:56:03+01:00" level=trace msg="received dealer pong" Mar 10 19:56:03 volumio volumio[14292]: info: CoreStateMachine::setRepeat null single undefined Mar 10 19:56:03 volumio volumio[14292]: info: CoreStateMachine::pushState Mar 10 19:56:03 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::volumioPushState Mar 10 19:56:03 volumio volumio[14292]: info: CoreStateMachine::setRandom null Mar 10 19:56:03 volumio volumio[14292]: info: CoreStateMachine::pushState Mar 10 19:56:03 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::volumioPushState Mar 10 19:56:03 volumio volumio[14292]: info: Setting Device type: Raspberry PI Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::volumioGetQueue Mar 10 19:56:03 volumio volumio[14292]: info: CoreStateMachine::getQueue Mar 10 19:56:03 volumio volumio[14292]: info: CorePlayQueue::getQueue Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Mar 10 19:56:03 volumio volumio[14292]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Mar 10 19:56:03 volumio volumio[14292]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Mar 10 19:56:03 volumio volumio[14292]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Mar 10 19:56:03 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Mar 10 19:56:04 volumio volumio[14292]: info: Completed loading Core Plugins Mar 10 19:56:04 volumio volumio[14292]: info: Preparing to generate the ALSA configuration file Mar 10 19:56:04 volumio volumio[14292]: info: VolumeController:: Volume=54 Mute =false Mar 10 19:56:04 volumio volumio[14292]: info: CoreStateMachine::pushState Mar 10 19:56:04 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::volumioPushState Mar 10 19:56:04 volumio volumio[14292]: info: CoreStateMachine::updateTrackBlock Mar 10 19:56:04 volumio volumio[14292]: info: CorePlayQueue::getTrackBlock Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 19:56:04 volumio volumio[14292]: info: Asound.conf file unchanged, so no further update is needed Mar 10 19:56:04 volumio volumio[14292]: info: Output device has changed, restarting MPD Mar 10 19:56:04 volumio sudo[14388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 19:56:04 volumio sudo[14388]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:04 volumio volumio[14292]: info: Output device has changed, restarting Shairport Sync Mar 10 19:56:04 volumio sudo[14388]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:04 volumio sudo[14391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 19:56:04 volumio sudo[14391]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:04 volumio volumio[14292]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 19:56:04 volumio volumio[14292]: info: ___________ START PLUGINS ___________ Mar 10 19:56:04 volumio systemd[1]: Stopping Music Player Daemon... Mar 10 19:56:04 volumio volumio[14292]: info: ControllerMpd::onStart: Initializing MPD Mar 10 19:56:04 volumio volumio[14292]: info: Creating MPD Configuration file Mar 10 19:56:04 volumio systemd[1]: mpd.service: Succeeded. Mar 10 19:56:04 volumio systemd[1]: Stopped Music Player Daemon. Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 19:56:04 volumio sudo[14398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 19:56:04 volumio sudo[14398]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:04 volumio volumio[14292]: info: [1741632964475] CoreMusicLibrary::Adding element Media Servers Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:56:04 volumio sudo[14398]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:04 volumio systemd[1]: Starting Music Player Daemon... Mar 10 19:56:04 volumio sudo[14400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 19:56:04 volumio sudo[14400]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:04 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 10 19:56:04 volumio systemd[1]: mpd.service: Succeeded. Mar 10 19:56:04 volumio systemd[1]: Stopped Music Player Daemon. Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:04 volumio systemd[1]: Starting Music Player Daemon... Mar 10 19:56:04 volumio volumio[14292]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:04 volumio sudo[14403]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 10 19:56:04 volumio sudo[14403]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:04 volumio sudo[14403]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:04 volumio volumio[14292]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 19:56:04 volumio volumio[14292]: info: [1741632964824] CoreMusicLibrary::Adding element Last_100 Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 19:56:04 volumio volumio[14292]: info: [1741632964829] CoreMusicLibrary::Adding element Webradio Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:56:04 volumio volumio[14292]: info: Initializing BBC Radios Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:04 volumio volumio[14292]: info: Creating Spotify config file Mar 10 19:56:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: GPIO-Buttons: Reading config and creating triggers... Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] loadI18nStrings: /data/plugins/system_hardware/rotaryencoder2/i18n/strings_en.json Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] loadI18nStrings: loaded: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2]{"ROTARYENCODER2":{"CONFIG":"Rotary Encoder II Plugin Configuration","SAVE":"Save","ENCODER0":"Rotary Encoder 1","D_ENCODER0":"Settings for the first rotary encoder.","ENCODER1":"Rotary Encoder 2","D_ENCODER1":"Settings for the second rotary encoder.","ENCODER2":"Rotary Encoder 3","D_ENCODER2":"Settings for the third rotary encoder.","ROTARYTYPE":"Periods per tick","D_ROTARYTYPE":"Periods per tick (Full: A and B full period, half: A and B half period, quarter: A or B half period","FULL":"Full-period mode","HALF":"Half-period mode","QUARTER":"Quarter-period mode","PINA":"Pin A GPIO","D_PINA":"GPIO pin that is connected to the first pin of the rotary.","PINB":"Pin B GPIO","D_PINB":"GPIO pin that is connected to the second pin of the rotary.","DIALACTION":"Dial Action","D_DIALACTION":"Action to be triggered by turning the rotary encocer. Option 'Emit Websocket Message' can be used to control other plugins using the Volumio Websock calls between Plugins. (see https://volumio.github.io/docs/API/WebSocket_APIs.html section 'CallMethod on Plugin' for details)","DOTS":"...","VOLUME":"Volume","SKIP":"Prev/Next title","SEEK":"Seek in title","SCROLL":"Scroll","EMIT":"Emit Websocket Message","TOGGLEFUSION":"Toggle Fusion DSP Enable/Disable","SOCKCMDCCW":"Command CCW","SOCKDATACCW":"Data CCW","SOCKCMDCW":"Command CW","SOCKDATACW":"Data CW","SOCKCMD":"Command","SOCKDATA":"Data","D_SOCKCMD":"Command to send via Websocket","D_SOCKDATA":"Data to include with the Websocket Command","PINPUSH":"Pushbutton GPIO","D_PINPUSH":"GPIO pin that is connected to the pushbutton pin of the rotary. 0 or empty to disable.","PINPUSHDEBOUNCE":"Debounce-time (ms)","D_PINPUSHDEBOUNCE":"Debounce time for the button. If the button has hardware-debouncing, set to 0.","PUSHSTATE":"Button logic-level active low","D_PUSHSTATE":"Activate this, if pressing the button pulls the logic level on the GPIO low.","PINPUSHDELAY":"Delay for a long button press (ms)","D_PINPUSHDEDELAY":"Minimum duration of a button press, that will trigger the long push action in ms","PINDOUBLEPUSHDELAY":"Maximum interval for double press (ms)","D_PINDOUBLEPUSHDEDELAY":"Time interval in ms, within which a double press has to be detected.","PUSHACTION":"Short Press Action","D_PUSHACTION":"Action that gets triggered, when pushbutton is pressed briefly.","LONGPUSHACTION":"Long Press Action","D_LONGPUSHACTION":"Action that gets triggered, when pushbutton is pressed longer.","DOUBLEPUSHACTION":"Double Press Action","D_DOUBLEPUSHACTION":"Action that gets triggered, when pushbutton is pressed twice quickly.","SET_DEBUG":"Debug Settings","D_SET_DEBUG":"Settings for functional debugging.","PLAY":"Play","PAUSE":"Pause","PLAYPAUSE":"Play/Pause toggle","STOP":"Stop","REPEAT":"Repeat","RANDOM":"Random","CLEARQUEUE":"Clear Queue","MUTE":"Mute","UNMUTE":"Unmute","TOGGLEMUTE":"Toggle Mute","SHUTDOWN":"System Shutdown","REBOOT":"System Reboot","RESTARTAPP":"Restart Application","DUMPLOG":"Dump logfile","LOGGING":"Logging","LOGGINGJSON":"Log JSON Objects","D_LOGGING":"Switch the output of log messages on or off. Error messages are always logged.","D_LOGGINGJSON":"Activate logging of JSON objects. Makes logs significantly longer.","TOAST_START_SUCCESS":"Plugin successfully started.","TOAST_STOP_SUCCESS":"Plugin successfully stopped.","TOAST_START_FAIL":"Plugin failed to start.","TOAST_STOP_FAIL":"Plugin failed to stop.","TOAST_GPIO_BLOCKED":"GPIO Pin unavailable","TOAST_MSG_OVERLAY_BLOCKING":"Blocked by another overlay.","TOAST_SAVE_SUCCESS":"Successfully saved","TOAST_MSG_SAVE":"Settings for Encoder ","TOAST_DEBUG_SAVE":"Debug Settings","TOAST_SAVE_FAIL":"Save failed","TOAST_WRONG_PARAMETER":"Error in parameters","TOAST_NEEDS_INTEGER":"GPIO Pins must be Integers.","TOAST_PINS_DIFFERENT":"GPIO Pins for A/B/Button must be different.","TOAST_PINS_BLOCKED":"Pins already used in another Encoder.","TOAST_NO_TYPE":"Please select 'Periods per tick'!","TOAST_KILL_HANDLE_FAIL":"Could not deactivate Rotary Resources. Correct GPIOs selected? Please correct and restart system!","TOAST_ERR_FROM_STREAM":"Error from Stream of Rotary, please check Hardware and GPIO Settings.","TOAST_ERR_ACT_ROTARY_FAILED":"Configuration of rotary encoder failed.","TOAST_ERR_ADD_OVERLAY_FAILED":"Failed to add Overlay: ","TOAST_ERR_ATTACH_LISTENER_FAILED":"Failed to attach Listener for DTO"}} Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] onStart: Config loaded: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2]{"syncSave":true,"autosave":true,"autosaveDelay":1000,"saved":true,"atomicSave":false,"data":{"enabled0":{"type":"boolean","value":true},"rotaryType0":{"type":"number","value":1},"pinA0":{"type":"string","value":"23"},"pinB0":{"type":"string","value":"24"},"dialAction0":{"type":"number","value":1},"socketCmdCW0":{"type":"string","value":""},"socketDataCW0":{"type":"string","value":""},"socketCmdCCW0":{"type":"string","value":""},"socketDataCCW0":{"type":"string","value":""},"pinPush0":{"type":"number","value":27},"pinPushDebounce0":{"type":"number","value":50},"pushState0":{"type":"boolean","value":true},"pushAction0":{"type":"number","value":13},"socketCmdPush0":{"type":"string","value":"callMethod"},"socketDataPush0":{"type":"string","value":"{endpoint: music_service/volspotconnect2, method: toggle, data: []}"},"longPushAction0":{"type":"number","value":0},"socketCmdLongPush0":{"type":"string","value":""},"socketDataLongPush0":{"type":"string","value":""},"delayLongPush0":{"type":"string","value":"1500"},"doublePushAction0":{"type":"number","value":0},"socketCmdDoublePush0":{"type":"string","value":""},"socketDataDoublePush0":{"type":"string","value":""},"delayDoublePush0":{"type":"string","value":"700"},"enabled1":{"type":"boolean","value":false},"rotaryType1":{"type":"number","value":0},"pinA1":{"type":"string","value":""},"pinB1":{"type":"string","value":""},"dialAction1":{"type":"number","value":0},"socketCmdCW1":{"type":"string","value":""},"socketDataCW1":{"type":"string","value":""},"socketCmdCCW1":{"type":"string","value":""},"socketDataCCW1":{"type":"string","value":""},"pinPush1":{"type":"number","value":0},"pinPushDebounce1":{"type":"number","value":0},"pushState1":{"type":"boolean","value":true},"pushAction1":{"type":"number","value":0},"socketCmdPush1":{"type":"string","value":""},"socketDataPush1":{"type":"string","value":""},"longPushAction1":{"type":"number","value":0},"socketCmdLongPush1":{"type":"string","value":""},"socketDataLongPush1":{"type":"string","value":""},"delayLongPush1":{"type":"string","value":"1500"},"doublePushAction1":{"type":"number","value":0},"socketCmdDoublePush1":{"type":"string","value":""},"socketDataDoublePush1":{"type":"string","value":""},"delayDoublePush1":{"type":"string","value":"700"},"enabled2":{"type":"boolean","value":false},"rotaryType2":{"type":"number","value":0},"pinA2":{"type":"string","value":""},"pinB2":{"type":"string","value":""},"dialAction2":{"type":"number","value":0},"socketCmdCW2":{"type":"string","value":""},"socketDataCW2":{"type":"string","value":""},"socketCmdCCW2":{"type":"string","value":""},"socketDataCCW2":{"type":"string","value":""},"pinPush2":{"type":"number","value":0},"pinPushDebounce2":{"type":"number","value":0},"pushState2":{"type":"boolean","value":true},"pushAction2":{"type":"number","value":0},"socketCmdPush2":{"type":"string","value":""},"socketDataPush2":{"type":"string","value":""},"longPushAction2":{"type":"number","value":0},"socketCmdLongPush2":{"type":"string","value":""},"socketDataLongPush2":{"type":"string","value":""},"delayLongPush2":{"type":"string","value":"1500"},"doublePushAction2":{"type":"number","value":0},"socketCmdDoublePush2":{"type":"string","value":""},"socketDataDoublePush2":{"type":"string","value":""},"delayDoublePush2":{"type":"string","value":"700"},"logging":{"type":"boolean","value":true},"loggingJSON":{"type":"boolean","value":true}},"callbacks":{"_":{}},"filePath":"/data/configuration/system_hardware/rotaryencoder2/config.json"} Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: 1,2,3 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: 1,2 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: 1 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: end of recursion. Mar 10 19:56:05 volumio volumio[14292]: info: Volumio Calling Home Mar 10 19:56:05 volumio volumio[14292]: info: GPIO-Buttons started Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] addOverlay for Rotary: 23 24 1 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] addOverlay: executing command: /usr/bin/sudo /usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 & Mar 10 19:56:05 volumio sudo[14455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 Mar 10 19:56:05 volumio sudo[14455]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:05 volumio sudo[14455]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:05 volumio volumio[14292]: info: Discovery: adding ec9afe1a-ac6f-4fe5-88d3-501a7428dd3b Mar 10 19:56:05 volumio volumio[14292]: info: Discovery: Found device Volumio Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:05 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:05 volumio volumio[14292]: error: [ROTARYENCODER2] addOverlay: * Failed to apply overlay '2_rotary-encoder' (kernel) Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] getI18nString("TOAST_WRONG_PARAMETER"):Error in parameters Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] getI18nString("TOAST_ERR_ADD_OVERLAY_FAILED"):Failed to add Overlay: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: 1,2,3 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: 1,2 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: 1 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: end of recursion. Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: Checking for existing overlays for Rotary: 1 type: rotary Mar 10 19:56:05 volumio volumio[14292]: info: MPD Permissions set Mar 10 19:56:05 volumio sudo[14465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 10 19:56:05 volumio sudo[14465]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:05 volumio volumio[14292]: info: VolumeController:: Volume=54 Mute =false Mar 10 19:56:05 volumio volumio[14292]: info: CoreStateMachine::pushState Mar 10 19:56:05 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::volumioPushState Mar 10 19:56:05 volumio sudo[14465]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:05 volumio volumio[14292]: info: Volumio called home Mar 10 19:56:05 volumio volumio[14292]: info: Spotify config file written Mar 10 19:56:05 volumio sudo[14468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 10 19:56:05 volumio sudo[14468]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:05 volumio systemd[1]: Stopping go-librespot Daemon... Mar 10 19:56:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Mar 10 19:56:05 volumio systemd[1]: go-librespot-daemon.service: Succeeded. Mar 10 19:56:05 volumio systemd[1]: Stopped go-librespot Daemon. Mar 10 19:56:05 volumio systemd[1]: Started go-librespot Daemon. Mar 10 19:56:05 volumio volumio[14292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 10 19:56:05 volumio sudo[14468]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:05 volumio go-librespot[14470]: go-librespot daemon starting... Mar 10 19:56:05 volumio volumio[14292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 10 19:56:05 volumio go-librespot[14470]: time="2025-03-10T19:56:05+01:00" level=info msg="running go-librespot 0.2.0" Mar 10 19:56:05 volumio go-librespot[14470]: time="2025-03-10T19:56:05+01:00" level=debug msg="app state loaded" Mar 10 19:56:05 volumio go-librespot[14470]: time="2025-03-10T19:56:05+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: check pinA=23pinB=24 in Overlays (in load order): Mar 10 19:56:05 volumio volumio[14292]: 0: rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 Mar 10 19:56:05 volumio volumio[14292]: 1: gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: rotary 1 uses overlay 0 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: attach rotary 1 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachListener: path: /dev/input/by-path/platform-rotary@17-event, type: rotary Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: Checking for existing overlays for Rotary: 1 type: button Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio sudo[14479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 10 19:56:05 volumio sudo[14479]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:05 volumio sudo[14479]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:05 volumio volumio[14292]: info: No need to fix Spotify hosts Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: check pinA=27pinB=undefined in Overlays (in load order): Mar 10 19:56:05 volumio volumio[14292]: 0: rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 Mar 10 19:56:05 volumio volumio[14292]: 1: gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: button 1 uses overlay 1 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: attach button 1 Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachListener: path: /dev/input/by-path/platform-button@1b-event, type: button Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners rotaries: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14477},"spawnargs":["/bin/cat","/dev/input/by-path/platform-rotary@17-event"],"pid":14477,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners buttons: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14490},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@1b-event"],"pid":14490,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners rotaries: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14477},"spawnargs":["/bin/cat","/dev/input/by-path/platform-rotary@17-event"],"pid":14477,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners buttons: Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14490},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@1b-event"],"pid":14490,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] onStart: Attach Event-handles now. Mar 10 19:56:05 volumio go-librespot[14470]: time="2025-03-10T19:56:05+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 10 19:56:05 volumio go-librespot[14470]: time="2025-03-10T19:56:05+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 10 19:56:05 volumio go-librespot[14470]: time="2025-03-10T19:56:05+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] Now addAllEventHandles for rotaries. Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle for rotary: 1 type: rotary Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] Now addAllEventHandles for buttons. Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle for rotary: 1 type: button Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle: adding handle : Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2]{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14490},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@1b-event"],"pid":14490,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]} Mar 10 19:56:05 volumio volumio[14292]: info: [ROTARYENCODER2] onStart: Plugin successfully started. Mar 10 19:56:05 volumio go-librespot[14470]: time="2025-03-10T19:56:05+01:00" level=info msg="zeroconf server listening on port 38217" Mar 10 19:56:06 volumio volumio[14292]: info: Starting Shairport Sync Mar 10 19:56:06 volumio volumio[14292]: info: Starting Shairport Sync Mar 10 19:56:06 volumio sudo[14492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 19:56:06 volumio sudo[14492]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:06 volumio volumio[14292]: info: Starting Shairport Sync Mar 10 19:56:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 19:56:06 volumio sudo[14495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 19:56:06 volumio sudo[14495]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:06 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 10 19:56:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 19:56:06 volumio sudo[14497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 19:56:06 volumio sudo[14497]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:06 volumio volumio[14292]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 10 19:56:06 volumio volumio[14292]: SPOTIFY: BQBI_amExUSJN83M_gcZ4Iquay-beDkuB263-KtmS3oFI4FQqAzpkrpuBQO2L8PqFKXIc7cCzW6N7nl-MT3X3HTxszGcf_D53cjdmti5vpE5cnKlFycE179vX-9LhNaOxzDGho3iTcsQ4YBDYjq6qvBFIt5dNAeUhE4xTQ6VAuZc7ZyMzc8Od9uSzAKY4YDxMgcYzIKAuzW9mLZQO8d37Zs6q7x3z1OlssORnpaKOQFU_z_s2PBy9B9pbj42mruy098I7bj2Rr06Yp6LbSdcYi8 Mar 10 19:56:06 volumio volumio[14292]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 10 19:56:06 volumio volumio[14292]: info: New Spotify access token = BQBI_amExUSJN83M_gcZ4Iquay-beDkuB263-KtmS3oFI4FQqAzpkrpuBQO2L8PqFKXIc7cCzW6N7nl-MT3X3HTxszGcf_D53cjdmti5vpE5cnKlFycE179vX-9LhNaOxzDGho3iTcsQ4YBDYjq6qvBFIt5dNAeUhE4xTQ6VAuZc7ZyMzc8Od9uSzAKY4YDxMgcYzIKAuzW9mLZQO8d37Zs6q7x3z1OlssORnpaKOQFU_z_s2PBy9B9pbj42mruy098I7bj2Rr06Yp6LbSdcYi8 Mar 10 19:56:06 volumio volumio[14292]: info: Spotify credentials grant success - running version from March 24, 2019 Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="obtained new client token: AADEHfApA/2FmRvqyCmZr91iVdGNpnsRcwM0p91KfSScXUxWzf/qfpeqyXYH6E6FbR1gMLuS4cf/dBM36go0qx3VaFmvHtALzd7QhPdtYJ5PTIQCDMoCPmKx7538u96WP2pSz0Ji3NnpyWe1vf/O9n23pXqfCx+EPTYloemzCyxvJckb6zqT189uneJyYPIaocSpqvwUXpnaMnbxwQkhXFmL/Dp8oAN1gln3mNxGWEQQP+PAHaq4TA==" Mar 10 19:56:06 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:06 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:06 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:06 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 19:56:06 volumio sudo[14492]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Mar 10 19:56:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 19:56:06 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 10 19:56:06 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 10 19:56:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 19:56:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 19:56:06 volumio sudo[14497]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:06 volumio sudo[14495]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:06 volumio volumio[14292]: info: Shairport-Sync Started Mar 10 19:56:06 volumio volumio[14292]: Error adding Membership: Error: addMembership EINVAL Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="completed keyexchange" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="completed challenge" Mar 10 19:56:06 volumio volumio[14292]: info: Shairport-Sync Started Mar 10 19:56:06 volumio volumio[14292]: info: Shairport-Sync Started Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=info msg="authenticated AP as drmedderrasen" Mar 10 19:56:06 volumio volumio[14292]: SPOTIFY: User informations: {"country":"DE","display_name":"drmedderrasen","email":"christian.wnr@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/drmedderrasen"},"followers":{"href":null,"total":6},"href":"https://api.spotify.com/v1/users/drmedderrasen","id":"drmedderrasen","images":[],"product":"premium","type":"user","uri":"spotify:user:drmedderrasen"} Mar 10 19:56:06 volumio volumio[14292]: info: Spotify Successfully logged in Mar 10 19:56:06 volumio volumio[14292]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 19:56:06 volumio volumio[14292]: info: [1741632966441] CoreMusicLibrary::Adding element Spotify Mar 10 19:56:06 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:56:06 volumio volumio[14292]: Cannot find translation for source Spotify Mar 10 19:56:06 volumio mpd[14427]: Mar 10 19:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 10 19:56:06 volumio systemd[1]: Started Music Player Daemon. Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=info msg="authenticated Login5 as drmedderrasen" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="initializing zeroconf session, username: drmedderrasen" Mar 10 19:56:06 volumio sudo[14391]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:06 volumio sudo[14400]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:06 volumio volumio[14292]: info: Completed starting Core Plugins Mar 10 19:56:06 volumio volumio[14292]: info: ------------------------------------------- Mar 10 19:56:06 volumio volumio[14292]: info: ----- MyVolumio plugins startup ---- Mar 10 19:56:06 volumio volumio[14292]: info: ------------------------------------------- Mar 10 19:56:06 volumio volumio[14292]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="dealer connection opened" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=trace msg="starting accesspoint recv loop" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=trace msg="starting dealer recv loop" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=trace msg="received accesspoint ping" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="received connection id: MDBiYmNmZDctYzcwOC00MGNkLTgxYjAtYTQyNmY5YWM1OWE3K2RlYWxlcit0Y3A6Ly8wYWNhNTk5NC5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArODA1Qzk4MDU1NUQ2N0U4NzI3QkFDQzUxMkFFQzA0M0RCQUM1RThFNTVFMjQ2RkU2QjlDQzE2RDRDODREREFCMQ==" Mar 10 19:56:06 volumio volumio[14292]: error: MPD error: The expression evaluated to a falsy value: Mar 10 19:56:06 volumio volumio[14292]: assert.ok(self.idling) Mar 10 19:56:06 volumio volumio[14292]: error: The expression evaluated to a falsy value: Mar 10 19:56:06 volumio volumio[14292]: assert.ok(self.idling) Mar 10 19:56:06 volumio volumio[14292]: info: MPD running with PID14427 Mar 10 19:56:06 volumio volumio[14292]: ,establishing connection Mar 10 19:56:06 volumio volumio[14292]: error: updateQueue error: null Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=trace msg="received accesspoint pong ack" Mar 10 19:56:06 volumio volumio[14292]: error: updateQueue error: null Mar 10 19:56:06 volumio go-librespot[14470]: time="2025-03-10T19:56:06+01:00" level=debug msg="put connect state because NEW_DEVICE" Mar 10 19:56:08 volumio volumio[14292]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.72 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 8 Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:08 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:08 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 10 19:56:08 volumio volumio[14292]: info: Received Get System Info Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:56:08 volumio volumio[14292]: info: Discovery: Getting this device information Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:08 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:56:08 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:08 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:08 volumio volumio[14292]: info: Listing playlists Mar 10 19:56:08 volumio volumio[14292]: info: go-librespot daemon successfully initialized Mar 10 19:56:09 volumio sudo[14525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 19:56:09 volumio sudo[14525]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:09 volumio sudo[14525]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:09 volumio sudo[14527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:56:09 volumio sudo[14527]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:09 volumio sudo[14527]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:09 volumio sudo[14531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 10 19:56:09 volumio sudo[14531]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:09 volumio sudo[14531]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:09 volumio volumio[14292]: info: Upmpdcli Daemon Started Mar 10 19:56:11 volumio volumio[14292]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 10 19:56:11 volumio volumio[14292]: info: Initializing connection to go-librespot Websocket Mar 10 19:56:11 volumio go-librespot[14470]: time="2025-03-10T19:56:11+01:00" level=debug msg="new websocket client" Mar 10 19:56:11 volumio volumio[14292]: info: Connection to go-librespot Websocket established Mar 10 19:56:14 volumio volumio[14292]: info: Getting Spotify volume Mar 10 19:56:14 volumio volumio[14292]: info: Spotify volume: 100 Mar 10 19:56:14 volumio volumio[14292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 10 19:56:14 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:14 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:15 volumio volumio[14292]: SPOTIFY: RECEIVED VOLUMIO VOLUME 54 Mar 10 19:56:15 volumio volumio[14292]: SPOTIFY: SPOTIFY VOLUME 100 Mar 10 19:56:15 volumio volumio[14292]: SPOTIFY: VOLUMIO VOLUME 54 Mar 10 19:56:15 volumio volumio[14292]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 10 19:56:15 volumio volumio[14292]: info: Setting Spotify Volume from Volumio: 54 Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 10 19:56:15 volumio volumio[14292]: info: Adding plugin bluetooth to MyMusic Plugins Mar 10 19:56:15 volumio volumio[14292]: info: Adding plugin multiroom to MyMusic Plugins Mar 10 19:56:15 volumio volumio[14292]: info: Adding plugin metavolumio to MyMusic Plugins Mar 10 19:56:15 volumio volumio[14292]: info: Adding plugin cd_controller to MyMusic Plugins Mar 10 19:56:15 volumio volumio[14292]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 10 19:56:15 volumio volumio[14292]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 10 19:56:15 volumio volumio[14292]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 10 19:56:16 volumio volumio[14292]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 10 19:56:16 volumio volumio[14292]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 10 19:56:16 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:16 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:16 volumio volumio[14292]: info: Starting MyVolumio Remote Streaming Endpoints Mar 10 19:56:16 volumio volumio[14292]: info: MyVolumio login type: Token Mar 10 19:56:16 volumio volumio[14292]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 10 19:56:16 volumio volumio[14292]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 10 19:56:17 volumio volumio[14292]: info: Starting Streaming Service Transparent Proxy Mar 10 19:56:17 volumio volumio[14292]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 10 19:56:17 volumio volumio[14292]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 10 19:56:17 volumio volumio[14292]: info: Streaming services startup Mar 10 19:56:17 volumio volumio[14292]: info: Starting Streaming Daemon Mar 10 19:56:17 volumio sudo[14544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 10 19:56:17 volumio sudo[14544]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:17 volumio volumio[14292]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 10 19:56:17 volumio sudo[14544]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:17 volumio volumio[14292]: SPOTIFY: SETTING SPOTIFY VOLUME 54 Mar 10 19:56:17 volumio volumio[14292]: info: Sending Spotify command with payload to local API: /player/volume Mar 10 19:56:17 volumio go-librespot[14470]: time="2025-03-10T19:56:17+01:00" level=debug msg="update volume to 35388/65535" Mar 10 19:56:17 volumio volumio[14292]: error: Cannot start Volumio Streaming Daemon Mar 10 19:56:17 volumio volumio[14292]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 10 19:56:17 volumio volumio[14292]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 10 19:56:17 volumio volumio[14292]: error: MyVolumio Custom Token format not valid, refreshing it Mar 10 19:56:18 volumio volumio[14292]: STREAMING PROXY: Starting server on port 3245 Mar 10 19:56:18 volumio volumio[14292]: Node JS runtime: 14 Mar 10 19:56:18 volumio go-librespot[14470]: time="2025-03-10T19:56:18+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 10 19:56:18 volumio go-librespot[14470]: time="2025-03-10T19:56:18+01:00" level=trace msg="emitting websocket event: volume" Mar 10 19:56:18 volumio volumio[14292]: SPOTIFY: received: {"type":"volume","data":{"value":54,"max":100}} Mar 10 19:56:18 volumio volumio[14292]: SPOTIFY: RECEIVED SPOTIFY VOLUME 54 Mar 10 19:56:19 volumio volumio[14292]: info: MyVolumio login type: Token Mar 10 19:56:19 volumio volumio[14292]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 10 19:56:23 volumio volumio[14292]: info: MyVolumio token set successfully Mar 10 19:56:23 volumio volumio[14292]: info: MYVOLUMIO: Adding device Mar 10 19:56:23 volumio volumio[14292]: info: MYVOLUMIO: Evaluating Server Mar 10 19:56:23 volumio volumio[14292]: info: MyVolumio status changed Mar 10 19:56:23 volumio volumio[14292]: info: Streaming services startup Mar 10 19:56:23 volumio volumio[14292]: info: Starting Streaming Daemon Mar 10 19:56:23 volumio volumio[14292]: info: Removing browser output: myVolumio user plan is not superstar Mar 10 19:56:23 volumio volumio[14292]: info: Removing audio output: Mar 10 19:56:23 volumio volumio[14292]: info: Stoppping Tunnel 1 Mar 10 19:56:23 volumio sudo[14584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 10 19:56:23 volumio sudo[14584]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:23 volumio sudo[14584]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:23 volumio sudo[14587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 10 19:56:23 volumio sudo[14587]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:56:23 volumio volumio[14292]: error: Cannot start Volumio Streaming Daemon Mar 10 19:56:23 volumio volumio[14292]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 10 19:56:23 volumio volumio[14292]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 10 19:56:23 volumio sudo[14587]: pam_unix(sudo:session): session closed for user root Mar 10 19:56:23 volumio volumio[14292]: info: Remote SSH Stopped Mar 10 19:56:23 volumio volumio[14292]: info: Setting Geolocation for MyVolumio to eu10 Mar 10 19:56:23 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:23 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:23 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:24 volumio volumio[14292]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 10 19:56:24 volumio volumio[14292]: info: Updating MyVolumio device info Mar 10 19:56:24 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:24 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:24 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:25 volumio volumio[14292]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 10 19:56:28 volumio volumio[14292]: info: MYVOLUMIO: Adding device Mar 10 19:56:28 volumio volumio[14292]: info: MYVOLUMIO: Evaluating Server Mar 10 19:56:29 volumio volumio[14292]: info: Setting Geolocation for MyVolumio to eu6 Mar 10 19:56:29 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:29 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:29 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:30 volumio volumio[14292]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 10 19:56:30 volumio volumio[14292]: info: Updating MyVolumio device info Mar 10 19:56:30 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:30 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:30 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:30 volumio volumio[14292]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 10 19:56:31 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:56:31 volumio volumio[14292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 19:56:31 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:31 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=debug msg="handling transfer player command from 91d9dcc9b632df8d86413278c9938097b53274ee" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=debug msg="resolved context of track" uri="spotify:playlist:6Gvp9Vf9QNPVPmhXQS2HE9" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=trace msg="fetched new page 0 with 120 items (list: 120)" uri="spotify:playlist:6Gvp9Vf9QNPVPmhXQS2HE9" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=debug msg="loading track (paused: false, position: 49688ms)" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=trace msg="emitting websocket event: will_play" Mar 10 19:56:32 volumio volumio[14292]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:2obihzEzrYcoNXlouXiOZe","play_origin":"playlist"}} Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=warning msg="original track has no formats, alternatives have a total of 8" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=debug msg="selected format OGG_VORBIS_320 (3678391f4c30d5639b39bfd16f375c233265124d)" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=debug msg="requested aes key for file 3678391f4c30d5639b39bfd16f375c233265124d, gid: 2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=debug msg="fetched first chunk of 35, total size is 18069936 bytes" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:32 volumio go-librespot[14470]: time="2025-03-10T19:56:32+01:00" level=debug msg="fetched chunk 1/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="fetched chunk 4/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=trace msg="seek to 49688ms (diff: 136ms, samples: 2191240, bytes: 2146099)" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="created new output device" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 100000 us, period size = 4410 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 5 frames" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=info msg="loaded track \"Mantequilla - Original Mix\" (paused: false, position: 49688ms, duration: 441595ms, prefetched: false)" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="fetched chunk 7/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=trace msg="scheduling prefetch in 362s" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=trace msg="emitting websocket event: metadata" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=trace msg="emitting websocket event: active" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="sending successful reply for dealer request" Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:2obihzEzrYcoNXlouXiOZe","name":"Mantequilla - Original Mix","artist_names":["Ron Flatter"],"album_name":"Mantequilla","album_cover_url":"https://i.scdn.co/image/ab67616d00001e025d5213d4f2e728648453d031","position":49688,"duration":441595,"release_date":"year:2013 month:6 day:7","track_number":1,"disc_number":1}} Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: received: {"type":"active","data":null} Mar 10 19:56:33 volumio volumio[14292]: info: Aligning Spotify Volume to Volumio Volume Mar 10 19:56:33 volumio volumio[14292]: info: CoreCommandRouter::volumioGetState Mar 10 19:56:33 volumio volumio[14292]: info: CorePlayQueue::getTrack 0 Mar 10 19:56:33 volumio volumio[14292]: info: Setting Spotify Volume from Volumio: 54 Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="fetched chunk 2/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="fetched chunk 6/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="fetched chunk 5/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=trace msg="emitting websocket event: playing" Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:2obihzEzrYcoNXlouXiOZe","play_origin":"playlist"}} Mar 10 19:56:33 volumio volumio[14292]: info: Spotify is playing in volatile mode Mar 10 19:56:33 volumio volumio[14292]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: UNSET VOLATILE Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: {"status":"stop","position":0,"title":"","artist":"","album":"","albumart":"/albumart","duration":0,"uri":"","seek":0,"samplerate":"","channels":"","bitdepth":"","Streaming":false,"service":"mpd","volume":54,"dbVolume":null,"mute":false,"disableVolumeControl":false,"random":null,"repeat":null,"repeatSingle":false,"updatedb":false,"consume":false} Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: PUSH STATE SPOTIFY Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: {"status":"play","service":"spop","title":"Mantequilla - Original Mix","artist":"Ron Flatter","album":"Mantequilla","albumart":"https://i.scdn.co/image/ab67616d00001e025d5213d4f2e728648453d031","uri":"spotify:track:2obihzEzrYcoNXlouXiOZe","trackType":"spotify","seek":49688,"duration":441,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Mar 10 19:56:33 volumio volumio[14292]: info: CoreCommandRouter::servicePushState Mar 10 19:56:33 volumio volumio[14292]: info: CoreStateMachine::pushState Mar 10 19:56:33 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 19:56:33 volumio volumio[14292]: info: CoreCommandRouter::volumioPushState Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: RECEIVED VOLUMIO VOLUME 54 Mar 10 19:56:33 volumio go-librespot[14470]: time="2025-03-10T19:56:33+01:00" level=debug msg="fetched chunk 3/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: PUSH STATE SPOTIFY Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: {"status":"play","service":"spop","title":"Mantequilla - Original Mix","artist":"Ron Flatter","album":"Mantequilla","albumart":"https://i.scdn.co/image/ab67616d00001e025d5213d4f2e728648453d031","uri":"spotify:track:2obihzEzrYcoNXlouXiOZe","trackType":"spotify","seek":49688,"duration":441,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Mar 10 19:56:33 volumio volumio[14292]: info: CoreCommandRouter::servicePushState Mar 10 19:56:33 volumio volumio[14292]: info: CoreStateMachine::pushState Mar 10 19:56:33 volumio volumio[14292]: info: CoreCommandRouter::volumioPushState Mar 10 19:56:33 volumio volumio[14292]: SPOTIFY: RECEIVED VOLUMIO VOLUME 54 Mar 10 19:56:34 volumio volumio[14292]: SPOTIFY: SETTING SPOTIFY VOLUME 54 Mar 10 19:56:34 volumio volumio[14292]: info: Sending Spotify command with payload to local API: /player/volume Mar 10 19:56:34 volumio go-librespot[14470]: time="2025-03-10T19:56:34+01:00" level=debug msg="update volume to 35388/65535" Mar 10 19:56:35 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:56:35 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:35 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:56:35 volumio volumio-remote-updater[614]: No test mode Mar 10 19:56:35 volumio volumio-remote-updater[614]: No alpha test mode Mar 10 19:56:35 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 10 19:56:35 volumio volumio[14292]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:56:35 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:56:35 volumio go-librespot[14470]: time="2025-03-10T19:56:35+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Mar 10 19:56:35 volumio go-librespot[14470]: time="2025-03-10T19:56:35+01:00" level=trace msg="emitting websocket event: volume" Mar 10 19:56:35 volumio volumio[14292]: SPOTIFY: received: {"type":"volume","data":{"value":54,"max":100}} Mar 10 19:56:35 volumio volumio[14292]: SPOTIFY: RECEIVED SPOTIFY VOLUME 54 Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:56:36 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle received from rotary: 1 -> Dir: 1 Mar 10 19:56:36 volumio volumio[14292]: info: [ROTARYENCODER2] emitDialCommand: 1 with value 1for Rotary: 1 Mar 10 19:56:36 volumio volumio[14292]: info: [ROTARYENCODER2] emitDialCommand: VOLUME UP Mar 10 19:56:36 volumio volumio[14292]: info: VolumeController::SetAlsaVolume+ Mar 10 19:56:36 volumio volumio[14292]: info: CoreStateMachine::pushState Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 19:56:36 volumio volumio[14292]: info: CoreCommandRouter::volumioPushState Mar 10 19:56:36 volumio volumio[14292]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55 Mar 10 19:56:36 volumio volumio[14292]: SPOTIFY: SPOTIFY VOLUME 54 Mar 10 19:56:36 volumio volumio[14292]: SPOTIFY: VOLUMIO VOLUME 55 Mar 10 19:56:36 volumio volumio[14292]: SPOTIFY: DELTA VOLUME ENOUGH: false Mar 10 19:56:36 volumio go-librespot[14470]: time="2025-03-10T19:56:36+01:00" level=trace msg="sent dealer ping" Mar 10 19:56:36 volumio go-librespot[14470]: time="2025-03-10T19:56:36+01:00" level=trace msg="received dealer pong" Mar 10 19:56:37 volumio volumio[14292]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 10 19:56:37 volumio volumio[14292]: info: Completed starting MyVolumio Plugin Mar 10 19:56:37 volumio volumio[14292]: [Metrics] CommandRouter: 39s 950.80ms Mar 10 19:56:37 volumio volumio[14292]: info: CoreCommandRouter::volumiosetStartupVolume Mar 10 19:56:37 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:56:37 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:56:37 volumio volumio[14292]: info: CoreCommandRouter::Close All Modals sent Mar 10 19:56:37 volumio volumio[14292]: info: CoreCommandRouter::Close All Modals sent Mar 10 19:56:37 volumio volumio[14292]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Mar 10 19:56:37 volumio volumio[14292]: aplay: main:828: audio open error: Device or resource busy Mar 10 19:56:38 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 10 19:56:38 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:56:38 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 10 19:56:43 volumio go-librespot[14470]: time="2025-03-10T19:56:43+01:00" level=debug msg="fetched chunk 8/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:56:44 volumio volumio[14292]: info: BOOT COMPLETED Mar 10 19:56:56 volumio go-librespot[14470]: time="2025-03-10T19:56:56+01:00" level=debug msg="fetched chunk 9/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:57:04 volumio volumio[14292]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] Mar 10 19:57:04 volumio volumio[14292]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] updateEncoder: Rotary1 with: Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2]{"enabled0":true,"rotaryType0":{"value":1,"label":"1/1"},"pinA0":"23","pinB0":"24","dialAction0":{"value":1,"label":"Volume"},"socketCmdCCW0":"","socketDataCCW0":"","socketCmdCW0":"","socketDataCW0":"","pinPush0":"27","pinPushDebounce0":"50","pushState0":true,"pushAction0":{"value":13,"label":"Emit Websocket Message"},"socketCmdPush0":"callMethod","socketDataPush0":"{\"endpoint\": \"music_service/volspotconnect2\", \"method\": \"toggle\", data: \"\"}","longPushAction0":{"value":0,"label":"..."},"socketCmdLongPush0":"","socketDataLongPush0":"","delayLongPush0":"1500","doublePushAction0":{"value":0,"label":"..."},"socketCmdDoublePush0":"","socketDataDoublePush0":"","delayDoublePush0":"700"} Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] sanityCheckSettings: Rotary1 for: Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2]{"enabled0":true,"rotaryType0":{"value":1,"label":"1/1"},"pinA0":"23","pinB0":"24","dialAction0":{"value":1,"label":"Volume"},"socketCmdCCW0":"","socketDataCCW0":"","socketCmdCW0":"","socketDataCW0":"","pinPush0":"27","pinPushDebounce0":"50","pushState0":true,"pushAction0":{"value":13,"label":"Emit Websocket Message"},"socketCmdPush0":"callMethod","socketDataPush0":"{\"endpoint\": \"music_service/volspotconnect2\", \"method\": \"toggle\", data: \"\"}","longPushAction0":{"value":0,"label":"..."},"socketCmdLongPush0":"","socketDataLongPush0":"","delayLongPush0":"1500","doublePushAction0":{"value":0,"label":"..."},"socketCmdDoublePush0":"","socketDataDoublePush0":"","delayDoublePush0":"700"} Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] sanityCheckSettings: allPins:23,24,27 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachAllListeners: 1,2,3 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachAllListeners: 1,2 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachAllListeners: 1 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachAllListeners: Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachAllListeners: end of recursion. Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachListener: Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2]{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14477},"spawnargs":["/bin/cat","/dev/input/by-path/platform-rotary@17-event"],"pid":14477,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]} Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachListener: successfully killed handler process Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachListener: Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2]{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14490},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@1b-event"],"pid":14490,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]} Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachListener: successfully killed handler process Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachListener: no handler process to kill Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] detachListener: no handler process to kill Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] uninstallAllOverlays: 1,2,3 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] uninstallAllOverlays: 2,3 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] uninstallAllOverlays: 3 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] uninstallAllOverlays: Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] uninstallAllOverlays: end of recursion. Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: Checking for existing overlays for Rotary: 1 type: rotary Mar 10 19:57:04 volumio sudo[14714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 10 19:57:04 volumio sudo[14714]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:04 volumio sudo[14714]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: check pinA=23pinB=24 in Overlays (in load order): Mar 10 19:57:04 volumio volumio[14292]: 0: rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 Mar 10 19:57:04 volumio volumio[14292]: 1: gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: rotary 1 uses overlay 0 Mar 10 19:57:04 volumio volumio[14292]: info: [ROTARYENCODER2] removeOverlay: 0 Mar 10 19:57:04 volumio sudo[14717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Mar 10 19:57:04 volumio sudo[14717]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:05 volumio kernel: input: button@1b as /devices/platform/button@1b/input/input8 Mar 10 19:57:05 volumio sudo[14717]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] removeOverlay: 0 returned: Mar 10 19:57:05 volumio sudo[14730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 10 19:57:05 volumio sudo[14730]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:05 volumio sudo[14730]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] removeOverlay: "overlay -l" returned: Overlays (in load order): Mar 10 19:57:05 volumio volumio[14292]: 0: gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: Checking for existing overlays for Rotary: 1 type: button Mar 10 19:57:05 volumio sudo[14733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 10 19:57:05 volumio sudo[14733]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:05 volumio sudo[14733]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: check pinA=27pinB=undefined in Overlays (in load order): Mar 10 19:57:05 volumio volumio[14292]: 0: gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: button 1 uses overlay 0 Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] removeOverlay: 0 Mar 10 19:57:05 volumio sudo[14736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Mar 10 19:57:05 volumio sudo[14736]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:05 volumio systemd-udevd[14722]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 10 19:57:05 volumio systemd-logind[617]: Failed to open /dev/input/event0: No such device Mar 10 19:57:05 volumio sudo[14736]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] removeOverlay: 0 returned: Mar 10 19:57:05 volumio sudo[14746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 10 19:57:05 volumio sudo[14746]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:05 volumio sudo[14746]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] removeOverlay: "overlay -l" returned: No overlays loaded Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] uninstallAllOverlays: overlays removed Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] updateEncoder: Changing Encoder 1 Settings to new values Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: 1,2,3 Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: 1,2 Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: 1 Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] installAllOverlays: end of recursion. Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] addOverlay for Rotary: 23 24 1 Mar 10 19:57:05 volumio volumio[14292]: info: [ROTARYENCODER2] addOverlay: executing command: /usr/bin/sudo /usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 & Mar 10 19:57:05 volumio sudo[14749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 Mar 10 19:57:05 volumio sudo[14749]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:05 volumio kernel: rotary-encoder rotary@17: gray Mar 10 19:57:05 volumio kernel: input: rotary@17 as /devices/platform/rotary@17/input/input9 Mar 10 19:57:05 volumio sudo[14749]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:05 volumio volumio[14292]: info: /dev/input: Mar 10 19:57:05 volumio volumio[14292]: event0 Mar 10 19:57:05 volumio volumio[14292]: mice Mar 10 19:57:05 volumio systemd-udevd[14722]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 10 19:57:06 volumio volumio[14292]: info: [ROTARYENCODER2] addOverlay for Button: 27 true up Mar 10 19:57:06 volumio volumio[14292]: info: [ROTARYENCODER2] addOverlay: executing command: /usr/bin/sudo /usr/bin/dtoverlay gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 & Mar 10 19:57:06 volumio sudo[14764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 Mar 10 19:57:06 volumio sudo[14764]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:06 volumio go-librespot[14470]: time="2025-03-10T19:57:06+01:00" level=trace msg="sent dealer ping" Mar 10 19:57:06 volumio kernel: input: button@1b as /devices/platform/button@1b/input/input10 Mar 10 19:57:06 volumio sudo[14764]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:06 volumio go-librespot[14470]: time="2025-03-10T19:57:06+01:00" level=trace msg="received dealer pong" Mar 10 19:57:06 volumio volumio[14292]: info: /dev/input: Mar 10 19:57:06 volumio volumio[14292]: by-path Mar 10 19:57:06 volumio volumio[14292]: event0 Mar 10 19:57:06 volumio volumio[14292]: event1 Mar 10 19:57:06 volumio volumio[14292]: mice Mar 10 19:57:06 volumio volumio[14292]: /dev/input/by-path: Mar 10 19:57:06 volumio volumio[14292]: platform-rotary@17-event Mar 10 19:57:07 volumio systemd-udevd[14722]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: 1,2,3 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: 1,2 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: 1 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: end of recursion. Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: Checking for existing overlays for Rotary: 1 type: rotary Mar 10 19:57:07 volumio sudo[14777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 10 19:57:07 volumio sudo[14777]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:07 volumio sudo[14777]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: check pinA=23pinB=24 in Overlays (in load order): Mar 10 19:57:07 volumio volumio[14292]: 0: rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 Mar 10 19:57:07 volumio volumio[14292]: 1: gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: rotary 1 uses overlay 0 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: attach rotary 1 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachListener: path: /dev/input/by-path/platform-rotary@17-event, type: rotary Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: Checking for existing overlays for Rotary: 1 type: button Mar 10 19:57:07 volumio sudo[14781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 10 19:57:07 volumio sudo[14781]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:57:07 volumio sudo[14781]: pam_unix(sudo:session): session closed for user root Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: check pinA=27pinB=undefined in Overlays (in load order): Mar 10 19:57:07 volumio volumio[14292]: 0: rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=1 Mar 10 19:57:07 volumio volumio[14292]: 1: gpio-key gpio=27 active_low=1 gpio_pull=up keycode=20 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] checkOverlayExists: button 1 uses overlay 1 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners: attach button 1 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachListener: path: /dev/input/by-path/platform-button@1b-event, type: button Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners rotaries: Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14779},"spawnargs":["/bin/cat","/dev/input/by-path/platform-rotary@17-event"],"pid":14779,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners buttons: Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14783},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@1b-event"],"pid":14783,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners rotaries: Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14779},"spawnargs":["/bin/cat","/dev/input/by-path/platform-rotary@17-event"],"pid":14779,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] attachAllListeners buttons: Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14783},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@1b-event"],"pid":14783,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] onStart: Attach Event-handles now. Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] Now addAllEventHandles for rotaries. Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle for rotary: 1 type: rotary Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] Now addAllEventHandles for buttons. Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle for rotary: 1 type: button Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle: adding handle : Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2]{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":14783},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@1b-event"],"pid":14783,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]} Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] getI18nString("TOAST_MSG_SAVE"):Settings for Encoder Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] updateEncoder: SUCCESS with Toast: Successfully saved Settings for Encoder 1 Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Mar 10 19:57:07 volumio volumio[14292]: info: [ROTARYENCODER2] getI18nString("TOAST_MSG_SAVE"):Settings for Encoder Mar 10 19:57:08 volumio go-librespot[14470]: time="2025-03-10T19:57:08+01:00" level=debug msg="fetched chunk 10/34, size: 524288" uri="spotify:track:2obihzEzrYcoNXlouXiOZe" Mar 10 19:57:15 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle received from rotary: 1 Button: 1 Mar 10 19:57:15 volumio volumio[14292]: info: [ROTARYENCODER2] Push Button 1 pressed. Mar 10 19:57:15 volumio volumio[14292]: info: [ROTARYENCODER2] Push Button 1 starting timers. Mar 10 19:57:16 volumio volumio[14292]: info: [ROTARYENCODER2] addEventHandle received from rotary: 1 Button: 0 Mar 10 19:57:16 volumio volumio[14292]: info: [ROTARYENCODER2] Push Button 1 released after 172ms. Mar 10 19:57:16 volumio volumio[14292]: info: [ROTARYENCODER2] Push Button 1 doublepush timer elapsed. (false, 1) Mar 10 19:57:16 volumio volumio[14292]: info: [ROTARYENCODER2] Push Button 1 sending single push command. Mar 10 19:57:16 volumio volumio[14292]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 19:57:16 volumio volumio[14292]: SyntaxError: Unexpected token d in JSON at position 66 Mar 10 19:57:16 volumio volumio[14292]: at JSON.parse () Mar 10 19:57:16 volumio volumio[14292]: at rotaryencoder2.emitPushCommand (/data/plugins/system_hardware/rotaryencoder2/index.js:1032:17) Mar 10 19:57:16 volumio volumio[14292]: at Timeout._onTimeout (/data/plugins/system_hardware/rotaryencoder2/index.js:913:16) Mar 10 19:57:16 volumio volumio[14292]: at listOnTimeout (internal/timers.js:554:17) Mar 10 19:57:16 volumio volumio[14292]: at processTimers (internal/timers.js:497:7) Mar 10 19:57:16 volumio volumio[14292]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 19:57:17 volumio sudo[14811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-10 19:56 Mar 10 19:57:17 volumio sudo[14811]: 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"