[mh] Insteon Stops Working

[Jim D. <ji...@du...>]

I'm using the insteon branch code.

After moving to the branch, about a half a dozen times, the insteon control
of lights stops working.  I have to reboot mh in order to restore functionality.
I have an example log extraction here.

I went to my basement, which has a motion sensor, and the lights
failed to turn on.  I went an turned on Insteon Debugging

03/05/11 01:13:15 PM Running: PLM messaging debug on

I then trigged the motion sensor again:
Warning: Dummy_Interface #1: trying to set_receive motion
Warning: Dummy_Interface #1: trying to set_receive motion
03/05/11 01:14:01 PM XG3GJ: basement_sensor_1 motion
03/05/11 01:14:01 PM W800: bad checksum (attempting to recover)
03/05/11 01:14:02 PM W800: failed to recover from bad checksums due to no data(count=1)
Warning: Dummy_Interface #1: trying to set_receive motion
Warning: Dummy_Interface #1: trying to set_receive motion
03/05/11 01:14:09 PM XG3GJ: basement_sensor_1 motion
Warning: Dummy_Interface #2: trying to set_receive motion
Warning: Dummy_Interface #2: trying to set_receive motion
03/05/11 01:14:11 PM XG5GJ: basement_sensor_2 motion
Warning: Dummy_Interface #4: trying to set_receive motion
Warning: Dummy_Interface #4: trying to set_receive motion
03/05/11 01:14:14 PM XG9GJ: basement_sensor_4 motion
Warning: Dummy_Interface #3: trying to set_receive motion
Warning: Dummy_Interface #3: trying to set_receive motion
03/05/11 01:14:15 PM XG7GJ: basement_sensor_3 motion
Warning: Dummy_Interface #3: trying to set_receive motion
Warning: Dummy_Interface #3: trying to set_receive motion
03/05/11 01:14:16 PM XG7GJ: basement_sensor_3 motion
Warning: Dummy_Interface #5: trying to set_receive motion
Warning: Dummy_Interface #5: trying to set_receive motion
03/05/11 01:14:16 PM XGBGJ: basement_laundry_sensor motion
Warning: Dummy_Interface #1: trying to set_receive motion
Warning: Dummy_Interface #1: trying to set_receive motion

I never see any insteon messages indicating its attempting to turn
on the basement lights.

Next, I attempt to control some lights using the web interface.
I can see the messages showing that the commands are run, but 
I don't see the messages which indicates that insteon is attempting
to control the lights.

03/05/11 01:16:26 PM W800: security: unmatched device 0x39 (state = Alert)
03/05/11 01:16:36 PM W800: security: unmatched device 0x39 (state = Normal)
03/05/11 01:16:44 PM Running: office lights off
03/05/11 01:16:48 PM Running: office lights off

Next, I reboot mh and run the same tests.

Motion in the basement ....

Warning: Dummy_Interface #0: trying to set_receive motion
Warning: Dummy_Interface #0: trying to set_receive motion
03/05/11 01:24:12 PM XG1GJ: basement_stair_sensor motion
03/05/11 01:24:12 PM [Insteon_PLM] DEBUG: Parsing serial data: 026210e3
03/05/11 01:24:12 PM [Insteon_PLM] DEBUG: Prepending prior data fragment: 026210e3
03/05/11 01:24:12 PM [Insteon_PLM] DEBUG: Parsing serial data: 026210e3180511ff06
03/05/11 01:24:12 PM [Insteon_PLM] DEBUG: received interface acknowledge: obj=$basement; command=on; extra=FF
03/05/11 01:24:12 PM [Insteon_PLM] DEBUG: Parsing serial data: 025010e3180dfd9e2111ff
03/05/11 01:24:14 PM [Insteon_PLM] DEBUG: Parsing serial data: 026210e3180511ff06
03/05/11 01:24:14 PM [Insteon_PLM] DEBUG: received interface acknowledge: obj=$basement; command=on; extra=FF
03/05/11 01:24:14 PM [Insteon_PLM] DEBUG: Parsing serial data: 025010e3180dfd9e2111ff


Web control of lights ....

03/05/11 01:23:29 PM Running: office lights off
03/05/11 01:23:29 PM [Insteon_PLM] DEBUG: Parsing serial data: 026211493905130006
03/05/11 01:23:29 PM [Insteon_PLM] DEBUG: received interface acknowledge: obj=$office_lights; command=off; extra=00
03/05/11 01:23:30 PM [Insteon_PLM] DEBUG: Parsing serial data: 02501149390dfd9e211300
03/05/11 01:23:31 PM Running: office lights on
03/05/11 01:23:31 PM [Insteon_PLM] DEBUG: Parsing serial data: 02621149390511ff06
03/05/11 01:23:31 PM [Insteon_PLM] DEBUG: received interface acknowledge: obj=$office_lights; command=on; extra=FF
03/05/11 01:23:31 PM [Insteon_PLM] DEBUG: Parsing serial data: 02501149390dfd9e2111ff

I'm somewhat concerned my problems are caused by the latest version of perl which comes with fedora 14.

Because I know that if this was happening to Gregg, it would have been fixed.

How can I help isolate and debug?  It's not very reproducible.

Thanks,

Jim