Caddx NX-8E Help Please

Plugins & Plugin Development Unmaintained
1

Hello,

I have a GE/Caddx Nx-8E panel that I am trying to integrate into my Vera 3. I have connected the two with a P-0003 cable connected to the NX-8E board, The P-0003 cable is connected to a DB9 RS232 Null Modem Cable. The RS232 cable is connected to USB to serial adapter which is plugged into the Vera 3.

I have programmed the NX-8E following http://forum.micasaverde.com/index.php/topic,14295.0.html

After the physical setup, I have followed the instructions at UI5 – GE Caddx Networx NX-584 NX-8E Alarm Plugin and the Caddx Device is created in the Vera. I installed the GE Caddx NetworX Alarm Panels Plugin Version 81.0.

However, I cannot scan any of the zones and the Vera Advanced UI continually displays the following message:
Caddx NX584 Security System[20]: Running Lua Startup.

I have rebooted the Vera multiple times and always end up in the same place. I have tried multiple baud rate settings making sure to keep the NX-8E and Vera Serial Port configuration in synch (presently at 9600).

What am I missing and how can I resolve this? Much appreciation for your help!

Also, I looked at the luup log via /cgi-bin/cmh/log.sh?Device=LuaUPnP and keep seeing the following repeat over an over periodically:

02 04/25/15 19:56:36.882 IOPort::Run RecvFailed 0 close 12 <0x2cc81680>
02 04/25/15 19:56:41.911 IOPort::Run RecvFailed 0 close 12 <0x2cc81680>
06 04/25/15 19:56:42.406 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:TemperatureSensor1 variable: CurrentTemperature was: 65 now: 65 #hooks: 0 upnp: 0 v:0x95b8b0/NONE duplicate:1 <0x2b481680>
02 04/25/15 19:56:46.100 LOG_CHECK_MEMORY_LEAK pMem start 0xcd8000 now 0xce9000 last 0xcd8000 leaked 69632 <0x2b481680>
06 04/25/15 19:56:49.055 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:HVAC_FanOperatingMode1 variable: Mode was: Auto now: Auto #hooks: 0 upnp: 0 v:0x8e2980/NONE duplicate:1 <0x2b481680>
06 04/25/15 19:56:49.165 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:HVAC_FanOperatingMode1 variable: Mode was: Auto now: Auto #hooks: 0 upnp: 0 v:0x8e2980/NONE duplicate:1 <0x2b481680>
50 04/25/15 19:56:49.605 luup_log:20: Received inconvenient message 0x0a <0x2b281680>
50 04/25/15 19:56:49.606 luup_log:20: Message: Unsolicited message body: 0x59 0xb9 0xa9 0x61 0x00 0x04 0x0f 0x15 0x1d 0x03 0x04 0x0a 0x01 0x43 0x4c 0x41 <0x2b281680>
50 04/25/15 19:56:49.606 luup_log:20: Sending message: 0x1D Positive Acknowledge <0x2b281680>
50 04/25/15 19:56:49.607 luup_log:20: Message: Outgoing: 0x7e 0x01 0x1d 0x1e 0x1f <0x2b281680>
50 04/25/15 19:56:49.608 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2b281680>
02 04/25/15 19:56:49.614 IOPort::Run RecvFailed 0 close 12 <0x2cc81680>
06 04/25/15 19:56:51.295 Device_Variable::m_szValue_set device: 7 service: urn:micasaverde-com:serviceId:ZWaveDevice1 variable: TemperatureScale was: 0,1,1 now: 0,1,1 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2b481680>
06 04/25/15 19:56:51.296 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: AllSetpoints was: 65,73,0 now: 65,73,0 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2b481680>
06 04/25/15 19:56:53.455 Device_Variable::m_szValue_set device: 7 service: urn:micasaverde-com:serviceId:ZWaveDevice1 variable: TemperatureScale was: 0,1,1 now: 0,1,1 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2b481680>
06 04/25/15 19:56:53.456 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: AllSetpoints was: 65,73,0 now: 65,73,0 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2b481680>
04 04/25/15 19:56:53.457 <0x2b481680>
02 04/25/15 19:56:54.632 IOPort::Run RecvFailed 0 close 12 <0x2cc81680>
50 04/25/15 19:56:59.652 luup_log:20: Ignoring byte 45 <0x2b281680>
50 04/25/15 19:56:59.664 luup_log:20: Ignoring byte 8a <0x2b281680>
50 04/25/15 19:56:59.673 luup_log:20: Ignoring byte 5a <0x2b281680>
50 04/25/15 19:56:59.683 luup_log:20: Ignoring byte b9 <0x2b281680>
50 04/25/15 19:56:59.694 luup_log:20: Ignoring byte 82 <0x2b281680>
50 04/25/15 19:56:59.704 luup_log:20: Ignoring byte 06 <0x2b281680>
50 04/25/15 19:56:59.714 luup_log:20: Ignoring byte 00 <0x2b281680>
50 04/25/15 19:56:59.735 luup_log:20: Ignoring byte 04 <0x2b281680>
50 04/25/15 19:56:59.746 luup_log:20: Ignoring byte 0f <0x2b281680>
50 04/25/15 19:56:59.756 luup_log:20: Ignoring byte 15 <0x2b281680>
50 04/25/15 19:56:59.766 luup_log:20: Ignoring byte 1d <0x2b281680>
50 04/25/15 19:56:59.777 luup_log:20: Ignoring byte 01 <0x2b281680>
50 04/25/15 19:56:59.788 luup_log:20: Ignoring byte 05 <0x2b281680>
50 04/25/15 19:56:59.798 luup_log:20: Ignoring byte 07 <0x2b281680>
50 04/25/15 19:56:59.815 luup_log:20: Ignoring byte 0a <0x2b281680>
50 04/25/15 19:56:59.825 luup_log:20: Ignoring byte 42 <0x2b281680>
50 04/25/15 19:56:59.836 luup_log:20: Ignoring byte 42 <0x2b281680>
50 04/25/15 19:56:59.846 luup_log:20: Ignoring byte 42 <0x2b281680>
50 04/25/15 19:56:59.856 luup_log:20: Ignoring byte 5b <0x2b281680>
50 04/25/15 19:56:59.872 luup_log:20: Ignoring byte c6 <0x2b281680>
50 04/25/15 19:57:02.350 luup_log:20: Received inconvenient message 0x0a <0x2b281680>
50 04/25/15 19:57:02.351 luup_log:20: Message: Unsolicited message body: 0x5a 0xb9 0x82 0x06 0x00 0x04 0x0f 0x15 0x1d 0x01 0x05 0x07 0x0a 0x42 0x42 0x42 <0x2b281680>
50 04/25/15 19:57:02.351 luup_log:20: Sending message: 0x1D Positive Acknowledge <0x2b281680>
50 04/25/15 19:57:02.352 luup_log:20: Message: Outgoing: 0x7e 0x01 0x1d 0x1e 0x1f <0x2b281680>
50 04/25/15 19:57:02.353 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2b281680>

Here is another startup log:

50 04/26/15 12:36:39.313 luup_log:20: Message: Outgoing: 0x7e 0x01 0x1d 0x1e 0x1f <0x2bc77680>
50 04/26/15 12:36:39.314 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2bc77680>
02 04/26/15 12:36:39.322 IOPort::Run RecvFailed 146 close 12 <0x2e691680>
06 04/26/15 12:36:40.399 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:TemperatureSensor1 variable: CurrentTemperature was: 65 now: 65 #hooks: 0 upnp: 0 v:0xa51920/NONE duplicate:1 <0x2be77680>
02 04/26/15 12:36:44.341 IOPort::Run RecvFailed 146 close 12 <0x2e691680>
06 04/26/15 12:36:46.798 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:HVAC_FanOperatingMode1 variable: Mode was: Auto now: Auto #hooks: 0 upnp: 0 v:0x9d89b8/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:36:48.928 Device_Variable::m_szValue_set device: 7 service: urn:micasaverde-com:serviceId:ZWaveDevice1 variable: TemperatureScale was: 0,1,1 now: 0,1,1 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:36:48.929 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: CurrentSetpoint was: 65 now: 65 #hooks: 0 upnp: 0 v:0xa55658/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:36:48.929 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:TemperatureSetpoint1_Heat variable: CurrentSetpoint was: 65 now: 65 #hooks: 0 upnp: 0 v:0xa593c0/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:36:48.930 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: AllSetpoints was: 65,73,0 now: 65,73,0 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:36:51.068 Device_Variable::m_szValue_set device: 7 service: urn:micasaverde-com:serviceId:ZWaveDevice1 variable: TemperatureScale was: 0,1,1 now: 0,1,1 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:36:51.069 Device_Variable::m_szValue_set device: 7 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: AllSetpoints was: 65,73,0 now: 65,73,0 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
04 04/26/15 12:36:51.070 <0x2be77680>
50 04/26/15 12:36:51.961 luup_log:20: Received inconvenient message 0x06 <0x2bc77680>
50 04/26/15 12:36:51.962 luup_log:20: Message: Unsolicited message body: 0x02 0x20 0x00 0x00 0x01 0x00 0x04 0x82 <0x2bc77680>
50 04/26/15 12:36:51.962 luup_log:20: Sending message: 0x1D Positive Acknowledge <0x2bc77680>
50 04/26/15 12:36:51.963 luup_log:20: Message: Outgoing: 0x7e 0x01 0x1d 0x1e 0x1f <0x2bc77680>
50 04/26/15 12:36:51.964 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2bc77680>
02 04/26/15 12:36:51.971 IOPort::Run RecvFailed 146 close 12 <0x2e691680>
02 04/26/15 12:36:56.991 IOPort::Run RecvFailed 146 close 12 <0x2e691680>
50 04/26/15 12:36:57.101 luup_log:3: Entered getErgyRegKey_ui5 <0x2c677680>
06 04/26/15 12:36:57.178 Device_Variable::m_szValue_set device: 3 service: urn:micasaverde-com:serviceId:EEM-Plugin1 variable: GotKey was: 0 now: 0 #hooks: 0 upnp: 0 v:0x9ecf28/NONE duplicate:1 <0x2c677680>
06 04/26/15 12:36:57.179 Device_Variable::m_szValue_set device: 3 service: urn:micasaverde-com:serviceId:EEM-Plugin1 variable: GatewayRegistered was: 0 now: 0 #hooks: 0 upnp: 0 v:0x9ed360/NONE duplicate:1 <0x2c677680>
06 04/26/15 12:36:57.180 Device_Variable::m_szValue_set device: 3 service: urn:micasaverde-com:serviceId:EEM-Plugin1 variable: DevicesRegistered was: 0 now: 0 #hooks: 0 upnp: 0 v:0x9ed340/NONE duplicate:1 <0x2c677680>
50 04/26/15 12:37:04.615 luup_log:20: Received inconvenient message 0x07 LEAK this:352256 start:499712 to 0xdd1000 <0x2bc77680>
50 04/26/15 12:37:04.616 luup_log:20: Message: Unsolicited message body: 0x03 0x02 0x02 0x02 0x02 0x02 0x02 0x02 <0x2bc77680>
50 04/26/15 12:37:04.616 luup_log:20: Sending message: 0x1D Positive Acknowledge <0x2bc77680>
50 04/26/15 12:37:04.616 luup_log:20: Message: Outgoing: 0x7e 0x01 0x1d 0x1e 0x1f <0x2bc77680>
50 04/26/15 12:37:04.618 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2bc77680>
02 04/26/15 12:37:04.625 IOPort::Run RecvFailed 146 close 12 <0x2e691680>
01 04/26/15 12:37:04.648 IOPort::Send failed: Socket operation on non-socket (wrote: -1) <0x2bc77680>
02 04/26/15 12:37:09.644 IOPort::Run RecvFailed 146 close 12 <0x2e691680>
06 04/26/15 12:37:10.309 Device_Variable::m_szValue_set device: 8 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: KWH was: 12.1010 now: 12.1010 #hooks: 0 upnp: 0 v:0xa61840/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:37:10.309 Device_Variable::m_szValue_set device: 8 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: KWHReading was: 1430072943 now: 1430073430 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:0 <0x2be77680>
06 04/26/15 12:37:12.469 Device_Variable::m_szValue_set device: 8 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: Watts was: 0 now: 0 #hooks: 0 upnp: 0 v:0xa611e8/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:37:12.469 Device_Variable::m_szValue_set device: 8 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: ActualUsage was: 1 now: 1 #hooks: 0 upnp: 0 v:0xa61e38/NONE duplicate:1 <0x2be77680>
04 04/26/15 12:37:12.470 <0x2be77680>
50 04/26/15 12:37:17.251 luup_log:20: Received inconvenient message 0x04 <0x2bc77680>
50 04/26/15 12:37:17.252 luup_log:20: Message: Unsolicited message body: 0x06 0x01 0x58 0x13 0xf0 0x00 0x02 <0x2bc77680>
50 04/26/15 12:37:17.252 luup_log:20: Sending message: 0x1D Positive Acknowledge <0x2bc77680>
50 04/26/15 12:37:17.253 luup_log:20: Message: Outgoing: 0x7e 0x01 0x1d 0x1e 0x1f <0x2bc77680>
50 04/26/15 12:37:17.254 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2bc77680>
02 04/26/15 12:37:17.261 IOPort::Run RecvFailed 146 close 13 <0x2e691680>
02 04/26/15 12:37:22.860 IOPort::Run RecvFailed 146 close 14 LEAK this:16384 start:516096 to 0xdd5000 <0x2e691680>
02 04/26/15 12:37:22.871 luvd_get_info mg conn can’t read /etc/cmh-ludl//toolbox.js or /etc/cmh-lu//toolbox.js from filename /toolbox.js pPtrFile (null) <0x2d477680>
02 04/26/15 12:37:25.046 LOG_CHECK_MEMORY_LEAK pMem start 0xd7b000 now 0xdd5000 last 0xd7b000 leaked 368640 <0x2be77680>
50 04/26/15 12:37:29.916 luup_log:20: Received inconvenient message 0x04 <0x2bc77680>
50 04/26/15 12:37:29.917 luup_log:20: Message: Unsolicited message body: 0x07 0x01 0x58 0x13 0xf0 0x00 0x02 <0x2bc77680>
50 04/26/15 12:37:29.917 luup_log:20: Sending message: 0x1D Positive Acknowledge <0x2bc77680>
50 04/26/15 12:37:29.918 luup_log:20: Message: Outgoing: 0x7e 0x01 0x1d 0x1e 0x1f <0x2bc77680>
50 04/26/15 12:37:29.919 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2bc77680>
02 04/26/15 12:37:29.926 IOPort::Run RecvFailed 146 close 14 <0x2e691680>
02 04/26/15 12:37:34.944 IOPort::Run RecvFailed 146 close 14 <0x2e691680>
06 04/26/15 12:37:40.440 Device_Variable::m_szValue_set device: 12 service: urn:upnp-org:serviceId:TemperatureSensor1 variable: CurrentTemperature was: 68 now: 68 #hooks: 0 upnp: 0 v:0xa51920/NONE duplicate:1 <0x2be77680>
50 04/26/15 12:37:42.572 luup_log:20: Received inconvenient message 0x05 <0x2bc77680>
50 04/26/15 12:37:42.572 luup_log:20: Message: Unsolicited message body: 0x00 0x80 0x00 0x00 0x00 0x00 0x00 0x00 0x00 <0x2bc77680>
50 04/26/15 12:37:42.573 luup_log:20: Sending message: 0x1D Positive Acknowledge <0x2bc77680>
50 04/26/15 12:37:42.573 luup_log:20: Message: Outgoing: 0x7e 0x01 0x1d 0x1e 0x1f <0x2bc77680>
50 04/26/15 12:37:42.574 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2bc77680>
02 04/26/15 12:37:42.582 IOPort::Run RecvFailed 146 close 14 <0x2e691680>
06 04/26/15 12:37:46.888 Device_Variable::m_szValue_set device: 12 service: urn:upnp-org:serviceId:HVAC_FanOperatingMode1 variable: Mode was: Auto now: Auto #hooks: 0 upnp: 0 v:0x9d89b8/NONE duplicate:1 <0x2be77680>
02 04/26/15 12:37:47.602 IOPort::Run RecvFailed 146 close 14 <0x2e691680>
06 04/26/15 12:37:49.018 Device_Variable::m_szValue_set device: 12 service: urn:micasaverde-com:serviceId:ZWaveDevice1 variable: TemperatureScale was: 0,1,1 now: 0,1,1 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:37:49.019 Device_Variable::m_szValue_set device: 12 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: CurrentSetpoint was: 65 now: 65 #hooks: 0 upnp: 0 v:0xa55658/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:37:49.019 Device_Variable::m_szValue_set device: 12 service: urn:upnp-org:serviceId:TemperatureSetpoint1_Heat variable: CurrentSetpoint was: 65 now: 65 #hooks: 0 upnp: 0 v:0xa593c0/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:37:49.020 Device_Variable::m_szValue_set device: 12 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: AllSetpoints was: 65,73,65 now: 65,73,65 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:37:51.148 Device_Variable::m_szValue_set device: 12 service: urn:micasaverde-com:serviceId:ZWaveDevice1 variable: TemperatureScale was: 0,1,1 now: 0,1,1 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:37:51.149 Device_Variable::m_szValue_set device: 12 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: AllSetpoints was: 65,73,65 now: 65,73,65 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
04 04/26/15 12:37:51.150 <0x2be77680>
06 04/26/15 12:37:52.749 Device_Variable::m_szValue_set device: 13 service: urn:upnp-org:serviceId:TemperatureSensor1 variable: CurrentTemperature was: 66 now: 67 #hooks: 0 upnp: 0 v:0xa51920/NONE duplicate:0 <0x2be77680>
50 04/26/15 12:38:02.575 luup_log:20: Input is nil <0x2bc77680>
50 04/26/15 12:38:02.575 luup_log:20: Timed out waiting for response, retrying <0x2bc77680>
50 04/26/15 12:38:02.576 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2bc77680>
02 04/26/15 12:38:02.580 IOPort::Run RecvFailed 146 close 14 <0x2e691680>
02 04/26/15 12:38:07.599 IOPort::Run RecvFailed 146 close 13 <0x2e691680>
06 04/26/15 12:38:10.369 Device_Variable::m_szValue_set device: 13 service: urn:upnp-org:serviceId:TemperatureSensor1 variable: CurrentTemperature was: 67 now: 67 #hooks: 0 upnp: 0 v:0xa51920/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:11.179 Device_Variable::m_szValue_set device: 8 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: KWH was: 12.1010 now: 12.1010 #hooks: 0 upnp: 0 v:0xa61840/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:11.179 Device_Variable::m_szValue_set device: 8 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: KWHReading was: 1430073430 now: 1430073491 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:0 <0x2be77680>
06 04/26/15 12:38:15.799 Device_Variable::m_szValue_set device: 14 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: KWH was: 142.3070 now: 142.3070 #hooks: 0 upnp: 0 v:0xa61840/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:15.799 Device_Variable::m_szValue_set device: 14 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: KWHReading was: 1430073033 now: 1430073495 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:0 <0x2be77680>
06 04/26/15 12:38:16.768 Device_Variable::m_szValue_set device: 13 service: urn:upnp-org:serviceId:HVAC_FanOperatingMode1 variable: Mode was: Auto now: Auto #hooks: 0 upnp: 0 v:0x9d89b8/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:18.898 Device_Variable::m_szValue_set device: 13 service: urn:micasaverde-com:serviceId:ZWaveDevice1 variable: TemperatureScale was: 0,1,1 now: 0,1,1 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:18.899 Device_Variable::m_szValue_set device: 13 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: CurrentSetpoint was: 68 now: 68 #hooks: 0 upnp: 0 v:0xa55658/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:18.899 Device_Variable::m_szValue_set device: 13 service: urn:upnp-org:serviceId:TemperatureSetpoint1_Heat variable: CurrentSetpoint was: 68 now: 68 #hooks: 0 upnp: 0 v:0xa593c0/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:18.900 Device_Variable::m_szValue_set device: 13 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: AllSetpoints was: 68,73,0 now: 68,73,0 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:21.039 Device_Variable::m_szValue_set device: 13 service: urn:micasaverde-com:serviceId:ZWaveDevice1 variable: TemperatureScale was: 0,1,1 now: 0,1,1 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:21.039 Device_Variable::m_szValue_set device: 13 service: urn:upnp-org:serviceId:TemperatureSetpoint1 variable: AllSetpoints was: 68,73,0 now: 68,73,0 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:1 <0x2be77680>
04 04/26/15 12:38:21.040 <0x2be77680>
50 04/26/15 12:38:22.577 luup_log:20: Input is nil <0x2bc77680>
50 04/26/15 12:38:22.577 luup_log:20: Timed out waiting for response, retrying <0x2bc77680>
50 04/26/15 12:38:22.578 luup_log:20: Message: Outgoing: 0x7e 0x01 0x21 0x22 0x23 <0x2bc77680>
02 04/26/15 12:38:22.582 IOPort::Run RecvFailed 146 close 13 <0x2e691680>
02 04/26/15 12:38:27.604 IOPort::Run RecvFailed 146 close 13 <0x2e691680>
06 04/26/15 12:38:40.509 Device_Variable::m_szValue_set device: 14 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: KWH was: 142.3070 now: 142.3070 #hooks: 0 upnp: 0 v:0xa61840/NONE duplicate:1 <0x2be77680>
06 04/26/15 12:38:40.509 Device_Variable::m_szValue_set device: 14 service: urn:micasaverde-com:serviceId:EnergyMetering1 variable: KWHReading was: 1430073495 now: 1430073520 #hooks: 0 upnp: 0 v:(nil)/NONE duplicate:0 <0x2be77680>
50 04/26/15 12:38:42.579 luup_log:20: Input is nil <0x2bc77680>
50 04/26/15 12:38:42.579 luup_log:20: Timed out waiting for response, retrying <0x2bc77680>
01 04/26/15 12:38:42.580 LuaInterface::CallFunction_Startup device 20 function caddxInitialize took 161 seconds <0x2bc77680>
01 04/26/15 12:38:42.580 LuaInterface::CallFunction_Startup-2 device 20 function caddxInitialize failed Caddx NX584 Security System[20] with return false <0x2bc77680>

2

Thanks for posting the logs. The symptoms in the logs are pretty clear: no message the Vera sends is reaching the NX-8E. However, messages from the NX-8E to Vera are arriving fine.

Since serial connections are full duplex, this can arise from a cable with a bad connection in either the TX or RX wire. The only surefire way to test this hypothesis is to swap out every part of the connection (P-0003 cable, USB-to-serial adapter) and retry. But read on for a more likely culprit.

USB-to-serial adapters need to step up the voltage from USB levels (5 V) to RS-232 levels (12 V). This requires a lot of current, often more than the Vera USB port can supply. A lot of the time this can be solved by adding an externally powered USB hub between the Vera and the USB-to-serial adapter. The extra power gives the USB-to-serial adapter the boost it needs to be able to send signals all the way to the NX-8E.

If you search for “USB hub” in this subforum you will see how often this crops up.

3

@futzle Thank you for you assistance!

Unfortunately, I am still stuck. I have added a powered USB hub to the mix as suggested. I actually tried 3 different ones to no avail. I then changed out both the serial cable and the serial to USB adapter replacing them with a new cable (although this one did not have null modem) - also to no avail. I Have not swapped out the P003 as it is expensive, takes a great deal of time to get here and is hard to find vendors for.

I have included latest logs below for your reference.

Is there a known trusted vendor for P003 cable?
Do I need a null modem in mix?
What baud rate should I try - I presently have both sides set to 9600 but have tried others to no avail.

Anything else I can do to troubleshoot that would be of value?

Thanks again for your help!

4

That’s good solid testing. You’ve definitely reduced the likelihood that there’s a problem with the Vera, the USB-to-serial adapter and the power level.

I don’t think that your baud rate is a problem. Or that you’ve got transmit/receive crossed wrongly. So any talk about null modem cables is probably not going to be productive.

Since you are still getting the same outcome (getting full messages from panel to Vera, but no messages from Vera to panel), it’s time to look at the parts you didn’t swap out. Sorry.

See if there are any status LEDs on the NX-8E board that can tell you if it is receiving packets over the serial interface. I have an NX-584 board, which does have these LEDs, but whether they are also on the NX-8E is unknown to me. You’d be looking for blinking in this LED when you reload LUUP on the Vera.

See if there is a good electrical connection in your P0003 cable. Both ends can have issues with not making a good connection. You can google which pins are the ones carrying the serial-to-panel signal. Inspect them. Inspect the header on the NX-8E board. Squeeze and jiggle stuff. This kind of messing about has been reported to fix the problem by one user a couple of years ago.

5

Unfortunately, I don’t have any means of testing the P0003 cable electrically. As the only part left to be changed out is the P0003 which was quite expensive, I’m wondering if alternatives may be acceptable. Could I trouble you to take a look at the following and tell me if either of these would be an acceptable replacement for the P0003 please?

6

I’ve got no way of knowing. You’d have to get a pinout diagram/table showing which DB9 pin connects to which pin in the 10-pin header, and compare with the same pinout for the P-0003. Just because the physical shape of the connector matches doesn’t mean the pinout is the same. Neither of those Amazon listings tells you the pinout. I don’t have a P-0003 cable and I’ve never seen one in real life. I’m only going by the descriptions that I’ve seen here in this forum.

Another thing you can and should try is to install the DL900 software on a PC and connect that to your alarm panel. This is the configuration software that installers use to avoid having to program it through the keypad. If there’s a physical fault in the P-00003 cable or the header on the NX-8E’s board, it won’t work either, but it’s good evidence that the problem is on the alarm panel end rather than the Vera end.

Because (I think) the problem is on the alarm panel end, you can also benefit from other automation forums. I did a bit of searching and found some discussions on the Homeseer forums, for instance. They might be instructive.

What bothers me is the messages in the Vera log “IOPort::Run RecvFailed 146 close 12”. These messages aren’t supposed to happen, and they are logged quickly after the corresponding message was sent so they’re not timeouts. They smell like flow control blockages, or a dropped DTR line, or something that is at the logic gate level rather than the physical connection level. I wasn’t aware of there being any way to control those from the NX-8E, either through jumpers on the panel or through programming the keypad. My model is not the NX-8E, which is not ever sold in my country, so again I’m only going by what I’ve read.

You did program the alarm panel to accept the necessary messages, right?

You’ve about exhausted my expertise. If I were in your shoes I’d try to get the DL900 software going, or MisterHouse or some other program that can talk the Caddx protocol, and try to get two-way communication going without the Vera. Failing that, bite the bullet and drop another $30 on a cable that is known to work. Or get a cheap multimeter and check the cable you’ve got.

7

Great advice Futzle!

I would highly recommend the next step in troubleshooting be downloading and installing the DL900 software. That will quickly be able to show the issue. I have had quite a few issues with connectivity between the Vera and NX8e panel that I have, but my DL900 software always confirms the physical side is good for me.