-- Logs begin at Wed 2025-07-02 13:13:28 CEST, end at Wed 2025-07-02 13:22:31 CEST. -- Jul 02 13:21:07 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:21:07 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:21:07 stue volumio[952]: info: Listing playlists Jul 02 13:21:07 stue volumio[952]: info: Listing playlists Jul 02 13:21:13 stue go-librespot[1507]: time="2025-07-02T13:21:13+02:00" level=trace msg="sent dealer ping" Jul 02 13:21:13 stue go-librespot[1507]: time="2025-07-02T13:21:13+02:00" level=trace msg="received dealer pong" Jul 02 13:21:17 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:21:17 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:21:27 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:21:27 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:21:27 stue volumio[952]: info: Listing playlists Jul 02 13:21:27 stue volumio[952]: info: Listing playlists Jul 02 13:21:37 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:21:37 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:21:43 stue go-librespot[1507]: time="2025-07-02T13:21:43+02:00" level=trace msg="received accesspoint ping" Jul 02 13:21:43 stue go-librespot[1507]: time="2025-07-02T13:21:43+02:00" level=trace msg="received accesspoint pong ack" Jul 02 13:21:43 stue go-librespot[1507]: time="2025-07-02T13:21:43+02:00" level=trace msg="sent dealer ping" Jul 02 13:21:43 stue go-librespot[1507]: time="2025-07-02T13:21:43+02:00" level=trace msg="received dealer pong" Jul 02 13:21:47 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:21:47 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:21:47 stue volumio[952]: info: Listing playlists Jul 02 13:21:47 stue volumio[952]: info: Listing playlists Jul 02 13:21:57 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:21:57 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:07 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:07 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:07 stue volumio[952]: info: Listing playlists Jul 02 13:22:07 stue volumio[952]: info: Listing playlists Jul 02 13:22:11 stue sudo[3596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 02 13:22:11 stue sudo[3596]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 13:22:11 stue sudo[3596]: pam_unix(sudo:session): session closed for user root Jul 02 13:22:11 stue sudo[3599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 02 13:22:11 stue sudo[3599]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 02 13:22:11 stue sudo[3599]: pam_unix(sudo:session): session closed for user root Jul 02 13:22:11 stue volumio[952]: verbose: New Socket.io Connection to 192.168.1.248 from 192.168.1.49 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Engine version: 3 Transport: polling Total Clients: 10 Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::volumioGetVisibleSources Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:11 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 02 13:22:11 stue volumio[952]: info: Received Get System Info Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 13:22:11 stue volumio[952]: info: Discovery: Getting this device information Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:11 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:11 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:11 stue volumio[952]: info: Listing playlists Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 02 13:22:11 stue volumio[952]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: RS232; amps: ["Denon - AVC-A11XV","Anthem - IDMSTR IA","Rotel - A12","Rotel - A14","Rotel - A11","Rotel - RC-1570","Rotel - RC-1592 >=V1.53","Rotel - RSP-1582 SW V5.xx","Rotel - RA-1592 SW >=V1.52","Meridian - DSP420","Cambridge - CXA61"]selected: Denon - AVC-A11XV Jul 02 13:22:11 stue volumio[952]: error: [SERIALAMPCONTROLLER] getUIConfig: failed: Error: The value undefined is not a number Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 13:22:11 stue volumio[952]: info: FusionDsp - Jul 02 13:22:11 stue volumio[952]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json Jul 02 13:22:11 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 02 13:22:12 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 02 13:22:13 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 02 13:22:13 stue volumio[952]: info: Received Get System Info Jul 02 13:22:13 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 13:22:13 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 13:22:13 stue volumio[952]: info: Discovery: Getting this device information Jul 02 13:22:13 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:13 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:13 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 13:22:13 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 02 13:22:13 stue go-librespot[1507]: time="2025-07-02T13:22:13+02:00" level=trace msg="sent dealer ping" Jul 02 13:22:13 stue go-librespot[1507]: time="2025-07-02T13:22:13+02:00" level=trace msg="received dealer pong" Jul 02 13:22:16 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:16 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:17 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:17 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 13:22:18 stue volumio[952]: info: FusionDsp - Jul 02 13:22:18 stue volumio[952]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 02 13:22:18 stue volumio[952]: info: Received Get System Info Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 13:22:18 stue volumio[952]: info: Discovery: Getting this device information Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:18 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 02 13:22:18 stue volumio[952]: info: Received Get System Info Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 13:22:18 stue volumio[952]: info: Discovery: Getting this device information Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:18 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:18 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 13:22:19 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 02 13:22:19 stue volumio[952]: info: Received Get System Info Jul 02 13:22:19 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 13:22:19 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 13:22:19 stue volumio[952]: info: Discovery: Getting this device information Jul 02 13:22:19 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:19 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:19 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 13:22:21 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 02 13:22:21 stue volumio[952]: info: [SERIALAMPCONTROLLER] closePorts: closing RS232 Jul 02 13:22:21 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 02 13:22:21 stue volumio[952]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards "0,3" Jul 02 13:22:21 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 02 13:22:21 stue volumio[952]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards [{"id":"0,3","alsacard":"HDMI","alsadevice":3,"name":"HDMI 0"},{"id":"0,7","alsacard":"HDMI","alsadevice":7,"name":"HDMI 1"},{"id":"0,8","alsacard":"HDMI","alsadevice":8,"name":"HDMI 2"},{"id":"1,0","alsacard":"PCH","alsadevice":0,"name":"Analog Out"}] Jul 02 13:22:21 stue volumio[952]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 02 13:22:21 stue volumio[952]: info: Updating Volume Controller Parameters: Device: 0,3 Name: HDMI 0 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 02 13:22:21 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 02 13:22:21 stue volumio[952]: info: Disabling external Volume Control Jul 02 13:22:21 stue volumio[952]: error: Plugin serialampcontroller does not return adequate promise from onStop: please update! Jul 02 13:22:21 stue volumio[952]: info: CoreStateMachine::pushState Jul 02 13:22:21 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:21 stue volumio[952]: info: CoreCommandRouter::volumioPushState Jul 02 13:22:21 stue volumio[952]: info: Disabling plugin serialampcontroller Jul 02 13:22:21 stue volumio[952]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: {"device":"0,3","mixer":"","devicename":"","mixertype":"None","maxvolume":100,"volumecurve":"logarithmic","volumesteps":1,"currentmute":true,"name":"HDMI 0"} undefined Jul 02 13:22:21 stue volumio[952]: info: Done. Jul 02 13:22:21 stue volumio[952]: info: [SERIALAMPCONTROLLER] closePorts: closed serial port Jul 02 13:22:21 stue volumio[952]: info: [SERIALAMPCONTROLLER] closePorts: remaining config: {"_readableState":{"objectMode":false,"highWaterMark":65536,"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":true,"autoDestroy":true,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"dataEmitted":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":65536,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":true,"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":true,"autoDestroy":true,"errored":null,"closed":false},"allowHalfOpen":true,"port":{"fd":null,"openOptions":{"vmin":1,"vtime":0,"dataBits":8,"lock":false,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false,"hupcl":true,"baudRate":9600,"path":"/dev/ttyUSB0"},"poller":{"_events":{},"_eventsCount":0,"poller":{}},"writeOperation":null},"_kMinPoolSpace":128,"opening":false,"closing":false,"settings":{"autoOpen":false,"endOnClose":true,"highWaterMark":65536,"binding":{"fd":55},"lock":false,"baudRate":9600,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false,"path":"/dev/ttyUSB0"}} Jul 02 13:22:21 stue volumio[952]: info: [SERIALAMPCONTROLLER] on:pushState: {"status":"stop","position":0,"title":"DR P3","albumart":"http://cdn-radiotime-logos.tunein.com/_0q.png","uri":"http://live-icy.gss.dr.dk/A/A05L.mp3.m3u","trackType":"webradio","seek":0,"samplerate":"","bitdepth":"","channels":0,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":100,"dbVolume":null,"disableVolumeControl":true,"mute":false,"stream":"webradio","updatedb":false,"volatile":false,"service":"webradio"} - stop Jul 02 13:22:21 stue volumio[952]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 02 13:22:21 stue volumio[952]: info: FusionDsp - Jul 02 13:22:21 stue volumio[952]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json Jul 02 13:22:27 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:27 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:27 stue volumio[952]: info: Listing playlists Jul 02 13:22:27 stue volumio[952]: info: Listing playlists Jul 02 13:22:29 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 02 13:22:29 stue volumio[952]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 02 13:22:29 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 02 13:22:29 stue volumio[952]: info: Received Get System Version Jul 02 13:22:29 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 02 13:22:29 stue volumio[952]: info: Received Get System Info Jul 02 13:22:29 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 02 13:22:29 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 02 13:22:29 stue volumio[952]: info: Discovery: Getting this device information Jul 02 13:22:29 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:29 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:29 stue volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 02 13:22:31 stue volumio[952]: info: Enabling plugin serialampcontroller Jul 02 13:22:31 stue volumio[952]: info: Loading plugin "serialampcontroller"... Jul 02 13:22:31 stue volumio[952]: info: Applying required configuration parameters for plugin serialampcontroller Jul 02 13:22:31 stue volumio[952]: info: Applying required configuration parameters for plugin serialampcontroller Jul 02 13:22:31 stue volumio[952]: info: PLUGIN START: serialampcontroller Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] onStart: config: {"syncSave":true,"autosave":true,"autosaveDelay":1000,"saved":true,"atomicSave":false,"data":{"logging":{"type":"boolean","value":true},"serialInterfaceDev":{"type":"string","value":"usb-1a86_USB2.0-Ser_-if00-port0"},"ampType":{"type":"string","value":"Denon - AVC-A11XV"},"volumioInput":{"type":"string","value":"DVD"},"minVolume":{"type":"number","value":0},"maxVolume":{"type":"number","value":80},"startupVolume":{"type":"number","value":50},"volumeSteps":{"type":"number","value":1},"mapTo100":{"type":"boolean","value":false},"pauseWhenMuted":{"type":"boolean","value":false},"pauseWhenInputChanged":{"type":"boolean","value":false},"switchInputAtPlay":{"type":"boolean","value":false},"startAtPowerup":{"type":"boolean","value":false},"tcpip":{"type":"boolean","value":false},"ipaddress":{"type":"string","value":"192.168.1.246"},"powerupOnBoot":{"type":"boolean","value":true},"powerupOnPlay":{"type":"boolean","value":true},"idlePowerOffDelay":{"type":"number"}},"callbacks":{"_":{}},"filePath":"/data/configuration/system_hardware/serialampcontroller/config.json"} Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] loadI18nStrings: /data/plugins/system_hardware/serialampcontroller/i18n/strings_da.json Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] loadI18nStrings: da not found. Fallback to en Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] loadAmpDefinitions: loaded AmpDefinitions for 11(serial) and 3 (TCP/IP) Amplifiers. Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] listSerialDevices: found 1 devices.[{"path":"/dev/ttyUSB0","manufacturer":"1a86","pnpId":"usb-1a86_USB2.0-Ser_-if00-port0","vendorId":"1a86","productId":"7523"}] Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] setActiveAmp: {"vendor":"Denon","model":"AVC-A11XV","baudRate":9600,"parity":"none","dataBits":8,"stopBits":1,"rtscts":false,"xon":false,"xoff":false,"xany":false,"sources":["PHONO","CD","TUNER","DVD","VDP","TV","DBS","VCR-1","VCR-2","VCR-3","V.AUX","CDR/TAPE"],"sourceCmd":["SIPHONO\r","SICD\r","SITUNER\r","SIDVD\r","SIVDP\r","SITV\r","SIDBS\r","SIVCR-\r1","SIVCR-2\r","SIVCR-3\r","SIV.AUX\r","SICDR/TAPE\r"],"sourceRespPostfix":["SIPHONO","SICD","SITUNER","SIDVD","SIVDP","SITV","SIDBS","SIVCR-1","SIVCR-2","SIVCR-3","SIV.AUX","SICDR/TAPE"],"delimiter":"\r","commands":{"powerOn":"PWON\r","volUp":"MVUP\r","powerToggle":"PWSTANDBY\r","volDown":"MVDOWN\r","volValue":"MV##\r","muteOn":"MUON\r","muteOff":"MUOFF\r"},"responses":[{"rx":"PWON","cmd":["respPowerOn"]},{"rx":"PWSTANDBY","cmd":["respPowerOff"]},{"rx":"MV([0-9]{2,3})","cmd":["respVolume"]},{"rx":"MUON","cmd":["respMuteOn"]},{"rx":"MUOFF","cmd":["respMuteOff"]},{"rx":"SI([a-z_12]*)","cmd":["respSource"]}],"statusRequests":{"reqPower":"PW?\r","reqSource":"SI?\r","reqVolume":"MV?\r","reqMute":"MU?\r"}} Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] setActiveAmp: can send these responses: respPowerOn,respPowerOff,respVolume,respMuteOn,respMuteOff,respSource Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] selectedInterfaceExists: usb-1a86_USB2.0-Ser_-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"1a86","pnpId":"usb-1a86_USB2.0-Ser_-if00-port0","vendorId":"1a86","productId":"7523"}]?: true Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] selectedAmpSupportsInterface: RS232 in [] Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] openSerialPort: starting Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] openSerialPort: check for usb-1a86_USB2.0-Ser_-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"1a86","pnpId":"usb-1a86_USB2.0-Ser_-if00-port0","vendorId":"1a86","productId":"7523"}] Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] openSerialPort: connect to [{"path":"/dev/ttyUSB0","manufacturer":"1a86","pnpId":"usb-1a86_USB2.0-Ser_-if00-port0","vendorId":"1a86","productId":"7523"}] configured with: {"autoOpen":false,"lock":false,"endOnClose":true,"baudRate":9600,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false} at /dev/ttyUSB0 Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] openSerialPort: Now trying to open port Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] attachParser: Port is now open. Connecting Parser with delimiter: Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] getAmpStatus: sending status requests to Amp Jul 02 13:22:31 stue volumio[952]: (node:952) UnhandledPromiseRejectionWarning: TypeError [ERR_INVALID_ARG_TYPE]: The "chunk" argument must be of type string or an instance of Buffer or Uint8Array. Received undefined Jul 02 13:22:31 stue volumio[952]: at new NodeError (internal/errors.js:322:7) Jul 02 13:22:31 stue volumio[952]: at SerialPort.Writable.write (internal/streams/writable.js:285:13) Jul 02 13:22:31 stue volumio[952]: at SerialPort.write (/data/plugins/system_hardware/serialampcontroller/node_modules/@serialport/stream/dist/index.js:152:22) Jul 02 13:22:31 stue volumio[952]: at serialampcontroller.sendStatusRequest (/data/plugins/system_hardware/serialampcontroller/index.js:1116:19) Jul 02 13:22:31 stue volumio[952]: at serialampcontroller.getAmpStatus (/data/plugins/system_hardware/serialampcontroller/index.js:327:14) Jul 02 13:22:31 stue volumio[952]: at SerialPort. (/data/plugins/system_hardware/serialampcontroller/index.js:650:26) Jul 02 13:22:31 stue volumio[952]: at SerialPort.emit (events.js:400:28) Jul 02 13:22:31 stue volumio[952]: at settings.binding.open.then.opening (/data/plugins/system_hardware/serialampcontroller/node_modules/@serialport/stream/dist/index.js:111:18) Jul 02 13:22:31 stue volumio[952]: (node:952) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 5) Jul 02 13:22:31 stue volumio[952]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jul 02 13:22:31 stue volumio[952]: info: CoreCommandRouter::volumioGetState Jul 02 13:22:31 stue volumio[952]: info: CorePlayQueue::getTrack 0 Jul 02 13:22:31 stue volumio[952]: info: [SERIALAMPCONTROLLER] on:pushState: {"status":"stop"} - stop Jul 02 13:22:31 stue volumio[952]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 13:22:31 stue volumio[952]: Error: The value undefined is not a number Jul 02 13:22:31 stue volumio[952]: at Config.forceToType (/data/plugins/system_hardware/serialampcontroller/node_modules/v-conf/index.js:323:20) Jul 02 13:22:31 stue volumio[952]: at Config.get (/data/plugins/system_hardware/serialampcontroller/node_modules/v-conf/index.js:138:21) Jul 02 13:22:31 stue volumio[952]: at Socket. (/data/plugins/system_hardware/serialampcontroller/index.js:286:56) Jul 02 13:22:31 stue volumio[952]: at Socket.Emitter.emit (/data/plugins/system_hardware/serialampcontroller/node_modules/component-emitter/index.js:145:20) Jul 02 13:22:31 stue volumio[952]: at Socket.onevent (/data/plugins/system_hardware/serialampcontroller/node_modules/socket.io-client/lib/socket.js:278:10) Jul 02 13:22:31 stue volumio[952]: at Socket.onpacket (/data/plugins/system_hardware/serialampcontroller/node_modules/socket.io-client/lib/socket.js:236:12) Jul 02 13:22:31 stue volumio[952]: at Manager. (/data/plugins/system_hardware/serialampcontroller/node_modules/component-bind/index.js:21:15) Jul 02 13:22:31 stue volumio[952]: at Manager.Emitter.emit (/data/plugins/system_hardware/serialampcontroller/node_modules/component-emitter/index.js:145:20) Jul 02 13:22:31 stue volumio[952]: at Manager.ondecoded (/data/plugins/system_hardware/serialampcontroller/node_modules/socket.io-client/lib/manager.js:349:8) Jul 02 13:22:31 stue volumio[952]: at Decoder. (/data/plugins/system_hardware/serialampcontroller/node_modules/component-bind/index.js:21:15) Jul 02 13:22:31 stue volumio[952]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 02 13:22:31 stue sudo[3667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-02 13:21 Jul 02 13:22:31 stue sudo[3667]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"