Feb 27 00:15:01 volumio volumio[1293]: error: [SERIALAMPCONTROLLER] onTcpError: Connection refused, trying to reconnect in 5 seconds. Feb 27 00:15:01 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] onTcpClose: Port has closed, removing listeners. Feb 27 00:15:01 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:02 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:03 volumio systemd[1]: Starting apt-daily.service - Daily apt download activities... Feb 27 00:15:05 volumio systemd[1]: apt-daily.service: Deactivated successfully. Feb 27 00:15:05 volumio systemd[1]: Finished apt-daily.service - Daily apt download activities. Feb 27 00:15:05 volumio systemd[1]: apt-daily.service: Consumed 1.076s CPU time. Feb 27 00:15:06 volumio volumio[1293]: error: [SERIALAMPCONTROLLER] onTcpError: Connection refused, trying to reconnect in 5 seconds. Feb 27 00:15:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] onTcpClose: Port has closed, removing listeners. Feb 27 00:15:06 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:07 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:11 volumio volumio[1293]: error: [SERIALAMPCONTROLLER] onTcpError: Connection refused, trying to reconnect in 5 seconds. Feb 27 00:15:11 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] onTcpClose: Port has closed, removing listeners. Feb 27 00:15:11 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:12 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:16 volumio volumio[1293]: error: [SERIALAMPCONTROLLER] onTcpError: Connection refused, trying to reconnect in 5 seconds. Feb 27 00:15:16 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] onTcpClose: Port has closed, removing listeners. Feb 27 00:15:16 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:17 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:20 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 27 00:15:20 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 27 00:15:21 volumio volumio[1293]: error: [SERIALAMPCONTROLLER] onTcpError: Connection refused, trying to reconnect in 5 seconds. Feb 27 00:15:21 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] onTcpClose: Port has closed, removing listeners. Feb 27 00:15:21 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:22 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:25 volumio volumio[1293]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 00:15:25 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: TCP/IP; amps: ["Rotel - RC-1592 >=V1.53","Rotel - RSP-1582 SW V5.xx","Rotel - RA-1592 SW >=V1.52"]selected: Rotel - RC-1592 >=V1.53 Feb 27 00:15:26 volumio volumio[1293]: error: [SERIALAMPCONTROLLER] onTcpError: Connection refused, trying to reconnect in 5 seconds. Feb 27 00:15:26 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] onTcpClose: Port has closed, removing listeners. Feb 27 00:15:26 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:27 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:31 volumio volumio[1293]: error: [SERIALAMPCONTROLLER] onTcpError: Connection refused, trying to reconnect in 5 seconds. Feb 27 00:15:31 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] onTcpClose: Port has closed, removing listeners. Feb 27 00:15:31 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:32 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:34 volumio volumio[1293]: info: CALLMETHOD: system_hardware serialampcontroller updateSerialSettings [object Object] Feb 27 00:15:34 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateSerialSettings Feb 27 00:15:34 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] updateSerialSettings: Saving Interface Settings:{"tcp_ip":false,"serial_interface_dev":{"value":1,"label":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0"},"ip_address":"127.0.0.1"} Feb 27 00:15:34 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closing TCP/IP Feb 27 00:15:34 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: Volume settings have been reset. Feb 27 00:15:34 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: Volume settings have been reset. Feb 27 00:15:34 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closed TCP/IP socket Feb 27 00:15:34 volumio volumio[1293]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 00:15:34 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: RS232; amps: ["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: ... Feb 27 00:15:34 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Feb 27 00:15:34 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SERIAL_SAVE"):Serial Interface Settings Feb 27 00:15:36 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:37 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:41 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:42 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:46 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:47 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:49 volumio volumio[1293]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpType [object Object] Feb 27 00:15:49 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpType Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] updateAmpType: Saving Amplifier Settings:{"amp_type":{"value":10,"label":"Cambridge - CXA61"}} Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: port is undefined Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: Volume settings have been reset. Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: {"vendor":"Cambridge","model":"CXA61","baudRate":9600,"parity":"none","dataBits":8,"stopBits":1,"rtscts":false,"xon":false,"xoff":false,"xany":false,"sources":["A1","A2","A3","A4","D1","D2","D3","MP3","Bluetooth","USB"],"sourceCmd":["#03,04,00\r","#03,04,01\r","#03,04,02\r","#03,04,03\r","#03,04,04\r","#03,04,05\r","#03,04,06\r","#03,04,10\r","#03,04,14\r","#03,04,16\r"],"sourceRespPostfix":["00","01","02","03","04","05","06","10","14","16"],"delimiter":"\r","commands":{"powerOn":"#1,02,1\r","muteOn":"#1,04,1\r","muteOff":"#1,04,0\r"},"responses":[{"rx":"#02,01,1","cmd":["respPowerOn"]},{"rx":"#02,01,0","cmd":["respPowerOff"]},{"rx":"#02,03,1","cmd":["respMuteOn"]},{"rx":"#02,03,0","cmd":["respMuteOff"]},{"rx":"#04,01,([0-9]*)","cmd":["respSource"]}],"statusRequests":{"reqPower":"#01,01\r","reqSource":"#03,01\r","reqVolume":"","reqMute":"#01,03\r","reqModel":"#13,02\r"}} Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: can send these responses: respPowerOn,respPowerOff,respMuteOn,respMuteOff,respSource Feb 27 00:15:49 volumio volumio[1293]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: RS232; amps: ["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: Cambridge - CXA61 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedInterfaceExists: usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}]?: true Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedAmpSupportsInterface: RS232 in [] Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: starting Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: check for usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: connect to [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] 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 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Now trying to open port Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_TYPE_SAVE"):Amplifier Type Feb 27 00:15:49 volumio volumio[1293]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] attachParser: Port is now open. Connecting Parser with delimiter: Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getAmpStatus: sending status requests to Amp Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Connection established. Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: volValue command string has no ## characters. Do not know how to send volume value. Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqModel": #13,02 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqPower": #01,01 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqMute": #01,03 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqSource": #03,01 Feb 27 00:15:49 volumio volumio[1293]: info: CoreCommandRouter::volumioGetState Feb 27 00:15:49 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:15:49 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - pause Feb 27 00:15:51 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:52 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:56 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:15:57 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:01 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:02 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:06 volumio volumio[1293]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpType [object Object] Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpType Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] updateAmpType: Saving Amplifier Settings:{"amp_type":{"value":2,"label":"Rotel - A12"}} Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closing RS232 Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards "5" Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"2","alsacard":"vc4hdmi0","name":"HDMI 0 Out"},{"id":"3","alsacard":"vc4hdmi1","name":"HDMI 1 Out"}] Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 27 00:16:06 volumio volumio[1293]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 27 00:16:06 volumio volumio[1293]: info: Disabling external Volume Control Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: {"vendor":"Rotel","model":"A12","baudRate":115200,"parity":"none","dataBits":8,"stopBits":1,"rtscts":false,"xon":false,"xoff":false,"xany":false,"sources":["CD","Coax1","Coax2","Opt1","Opt2","Aux1","Aux2","Tuner","Phono","USB","Bluetooth","PC-USB"],"sourceCmd":["cd!","coax1!","coax2!","opt1!","opt2!","aux1!","aux2!","tuner!","phono!","usb!","bluetooth!","pcusb!"],"sourceRespPostfix":["cd","coax1","coax2","opt1","opt2","aux1","aux2","tuner","phono","usb","bluetooth","pc_usb"],"delimiter":"$","commands":{"powerOn":"power_on!","powerToggle":"power_toggle!","volUp":"vol_up!","volDown":"vol_dwn!","volValue":"vol_##!","mute":"mute!","muteOn":"mute_on!","muteOff":"mute_off!"},"responses":[{"rx":"power=on","cmd":["respPowerOn"]},{"rx":"power=standby","cmd":["respPowerOff"]},{"rx":"volume=([0-9]{2})","cmd":["respVolume"]},{"rx":"mute=on","cmd":["respMuteOn"]},{"rx":"mute=off","cmd":["respMuteOff"]},{"rx":"source=([a-z_12]*)","cmd":["respSource"]}],"statusRequests":{"reqPower":"power?","reqSource":"source?","reqVolume":"volume?","reqMute":"mute?","reqModel":"model?"}} Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: can send these responses: respPowerOn,respPowerOff,respVolume,respMuteOn,respMuteOff,respSource Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 00:16:06 volumio volumio[1293]: info: CoreStateMachine::pushState Feb 27 00:16:06 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: {"device":"5","mixer":"","devicename":"","mixertype":"None","maxvolume":100,"volumecurve":"logarithmic","volumesteps":1,"currentmute":true,"name":""} undefined Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closed serial port Feb 27 00:16:06 volumio volumio[1293]: 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,"constructed":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":0,"_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":false,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"constructed":true,"prefinished":false,"errorEmitted":false,"emitClose":true,"autoDestroy":true,"errored":null,"closed":false,"closeEmitted":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":34},"lock":false,"baudRate":9600,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false,"path":"/dev/ttyUSB0"}} Feb 27 00:16:06 volumio volumio[1293]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: RS232; amps: ["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: Rotel - A12 Feb 27 00:16:06 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedInterfaceExists: usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}]?: true Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedAmpSupportsInterface: RS232 in [] Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: starting Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: check for usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: connect to [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] configured with: {"autoOpen":false,"lock":false,"endOnClose":true,"baudRate":115200,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false} at /dev/ttyUSB0 Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Now trying to open port Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_TYPE_SAVE"):Amplifier Type Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] attachParser: Port is now open. Connecting Parser with delimiter: $ Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getAmpStatus: sending status requests to Amp Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Connection established. Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_10! Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqModel": model? Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqPower": power? Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqVolume": volume? Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqMute": mute? Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqSource": source? Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_10! Feb 27 00:16:06 volumio volumio[1293]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 27 00:16:06 volumio volumio[1293]: info: CoreCommandRouter::volumioGetState Feb 27 00:16:06 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:06 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - pause Feb 27 00:16:07 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:11 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:12 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:15 volumio volumio[1293]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpType [object Object] Feb 27 00:16:15 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpType Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] updateAmpType: Saving Amplifier Settings:{"amp_type":{"value":5,"label":"Rotel - RC-1570"}} Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closing RS232 Feb 27 00:16:15 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards "5" Feb 27 00:16:15 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"2","alsacard":"vc4hdmi0","name":"HDMI 0 Out"},{"id":"3","alsacard":"vc4hdmi1","name":"HDMI 1 Out"}] Feb 27 00:16:15 volumio volumio[1293]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 27 00:16:15 volumio volumio[1293]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 27 00:16:15 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 27 00:16:15 volumio volumio[1293]: info: Disabling external Volume Control Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: {"vendor":"Rotel","model":"RC-1570","baudRate":115200,"parity":"none","dataBits":8,"stopBits":1,"rtscts":false,"xon":false,"xoff":false,"xany":false,"sources":["CD","Coax1","Coax2","Opt1","Opt2","Aux1","Aux2","Tuner","Phono","USB","PC-USB","XLR"],"sourceCmd":["cd!","coax1!","coax2!","opt1!","opt2!","aux1!","aux2!","tuner!","phono!","usb!","pc_usb!","bal_xlr!"],"sourceRespPostfix":["cd","coax1","coax2","opt1","opt2","aux1","aux2","tuner","phono","usb","pc_usb","bal_xlr"],"delimiter":"!","commands":{"powerOn":"power_on!","powerToggle":"power_toggle!","volUp":"volume_up!","volDown":"volume_down!","volValue":"volume_#!","mute":"mute!","muteOn":"mute_on!","muteOff":"mute_off!"},"responses":[{"rx":"power=on","cmd":["respPowerOn"]},{"rx":"power=standby","cmd":["respPowerOff"]},{"rx":"volume=([0-9]{1,2})","cmd":["respVolume"]},{"rx":"mute=on","cmd":["respMuteOn"]},{"rx":"mute=off","cmd":["respMuteOff"]},{"rx":"source=([a-z_12]*)","cmd":["respSource"]}],"statusRequests":{"reqPower":"get_current_power!","reqSource":"get_current_source!","reqVolume":"get_volume!","reqMute":"get_mute_status!","reqModel":""}} Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: can send these responses: respPowerOn,respPowerOff,respVolume,respMuteOn,respMuteOff,respSource Feb 27 00:16:15 volumio volumio[1293]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 00:16:15 volumio volumio[1293]: info: CoreStateMachine::pushState Feb 27 00:16:15 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:15 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: {"device":"5","mixer":"","devicename":"","mixertype":"None","maxvolume":100,"volumecurve":"logarithmic","volumesteps":1,"currentmute":true,"name":""} undefined Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closed serial port Feb 27 00:16:15 volumio volumio[1293]: 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,"constructed":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":0,"_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":false,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"constructed":true,"prefinished":false,"errorEmitted":false,"emitClose":true,"autoDestroy":true,"errored":null,"closed":false,"closeEmitted":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":115200,"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":34},"lock":false,"baudRate":115200,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false,"path":"/dev/ttyUSB0"}} Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: RS232; amps: ["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: Rotel - RC-1570 Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedInterfaceExists: usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}]?: true Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedAmpSupportsInterface: RS232 in [] Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: starting Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: check for usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: connect to [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] configured with: {"autoOpen":false,"lock":false,"endOnClose":true,"baudRate":115200,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false} at /dev/ttyUSB0 Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Now trying to open port Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_TYPE_SAVE"):Amplifier Type Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] attachParser: Port is now open. Connecting Parser with delimiter: ! Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getAmpStatus: sending status requests to Amp Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Connection established. Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_10! Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqPower": get_current_power! Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqVolume": get_volume! Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqMute": get_mute_status! Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqSource": get_current_source! Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_10! Feb 27 00:16:15 volumio volumio[1293]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 27 00:16:15 volumio volumio[1293]: info: CoreCommandRouter::volumioGetState Feb 27 00:16:15 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:15 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - pause Feb 27 00:16:16 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:17 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:21 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:22 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:26 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:27 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:29 volumio volumio[1293]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpType [object Object] Feb 27 00:16:29 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpType Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] updateAmpType: Saving Amplifier Settings:{"amp_type":{"value":8,"label":"Rotel - RA-1592 SW >=V1.52"}} Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closing RS232 Feb 27 00:16:29 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards "5" Feb 27 00:16:29 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"2","alsacard":"vc4hdmi0","name":"HDMI 0 Out"},{"id":"3","alsacard":"vc4hdmi1","name":"HDMI 1 Out"}] Feb 27 00:16:29 volumio volumio[1293]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 27 00:16:29 volumio volumio[1293]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 27 00:16:29 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 27 00:16:29 volumio volumio[1293]: info: Disabling external Volume Control Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: {"vendor":"Rotel","model":"RA-1592 SW >=V1.52","interfaces":["RS232","TCP/IP"],"tcpport":9590,"baudRate":115200,"parity":"none","dataBits":8,"stopBits":1,"rtscts":false,"xon":false,"xoff":false,"xany":false,"sources":["CD","Coax1","Coax2","Coax3","Opt1","Opt2","Opt3","Aux","Tuner","Phono","USB","Bluetooth","Bal XLR","PC-USB"],"sourceCmd":["cd!","coax1!","coax2!","coax3!","opt1!","opt2!","opt3!","aux!","tuner!","phono!","usb!","bluetooth!","bal_xlr!","pcusb!"],"sourceRespPostfix":["cd","coax1","coax2","coax3","opt1","opt2","opt3","aux","tuner","phono","usb","bluetooth","bal_xlr","pc_usb"],"delimiter":"$","commands":{"powerOn":"power_on!","powerToggle":"power_toggle!","volUp":"vol_up!","volDown":"vol_dwn!","volValue":"vol_#!","mute":"mute!","muteOn":"mute_on!","muteOff":"mute_off!"},"responses":[{"rx":"power=on","cmd":["respPowerOn"]},{"rx":"power=standby","cmd":["respPowerOff"]},{"rx":"volume=([0-9]{1,2})","cmd":["respVolume"]},{"rx":"mute=on","cmd":["respMuteOn"]},{"rx":"mute=off","cmd":["respMuteOff"]},{"rx":"source=([a-z_12]*)","cmd":["respSource"]}],"statusRequests":{"reqPower":"power?","reqSource":"source?","reqVolume":"volume?","reqMute":"mute?","reqModel":"model?"}} Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: can send these responses: respPowerOn,respPowerOff,respVolume,respMuteOn,respMuteOff,respSource Feb 27 00:16:29 volumio volumio[1293]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 00:16:29 volumio volumio[1293]: info: CoreStateMachine::pushState Feb 27 00:16:29 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:29 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: {"device":"5","mixer":"","devicename":"","mixertype":"None","maxvolume":100,"volumecurve":"logarithmic","volumesteps":1,"currentmute":true,"name":""} undefined Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closed serial port Feb 27 00:16:29 volumio volumio[1293]: 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,"constructed":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":0,"_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":false,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"constructed":true,"prefinished":false,"errorEmitted":false,"emitClose":true,"autoDestroy":true,"errored":null,"closed":false,"closeEmitted":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":115200,"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":34},"lock":false,"baudRate":115200,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false,"path":"/dev/ttyUSB0"}} Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: RS232; amps: ["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: Rotel - RA-1592 SW >=V1.52 Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedInterfaceExists: usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}]?: true Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedAmpSupportsInterface: RS232 in ["RS232","TCP/IP"] Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: starting Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: check for usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: connect to [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] configured with: {"autoOpen":false,"lock":false,"endOnClose":true,"baudRate":115200,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false} at /dev/ttyUSB0 Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Now trying to open port Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_TYPE_SAVE"):Amplifier Type Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] attachParser: Port is now open. Connecting Parser with delimiter: $ Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getAmpStatus: sending status requests to Amp Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Connection established. Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_10! Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqModel": model? Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqPower": power? Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqVolume": volume? Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqMute": mute? Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqSource": source? Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_10! Feb 27 00:16:29 volumio volumio[1293]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 27 00:16:29 volumio volumio[1293]: info: CoreCommandRouter::volumioGetState Feb 27 00:16:29 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:29 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - pause Feb 27 00:16:31 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:32 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:36 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:37 volumio volumio[1293]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpType [object Object] Feb 27 00:16:37 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpType Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] updateAmpType: Saving Amplifier Settings:{"amp_type":{"value":7,"label":"Rotel - RSP-1582 SW V5.xx"}} Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closing RS232 Feb 27 00:16:37 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards "5" Feb 27 00:16:37 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"2","alsacard":"vc4hdmi0","name":"HDMI 0 Out"},{"id":"3","alsacard":"vc4hdmi1","name":"HDMI 1 Out"}] Feb 27 00:16:37 volumio volumio[1293]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 27 00:16:37 volumio volumio[1293]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 27 00:16:37 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 27 00:16:37 volumio volumio[1293]: info: Disabling external Volume Control Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: {"vendor":"Rotel","model":"RSP-1582 SW V5.xx","interfaces":["RS232","TCP/IP"],"tcpport":9596,"baudRate":115200,"parity":"none","dataBits":8,"stopBits":1,"rtscts":false,"xon":false,"xoff":false,"xany":false,"sources":["CD","Video 1","Video 2","Video 3","Video 4","Video 5","Video 6","Video 7","Video 8","Tuner","Phono","USB","PC-USB","XLR"],"sourceCmd":["cd!","video1!","video2!","video3!","video4!","video5!","video6!","video7!","video8!","tuner!","phono!","usb!","pc_usb!","bal_xlr!"],"sourceRespPostfix":["cd","video1","video2","video3","video4","video5","video6","video7","video8","tuner","phono","usb","pc_usb","bal_xlr"],"delimiter":"!","commands":{"powerOn":"power_on!","powerToggle":"power_toggle!","volUp":"volume_up!","volDown":"volume_down!","volValue":"volume_#!","mute":"mute!","muteOn":"mute_on!","muteOff":"mute_off!"},"responses":[{"rx":"power=on","cmd":["respPowerOn"]},{"rx":"power=standby","cmd":["respPowerOff"]},{"rx":"volume=([0-9]{1,2})","cmd":["respVolume"]},{"rx":"mute=on","cmd":["respMuteOn"]},{"rx":"mute=off","cmd":["respMuteOff"]},{"rx":"source=([a-z_12]*)","cmd":["respSource"]}],"statusRequests":{"reqPower":"get_current_power!","reqSource":"get_current_source!","reqVolume":"get_volume!","reqMute":"get_mute_status!","reqModel":""}} Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: can send these responses: respPowerOn,respPowerOff,respVolume,respMuteOn,respMuteOff,respSource Feb 27 00:16:37 volumio volumio[1293]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 00:16:37 volumio volumio[1293]: info: CoreStateMachine::pushState Feb 27 00:16:37 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:37 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: {"device":"5","mixer":"","devicename":"","mixertype":"None","maxvolume":100,"volumecurve":"logarithmic","volumesteps":1,"currentmute":true,"name":""} undefined Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closed serial port Feb 27 00:16:37 volumio volumio[1293]: 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,"constructed":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":0,"_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":false,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"constructed":true,"prefinished":false,"errorEmitted":false,"emitClose":true,"autoDestroy":true,"errored":null,"closed":false,"closeEmitted":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":115200,"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":34},"lock":false,"baudRate":115200,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false,"path":"/dev/ttyUSB0"}} Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: RS232; amps: ["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: Rotel - RSP-1582 SW V5.xx Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedInterfaceExists: usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}]?: true Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedAmpSupportsInterface: RS232 in ["RS232","TCP/IP"] Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: starting Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: check for usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: connect to [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] configured with: {"autoOpen":false,"lock":false,"endOnClose":true,"baudRate":115200,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false} at /dev/ttyUSB0 Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Now trying to open port Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_TYPE_SAVE"):Amplifier Type Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] attachParser: Port is now open. Connecting Parser with delimiter: ! Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getAmpStatus: sending status requests to Amp Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Connection established. Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_10! Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqPower": get_current_power! Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqVolume": get_volume! Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqMute": get_mute_status! Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqSource": get_current_source! Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_10! Feb 27 00:16:37 volumio volumio[1293]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 27 00:16:37 volumio volumio[1293]: info: CoreCommandRouter::volumioGetState Feb 27 00:16:37 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:37 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - pause Feb 27 00:16:37 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:41 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:43 volumio volumio[1293]: error: [MQTT] MQTT connection error: Error: connect ECONNREFUSED 127.0.0.1:1883 Feb 27 00:16:45 volumio volumio[1293]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpType [object Object] Feb 27 00:16:45 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpType Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] updateAmpType: Saving Amplifier Settings:{"amp_type":{"value":9,"label":"Meridian - DSP420"}} Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closing RS232 Feb 27 00:16:45 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards "5" Feb 27 00:16:45 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"2","alsacard":"vc4hdmi0","name":"HDMI 0 Out"},{"id":"3","alsacard":"vc4hdmi1","name":"HDMI 1 Out"}] Feb 27 00:16:45 volumio volumio[1293]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 27 00:16:45 volumio volumio[1293]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 27 00:16:45 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 27 00:16:45 volumio volumio[1293]: info: Disabling external Volume Control Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: {"vendor":"Meridian","model":"DSP420","baudRate":9600,"parity":"none","dataBits":8,"stopBits":1,"rtscts":false,"xon":false,"xoff":false,"xany":false,"sources":["CD","Radio","LP","TV","Tape 1","Tape 2","CDR","Cable","DVD","VCR 1","VCR 2","Laser Disc"],"sourceCmd":["CD","RD","LP","TV","T1","T2","CR","CB","DV","V1","V2","LD"],"sourceRespPostfix":["CD","Radio","LP","TV","Tape1","Tape2","CDR","Cable","DVD","VCR1","VCR2","LDisc"],"delimiter":"\r\n","commands":{"powerToggle":"SB","volUp":"VP","volDown":"VM","volValue":"VN##!","mute":"MU"},"responses":[{"rx":"([A-Za-z0-9]{2,5}) *([0-9]{1,2})","cmd":["respSource","respVolume","respMuteOff"]},{"rx":"Mute","cmd":["respMuteOn"]},{"rx":"Standby","cmd":["respPowerOff"]}],"statusRequests":{}} Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] setActiveAmp: can send these responses: respSource,respVolume,respMuteOff,respMuteOn,respPowerOff Feb 27 00:16:45 volumio volumio[1293]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 27 00:16:45 volumio volumio[1293]: info: CoreStateMachine::pushState Feb 27 00:16:45 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Feb 27 00:16:45 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: {"device":"5","mixer":"","devicename":"","mixertype":"None","maxvolume":100,"volumecurve":"logarithmic","volumesteps":1,"currentmute":true,"name":""} undefined Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] closePorts: closed serial port Feb 27 00:16:45 volumio volumio[1293]: 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,"constructed":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":0,"_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":false,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"constructed":true,"prefinished":false,"errorEmitted":false,"emitClose":true,"autoDestroy":true,"errored":null,"closed":false,"closeEmitted":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":115200,"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":34},"lock":false,"baudRate":115200,"dataBits":8,"stopBits":1,"parity":"none","rtscts":false,"xon":false,"xoff":false,"xany":false,"path":"/dev/ttyUSB0"}} Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: RS232; amps: ["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: Meridian - DSP420 Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedInterfaceExists: usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}]?: true Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] selectedAmpSupportsInterface: RS232 in [] Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: starting Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: check for usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0 in [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: connect to [{"path":"/dev/ttyUSB0","manufacturer":"FTDI","serialNumber":"FTB6SPL3","pnpId":"usb-FTDI_USB_Serial_Converter_FTB6SPL3-if00-port0","vendorId":"0403","productId":"6001"}] 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 Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] openSerialPort: Now trying to open port Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_TYPE_SAVE"):Amplifier Type Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] attachParser: Port is now open. Connecting Parser with delimiter: Feb 27 00:16:45 volumio volumio[1293]: info: [SERIALAMPCONTROLLER] getAmpStatus: sending status requests to Amp Feb 27 00:16:45 volumio volumio[1293]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 27 00:16:45 volumio volumio[1293]: TypeError [ERR_INVALID_ARG_TYPE]: The "chunk" argument must be of type string or an instance of Buffer or Uint8Array. Received undefined Feb 27 00:16:45 volumio volumio[1293]: at new NodeError (node:internal/errors:405:5) Feb 27 00:16:45 volumio volumio[1293]: at _write (node:internal/streams/writable:322:13) Feb 27 00:16:45 volumio volumio[1293]: at Writable.write (node:internal/streams/writable:344:10) Feb 27 00:16:45 volumio volumio[1293]: at SerialPort.write (/data/plugins/system_hardware/serialampcontroller/node_modules/@serialport/stream/dist/index.js:152:22) Feb 27 00:16:45 volumio volumio[1293]: at serialampcontroller.sendStatusRequest (/data/plugins/system_hardware/serialampcontroller/index.js:1067:19) Feb 27 00:16:45 volumio volumio[1293]: at serialampcontroller.getAmpStatus (/data/plugins/system_hardware/serialampcontroller/index.js:299:14) Feb 27 00:16:45 volumio volumio[1293]: at SerialPort. (/data/plugins/system_hardware/serialampcontroller/index.js:621:26) Feb 27 00:16:45 volumio volumio[1293]: at SerialPort.emit (node:events:514:28) Feb 27 00:16:45 volumio volumio[1293]: at settings.binding.open.then.opening (/data/plugins/system_hardware/serialampcontroller/node_modules/@serialport/stream/dist/index.js:111:18) { Feb 27 00:16:45 volumio volumio[1293]: code: 'ERR_INVALID_ARG_TYPE' Feb 27 00:16:45 volumio volumio[1293]: } Feb 27 00:16:45 volumio volumio[1293]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 27 00:16:45 volumio sudo[30397]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-27 00:15' Feb 27 00:16:45 volumio sudo[30397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"