Still no luck. I push/hold the PLM reset and it blinks. I push/hold the light switch and it beeps once and begins to blink. The PLM and light switch continue blinking for about 4 minutes. Does this mean the link is not established? I tried reversing the order and doing the light switch, then the PLM but the result was the same. The Insteon components did not come with detailed instructions, and I could not find anything on the website. I am completely mystified how anyone can get Insteon working with LinuxMCE. Here is the log.
2603:(***):MY DEVICE:38
(***):SndIns:Queue:1
(***):out:02 6B 40 Length:3
(***):X-----------SndIns: Waiting for response to:SetCfg
(***):X-----------SndIns: Current Queue Length:2
(***):Finding Children..
(***):reading stored Child configuration:
(***):********************************************************
(***):X-----------SndIns: Waiting for response to:SetCfg
(***):X-----------SndIns: Current Queue Length:2
(***):IN:02 6B 40 06 Length:4
(***):SetCfg Completed
(***):Command Completed.
(***):SndIns:Queue:1
(***):out:02 69 Length:2
(***):IN:02 69 06 02 57 E2 01 0A 97 0B 01 01 FF Length:13
(***):GetLnk ACKED
(***):LnkData Message Received
(***):{"Parameter2"=>"57", "Parameter3"=>"E2", "Parameter4"=>"01", "Parameter5"=>"0A", "Parameter6"=>"97", "Parameter7"=>"0B", "Response"=>"LnkData", "Parameter8"=>"01", "Parameter9"=>"01", "Parameter10"=>"FF", "Parameter1"=>"02"}
(***):record Flags:E2
(***):Controller
(***):Insteon ID:0A.97.0B, Group:01
(***):Command Completed.
(***):SndIns:Queue:1
(***):out:02 6A Length:2
(***):IN:02 6A 15 Length:3
(***):sendGetNext NACKED
(***):Command Completed.
(***):Entered CheckChildRecordsinPLM
(***):Record: = 0A.97.0B Group:01
(***):checking to see if it needs to be added as a child...
(***):ExistsinChild:InsteonID:0A.97.0B
(***):ExistsinChild result:FALSE
(***):0A.97.0B needs to be added to the child database
(***):addtochild Routne called
(***):Adding 0A.97.0B to the child database...
(***):Child is Insteon
(***):PING Sent!
(***):0A.97.0B exists in PLM
(***):SndIns:Queue:1
(***):out:02 62 0A 97 0B 0F 10 00 Length:8
(***):IN:02 62 0A 97 0B 0F 10 00 06 Length:9
(***):Got PING ACK
(***):receive timeout=1
(***):receive timeout=2
(***):receive timeout=3
(***):Command Stalled! resetting and retrying
(***):Current Command:1
(***):SndIns:Queue:1
(***):out:02 62 0A 97 0B 0F 10 00 Length:8
(***):IN:02 62 0A 97 0B 0F 10 00 06 Length:9
(***):Got PING ACK
(***):receive timeout=1
(***):receive timeout=2
(***):receive timeout=3
(***):Command Stalled! resetting and retrying
(***):Current Command:1
(***):SndIns:Queue:1
(***):out:02 62 0A 97 0B 0F 10 00 Length:8
(***):IN:02 62 0A 97 0B 0F 10 00 06 Length:9
(***):Got PING ACK
(***):receive timeout=1
(***):receive timeout=2
(***):receive timeout=3
(***):Third attempt, Failing Command!
(***):Command Completed.
(***):Queue Empty.
(***):RERUN=TRUE, RESTARTING
(***):SndIns:Queue:1
(***):out:02 62 0A 97 0B 0F 19 00 Length:8
(***):X-----------SndIns: Waiting for response to:SndIns
(***):X-----------SndIns: Current Queue Length:1
(***):IN:02 62 0A 97 0B 0F 19 00 06 Length:9
(***):receive timeout=1
(***):receive timeout=2
(***):receive timeout=3
(***):Command Stalled! resetting and retrying
(***):Current Command:25
(***):SndIns:Queue:1
(***):out:02 62 0A 97 0B 0F 19 00 Length:8
(***):IN:02 62 0A 97 0B 0F 19 00 06 Length:9
(***):receive timeout=1
(***):receive timeout=2
(***):receive timeout=3
(***):Command Stalled! resetting and retrying
(***):Current Command:25
(***):SndIns:Queue:1
(***):out:02 62 0A 97 0B 0F 19 00 Length:8
(***):IN:02 62 0A 97 0B 0F 19 00 06 Length:9
(***):receive timeout=1
(***):receive timeout=2
(***):receive timeout=3
(***):Third attempt, Failing Command!
(***):Command Completed.
(***):Queue Empty.
(***):RERUN Not needed
(***):Reporting Child Devices
(***):Child:0A.97.0B
(***):Config:["****************"]
(***):0A.97.0B
05 04/09/11 8:26:09.986 Socket::ReceiveData 0x96665a8 failed, bytes left 0 start: 1890000 1: 0 1b: 0 2: 0 2b: 0 m_Socket: 8 Command_Impl1 Dev #38 <0xb57fbb90>
05 04/09/11 8:26:09.986 Socket::ReceiveString2 ReceiveData failed m_Socket: -1 Command_Impl1 Dev #38 <0xb57fbb90>
01 04/09/11 8:26:09.986 Receive string failed in HandleRequestSocket 18:ReceiveData failed Command_Impl1 Dev #38 <0xb57fbb90>
05 04/09/11 8:26:09.986 Dumping 1 locks <0xb57fbb90>
05 04/09/11 8:26:09.986 finished check for exceptions <0xb57fbb90>
05 04/09/11 8:26:09.986 OL: (0x96666f4) (>75) MessageQueue Command_Impl.cpp l:822 time: 5:00:00p (1302359169 s) thread: 3053439888 Rel: Y Got: Y <0xb57fbb90>
== ATTEMPT FRESH START ==
1 04/09/11 08:28:47 /usr/pluto/bin/Spawn_Device.sh 38 (spawning-device) 15098 Dev: 38; Already Running list: 15,16,18,19,29,30,
== FRESH START ==
1 04/09/11 08:28:47 /usr/pluto/bin/Spawn_Device.sh 38 (spawning-device) device: 38 ip: localhost cmd_line: Generic_Serial_Device
0 04/09/11 08:28:48 38 (spawning-device) Entering 38
========== NEW LOG SECTION ==========
1 04/09/11 08:28:48 38 (spawning-device) Starting... 1
1 04/09/11 08:28:48 38 (spawning-device) Found /usr/pluto/bin/Generic_Serial_Device
RCODE:
0:require 'Ruby_Generic_Serial_Device'