Author Topic: ZWave USB serial problem  (Read 2297 times)

Domodude

  • Guest
ZWave USB serial problem
« on: June 15, 2009, 10:38:09 pm »
Hmm, what is going on here?
I was trying to reset the dongle, and then have it download my new zwave configuration (perpared with Merten). Now I get this:

Code: [Select]
========== NEW LOG SECTION ==========
1       06/15/09 22:06:15       220 (spawning-device)   Starting... 50
1       06/15/09 22:06:15       220 (spawning-device)   Found /usr/pluto/bin/ZWave
10      06/15/09 22:06:15.112           Device: 220 starting.  Connecting to: localhost <0xb795d6c0>
10      06/15/09 22:06:15.114           Setting timeout for socket 4 to 20 <0xb795d6c0>
10      06/15/09 22:06:15.198           Socket::SendMessage type 5 id 37 from 220 to -1000 <0xb795d6c0>
10      06/15/09 22:06:15.237           TranslateSerialUSB  isn't serial usb <0xb795d6c0>
36      06/15/09 22:06:15.237           Initialization... <0xb795d6c0>
36      06/15/09 22:06:15.237           Open serial port  <0xb795d6c0>
Return code: 255
3       06/15/09 22:06:15       220 (spawning-device)   Device died... count=50/50 dev=220
Mon Jun 15 22:06:15 CEST 2009 died
3       06/15/09 22:06:25       220 (spawning-device)   Aborting restart of device 220...

I took out the tricklestar and put in the MCV: same result.

Hari, do you have any idea where this may come from?

hari

  • Administrator
  • LinuxMCE God
  • *****
  • Posts: 2421
    • View Profile
    • ago control
Re: ZWave USB serial problem
« Reply #1 on: June 16, 2009, 02:17:12 pm »
what did you select as com port on pc? can you make a screenshot of that field in the web admin and provide me with lspci/lsusb outputs? The translation code was not changed since 0710.

br, Hari
rock your home - http://www.agocontrol.com home automation

Domodude

  • Guest
Re: ZWave USB serial problem
« Reply #2 on: June 16, 2009, 11:04:10 pm »
what did you select as com port on pc? can you make a screenshot of that field in the web admin and provide me with lspci/lsusb outputs? The translation code was not changed since 0710.

The com port said "please select". So, nothing chosen.

This is lspci:
Code: [Select]
00:00.0 RAM memory: nVidia Corporation Unknown device 0754 (rev a2)
00:01.0 ISA bridge: nVidia Corporation Unknown device 075c (rev a2)
00:01.1 SMBus: nVidia Corporation Unknown device 0752 (rev a1)
00:01.2 RAM memory: nVidia Corporation Unknown device 0751 (rev a1)
00:01.3 Co-processor: nVidia Corporation Unknown device 0753 (rev a2)
00:01.4 RAM memory: nVidia Corporation Unknown device 0568 (rev a1)
00:02.0 USB Controller: nVidia Corporation Unknown device 077b (rev a1)
00:02.1 USB Controller: nVidia Corporation Unknown device 077c (rev a1)
00:04.0 USB Controller: nVidia Corporation Unknown device 077d (rev a1)
00:04.1 USB Controller: nVidia Corporation Unknown device 077e (rev a1)
00:06.0 IDE interface: nVidia Corporation Unknown device 0759 (rev a1)
00:07.0 Audio device: nVidia Corporation Unknown device 0774 (rev a1)
00:08.0 PCI bridge: nVidia Corporation Unknown device 075a (rev a1)
00:09.0 SATA controller: nVidia Corporation Unknown device 0ad4 (rev a2)
00:0a.0 Ethernet controller: nVidia Corporation Unknown device 0760 (rev a2)
00:0b.0 PCI bridge: nVidia Corporation Unknown device 0569 (rev a1)
00:10.0 PCI bridge: nVidia Corporation Unknown device 0778 (rev a1)
00:12.0 PCI bridge: nVidia Corporation Unknown device 075b (rev a1)
00:13.0 PCI bridge: nVidia Corporation Unknown device 077a (rev a1)
00:14.0 PCI bridge: nVidia Corporation Unknown device 077a (rev a1)
00:18.0 Host bridge: Advanced Micro Devices [AMD] K8 [Athlon64/Opteron] HyperTransport Technology Configuration
00:18.1 Host bridge: Advanced Micro Devices [AMD] K8 [Athlon64/Opteron] Address Map
00:18.2 Host bridge: Advanced Micro Devices [AMD] K8 [Athlon64/Opteron] DRAM Controller
00:18.3 Host bridge: Advanced Micro Devices [AMD] K8 [Athlon64/Opteron] Miscellaneous Control
01:09.0 Multimedia video controller: Internext Compression Inc iTVC16 (CX23416) MPEG-2 Encoder (rev 01)
01:0a.0 FireWire (IEEE 1394): Agere Systems FW323 (rev 70)
01:0b.0 Multimedia video controller: Internext Compression Inc iTVC15 MPEG-2 Encoder (rev 01)
02:00.0 VGA compatible controller: nVidia Corporation Unknown device 0848 (rev a2)
06:00.0 Ethernet controller: Intel Corporation 82572EI Gigabit Ethernet Controller (Copper) (rev 06)
/code]

and lsusb:
[code][Bus 004 Device 002: ID 0603:00f2 Novatek Microelectronics Corp.
Bus 004 Device 003: ID 15ca:00c3
Bus 004 Device 001: ID 0000:0000
Bus 003 Device 006: ID 067b:2303 Prolific Technology, Inc. PL2303 Serial Port
Bus 003 Device 002: ID 0403:f850 Future Technology Devices International, Ltd
Bus 003 Device 001: ID 0000:0000
Bus 002 Device 001: ID 0000:0000
Bus 001 Device 001: ID 0000:0000
/code]

I figured I might as well delete the device. So I did, but after that nothing showed up about a zwave controller. Unplugging/plugging the stick did not do it either.

Something very strange is going on: detection of the device is not working properly...  :o

Hmmmmm....
[/code]

hari

  • Administrator
  • LinuxMCE God
  • *****
  • Posts: 2421
    • View Profile
    • ago control
Re: ZWave USB serial problem
« Reply #3 on: June 16, 2009, 11:36:36 pm »
so how should the z-wave dce device shall open the proper /dev/ttyUSBx when you did not specify a serial port?

br, Hari
rock your home - http://www.agocontrol.com home automation

Domodude

  • Guest
Re: ZWave USB serial problem
« Reply #4 on: June 17, 2009, 09:08:29 am »
so how should the z-wave dce device shall open the proper /dev/ttyUSBx when you did not specify a serial port?

True, so I tried to pick one that was appropriate, but there was none! I figured I might as well delete the device, then re-install the stick. So I did, but after that nothing showed up about a zwave controller. Unplugging/plugging the stick did not do it either.

Something very strange is going on: detection of the device is not working properly...  :o
Maybe I broke something, but I have no idea at all how I did that...

Hmmmmm.

btw, lsusb gives me this:
Code: [Select]
Bus 004 Device 001: ID 0000:0000
Bus 003 Device 001: ID 0000:0000
Bus 002 Device 003: ID 15ca:00c3
Bus 002 Device 002: ID 0603:00f2 Novatek Microelectronics Corp.
Bus 002 Device 001: ID 0000:0000
Bus 001 Device 005: ID 067b:2303 Prolific Technology, Inc. PL2303 Serial Port
Bus 001 Device 003: ID 0403:f850 Future Technology Devices International, Ltd
Bus 001 Device 001: ID 0000:0000

hari

  • Administrator
  • LinuxMCE God
  • *****
  • Posts: 2421
    • View Profile
    • ago control
Re: ZWave USB serial problem
« Reply #5 on: June 17, 2009, 04:24:49 pm »
i would assume that launch manager does not run ListSerialPorts/UpdateAvailableSerialPorts properly.

But that will affect all ttyUSB devices and not only zwave...

br, Hari
rock your home - http://www.agocontrol.com home automation

totallymaxed

  • LinuxMCE God
  • ****
  • Posts: 4438
  • Smart Home Consulting
    • View Profile
    • Dianemo - at home with technology
Re: ZWave USB serial problem
« Reply #6 on: June 17, 2009, 04:53:28 pm »
so how should the z-wave dce device shall open the proper /dev/ttyUSBx when you did not specify a serial port?

True, so I tried to pick one that was appropriate, but there was none! I figured I might as well delete the device, then re-install the stick. So I did, but after that nothing showed up about a zwave controller. Unplugging/plugging the stick did not do it either.

Something very strange is going on: detection of the device is not working properly...  :o
Maybe I broke something, but I have no idea at all how I did that...

Hmmmmm.

btw, lsusb gives me this:
Code: [Select]
Bus 004 Device 001: ID 0000:0000
Bus 003 Device 001: ID 0000:0000
Bus 002 Device 003: ID 15ca:00c3
Bus 002 Device 002: ID 0603:00f2 Novatek Microelectronics Corp.
Bus 002 Device 001: ID 0000:0000
Bus 001 Device 005: ID 067b:2303 Prolific Technology, Inc. PL2303 Serial Port
Bus 001 Device 003: ID 0403:f850 Future Technology Devices International, Ltd
Bus 001 Device 001: ID 0000:0000

Bus ID 067b:2303 would almost certainly be a Tricklestar...unless you have a USB-serial adapter attached that uses a PL2303

Andrew
Andy Herron,
Convergent Home Technologies Ltd
United Kingdom

Read My Blog; http://ellipticalcurve.com

Contact me for Smart Home consulting advice here;
@herron on Twitter, totallymaxed+consulting@gmail.com via email or PM me here.

Get a Dianemo S License: http://forum.linuxmce.org/index.php?topic=8880.0
iOS Orbiter: http://wiki.linuxmce.org/index.php/Dianemo_iOS_Orbiter
Follow us on Facebook: https://www.facebook.com/pages/Dianemo-Home-Automation/226019387454465

Sales & Info:
http://www.dianemo.co.uk

Domodude

  • Guest
Re: ZWave USB serial problem
« Reply #7 on: June 17, 2009, 05:16:40 pm »
Code: [Select]
Bus 002 Device 002: ID 0603:00f2 Novatek Microelectronics Corp.
Bus ID 067b:2303 would almost certainly be a Tricklestar...unless you have a USB-serial adapter attached that uses a PL2303

It is, but the system does not seem to pick it up. Strange.

hari

  • Administrator
  • LinuxMCE God
  • *****
  • Posts: 2421
    • View Profile
    • ago control
Re: ZWave USB serial problem
« Reply #8 on: June 17, 2009, 06:33:07 pm »
domodude, try a reboot, it shall update the list of serialports properly.

br, Hari
rock your home - http://www.agocontrol.com home automation

Domodude

  • Guest
Re: ZWave USB serial problem
« Reply #9 on: June 17, 2009, 11:00:32 pm »
I took out the stick, and rebooted.

lsusb:
Code: [Select]
dcerouter_31363:/mnt/device/30# lsusb
Bus 003 Device 002: ID 0403:f850 Future Technology Devices International, Ltd
Bus 003 Device 001: ID 0000:0000
Bus 004 Device 002: ID 0603:00f2 Novatek Microelectronics Corp.
Bus 004 Device 003: ID 15ca:00c3
Bus 004 Device 001: ID 0000:0000
Bus 001 Device 001: ID 0000:0000
Bus 002 Device 001: ID 0000:0000
After I plug the stick back in:
Code: [Select]
dcerouter_31363:/mnt/device/30# lsusb
Bus 003 Device 003: ID 067b:2303 Prolific Technology, Inc. PL2303 Serial Port
Bus 003 Device 002: ID 0403:f850 Future Technology Devices International, Ltd
Bus 003 Device 001: ID 0000:0000
Bus 004 Device 002: ID 0603:00f2 Novatek Microelectronics Corp.
Bus 004 Device 003: ID 15ca:00c3
Bus 004 Device 001: ID 0000:0000
Bus 001 Device 001: ID 0000:0000
Bus 002 Device 001: ID 0000:0000
so it is actually the prolific that is the zwave stick. This still does not get recognized, by the way.
I picked the only reasonable serial interface that was left on the list, after setting up the device manually. That works, as far as sending commands goes. But this is what I get after a full reset (which I think should erase all information about the previous network), followed by a StatusReport:
Code: [Select]
10 06/17/09 22:53:59.789 Receive string: MESSAGE 72             <0xb68a4b90>
10 06/17/09 22:53:59.789 Received MESSAGE 72             0x80817a0 device: 387 <0xb68a4b90>
10 06/17/09 22:53:59.789 Received Message type 1 ID 776 from 0 to 387 (device: 387) resp 3 <0xb68a4b90>
36 06/17/09 22:53:59.789 Received command #776 - Reset <0xb68a4b90>
36 06/17/09 22:53:59.790 Resetting the eprom and all node information <0xb68a4b90>
36 06/17/09 22:53:59.790 Reset controller and erase all node information <0xb68a4b90>
40 06/17/09 22:53:59.849 Sending job 0x80c1df0 (cb 11) - 0x1 0x4 0x0 0x42 0xb 0xb2 (###B##) <0xb78a6b90>
41 06/17/09 22:54:00.669 0x1 0x4 0x0 0x42 0xb 0xb2 (###B##) <0xb78a6b90>
36 06/17/09 22:54:00.669 Generic callback handling for command 66, removing job <0xb78a6b90>
10 06/17/09 22:54:12.706 Receive string: MESSAGE 67             <0xb68a4b90>
10 06/17/09 22:54:12.706 Received MESSAGE 67             0x80817a0 device: 387 <0xb68a4b90>
10 06/17/09 22:54:12.706 Received Message type 1 ID 756 from 0 to 387 (device: 387) resp 0 <0xb68a4b90>
36 06/17/09 22:54:12.706 Received command #756 - Report Child Devices <0xb68a4b90>
10 06/17/09 22:54:22.319 Receive string: MESSAGE 72             <0xb68a4b90>
10 06/17/09 22:54:22.319 Received MESSAGE 72             0x80817a0 device: 387 <0xb68a4b90>
10 06/17/09 22:54:22.319 Received Message type 1 ID 788 from 0 to 387 (device: 387) resp 0 <0xb68a4b90>
36 06/17/09 22:54:22.319 Received command #788 - StatusReport <0xb68a4b90>
36 06/17/09 22:54:22.319 Soft-resetting the Z-Wave chip <0xb68a4b90>
40 06/17/09 22:54:22.333 Sending job 0x80c2010 (cb 0) - 0x1 0x3 0x0 0x8 0xf4 (#####) <0xb78a6b90>
36 06/17/09 22:54:24.319 Requesting Neighbour Update for node 1 <0xb68a4b90>
40 06/17/09 22:54:24.353 Sending job 0x80c2230 (cb 12) - 0x1 0x5 0x0 0x48 0x1 0xc 0xbf (###H###) <0xb78a6b90>
41 06/17/09 22:54:24.361 0x1 0x5 0x0 0x48 0xc 0x23 0x9d (###H###) <0xb78a6b90>
36 06/17/09 22:54:24.361 Generic callback handling for command 72, removing job <0xb78a6b90>
40 06/17/09 22:54:24.461 Sending job 0x80c2450 (cb 13) - 0x1 0xa 0x0 0x13 0xd 0x3 0x60 0x4 0x31 0x5 0xd 0xb5 (#\n##\r#`#1#\r#) <0xb78a6b90>
41 06/17/09 22:54:24.469 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:24.469 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:24.689 0x1 0x5 0x0 0x13 0xd 0x1 0xe5 (####\r##) <0xb78a6b90>
36 06/17/09 22:54:24.689 ZW_SEND Response with callback 13 received <0xb78a6b90>
36 06/17/09 22:54:24.689 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:24.789 Sending job 0x80c2450 (cb 13) - 0x1 0xa 0x0 0x13 0xd 0x3 0x60 0x4 0x31 0x5 0xd 0xb5 (#\n##\r#`#1#\r#) <0xb78a6b90>
41 06/17/09 22:54:24.797 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:24.797 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:25.097 0x1 0x5 0x0 0x13 0xd 0x1 0xe5 (####\r##) <0xb78a6b90>
36 06/17/09 22:54:25.097 ZW_SEND Response with callback 13 received <0xb78a6b90>
36 06/17/09 22:54:25.097 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:25.197 Sending job 0x80c2450 (cb 13) - 0x1 0xa 0x0 0x13 0xd 0x3 0x60 0x4 0x31 0x5 0xd 0xb5 (#\n##\r#`#1#\r#) <0xb78a6b90>
41 06/17/09 22:54:25.205 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:25.205 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:25.585 0x1 0x5 0x0 0x13 0xd 0x1 0xe5 (####\r##) <0xb78a6b90>
36 06/17/09 22:54:25.585 ZW_SEND Response with callback 13 received <0xb78a6b90>
36 06/17/09 22:54:25.585 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:25.685 Sending job 0x80c2450 (cb 13) - 0x1 0xa 0x0 0x13 0xd 0x3 0x60 0x4 0x31 0x5 0xd 0xb5 (#\n##\r#`#1#\r#) <0xb78a6b90>
41 06/17/09 22:54:25.693 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:25.693 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:26.033 0x1 0x5 0x0 0x13 0xd 0x1 0xe5 (####\r##) <0xb78a6b90>
36 06/17/09 22:54:26.033 ZW_SEND Response with callback 13 received <0xb78a6b90>
36 06/17/09 22:54:26.033 Error: ZW_SEND failed, removing job after three tries <0xb78a6b90>
40 06/17/09 22:54:26.133 Sending job 0x80c2670 (cb 14) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x1 0x31 0x4 0x5 0xe 0xb1 (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:26.141 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:26.141 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:26.365 0x1 0x5 0x0 0x13 0xe 0x1 0xe6 (#######) <0xb78a6b90>
36 06/17/09 22:54:26.365 ZW_SEND Response with callback 14 received <0xb78a6b90>
36 06/17/09 22:54:26.365 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:26.465 Sending job 0x80c2670 (cb 14) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x1 0x31 0x4 0x5 0xe 0xb1 (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:26.473 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:26.473 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:26.777 0x1 0x5 0x0 0x13 0xe 0x1 0xe6 (#######) <0xb78a6b90>
36 06/17/09 22:54:26.777 ZW_SEND Response with callback 14 received <0xb78a6b90>
36 06/17/09 22:54:26.777 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:26.877 Sending job 0x80c2670 (cb 14) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x1 0x31 0x4 0x5 0xe 0xb1 (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:26.885 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:26.885 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:27.269 0x1 0x5 0x0 0x13 0xe 0x1 0xe6 (#######) <0xb78a6b90>
36 06/17/09 22:54:27.269 ZW_SEND Response with callback 14 received <0xb78a6b90>
36 06/17/09 22:54:27.269 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:27.369 Sending job 0x80c2670 (cb 14) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x1 0x31 0x4 0x5 0xe 0xb1 (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:27.377 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:27.377 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:27.681 0x1 0x5 0x0 0x13 0xe 0x1 0xe6 (#######) <0xb78a6b90>
36 06/17/09 22:54:27.681 ZW_SEND Response with callback 14 received <0xb78a6b90>
36 06/17/09 22:54:27.681 Error: ZW_SEND failed, removing job after three tries <0xb78a6b90>
40 06/17/09 22:54:27.781 Sending job 0x80c2890 (cb 15) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x2 0x31 0x4 0x5 0xf 0xb3 (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:27.789 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:27.789 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:28.057 0x1 0x5 0x0 0x13 0xf 0x1 0xe7 (#######) <0xb78a6b90>
36 06/17/09 22:54:28.057 ZW_SEND Response with callback 15 received <0xb78a6b90>
36 06/17/09 22:54:28.057 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:28.157 Sending job 0x80c2890 (cb 15) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x2 0x31 0x4 0x5 0xf 0xb3 (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:28.165 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:28.165 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:28.509 0x1 0x5 0x0 0x13 0xf 0x1 0xe7 (#######) <0xb78a6b90>
36 06/17/09 22:54:28.509 ZW_SEND Response with callback 15 received <0xb78a6b90>
36 06/17/09 22:54:28.509 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:28.609 Sending job 0x80c2890 (cb 15) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x2 0x31 0x4 0x5 0xf 0xb3 (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:28.617 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:28.617 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:28.961 0x1 0x5 0x0 0x13 0xf 0x1 0xe7 (#######) <0xb78a6b90>
36 06/17/09 22:54:28.961 ZW_SEND Response with callback 15 received <0xb78a6b90>
36 06/17/09 22:54:28.961 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:29.061 Sending job 0x80c2890 (cb 15) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x2 0x31 0x4 0x5 0xf 0xb3 (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:29.069 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:29.069 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:29.333 0x1 0x5 0x0 0x13 0xf 0x1 0xe7 (#######) <0xb78a6b90>
36 06/17/09 22:54:29.333 ZW_SEND Response with callback 15 received <0xb78a6b90>
36 06/17/09 22:54:29.333 Error: ZW_SEND failed, removing job after three tries <0xb78a6b90>
40 06/17/09 22:54:29.433 Sending job 0x80c2ab0 (cb 16) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x3 0x31 0x4 0x5 0x10 0xad (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:29.441 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:29.441 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:29.785 0x1 0x5 0x0 0x13 0x10 0x1 0xf8 (#######) <0xb78a6b90>
36 06/17/09 22:54:29.785 ZW_SEND Response with callback 16 received <0xb78a6b90>
36 06/17/09 22:54:29.785 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:29.885 Sending job 0x80c2ab0 (cb 16) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x3 0x31 0x4 0x5 0x10 0xad (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:29.893 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:29.893 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:30.158 0x1 0x5 0x0 0x13 0x10 0x1 0xf8 (#######) <0xb78a6b90>
36 06/17/09 22:54:30.158 ZW_SEND Response with callback 16 received <0xb78a6b90>
36 06/17/09 22:54:30.158 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:30.257 Sending job 0x80c2ab0 (cb 16) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x3 0x31 0x4 0x5 0x10 0xad (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:30.265 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:30.265 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:30.529 0x1 0x5 0x0 0x13 0x10 0x1 0xf8 (#######) <0xb78a6b90>
36 06/17/09 22:54:30.529 ZW_SEND Response with callback 16 received <0xb78a6b90>
36 06/17/09 22:54:30.529 Error: ZW_SEND failed, retrying <0xb78a6b90>
40 06/17/09 22:54:30.629 Sending job 0x80c2ab0 (cb 16) - 0x1 0xc 0x0 0x13 0xd 0x5 0x60 0x6 0x3 0x31 0x4 0x5 0x10 0xad (####\r#`##1####) <0xb78a6b90>
41 06/17/09 22:54:30.637 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78a6b90>
36 06/17/09 22:54:30.637 ZW_SEND delivered to Z-Wave stack <0xb78a6b90>
41 06/17/09 22:54:31.061 0x1 0x5 0x0 0x13 0x10 0x1 0xf8 (#######) <0xb78a6b90>
36 06/17/09 22:54:31.061 ZW_SEND Response with callback 16 received <0xb78a6b90>
36 06/17/09 22:54:31.061 Error: ZW_SEND failed, removing job after three tries <0xb78a6b90>
Please note all the ZW_SEND failed notifications. There is no network, so why is the interface trying to send stuff? Is this my situation, is it something with the driver or do I maybe not understand what is going on?  :D

hari

  • Administrator
  • LinuxMCE God
  • *****
  • Posts: 2421
    • View Profile
    • ago control
Re: ZWave USB serial problem
« Reply #10 on: June 18, 2009, 01:25:53 am »
the Statusreport command also tries to refresh the neighbor list of all nodes. As you did not quick reload after the Reset command, lmce still has the list of the old childs in memory and tries to reach each of them at the statusreport. As the nodes of course don't exist anymore in the network/nodelist on the chip, ZW_SEND to those node id of course does fail.

br, Hari
rock your home - http://www.agocontrol.com home automation

Domodude

  • Guest
Re: ZWave USB serial problem
« Reply #11 on: June 18, 2009, 09:26:39 am »
the Statusreport command also tries to refresh the neighbor list of all nodes. As you did not quick reload after the Reset command, lmce still has the list of the old childs in memory and tries to reach each of them at the statusreport. As the nodes of course don't exist anymore in the network/nodelist on the chip, ZW_SEND to those node id of course does fail.

Ah ok. So it is as I feared -- I didn't fully understand what was going on  ;D

Domodude

  • Guest
Re: ZWave USB serial problem
« Reply #12 on: June 18, 2009, 07:57:44 pm »
Hm, I did a reset of the dcerouter, and after that a reset of the core. To be absolutely certain of a proper reset, I sent the Reset command to the stick again after that. Same result.

I am going to upload the Merten config now, and see what happens.

EDIT

Result (very long):
Code: [Select]
10 06/18/09 19:57:58.703 Received MESSAGE 72             0x80817a0 device: 387 <0xb68b5b90>
10 06/18/09 19:57:58.703 Received Message type 1 ID 757 from 0 to 387 (device: 387) resp 3 <0xb68b5b90>
36 06/18/09 19:57:58.703 Received command #757 - Download Configuration <0xb68b5b90>
36 06/18/09 19:57:58.703 Download configuration start <0xb68b5b90>
36 06/18/09 19:57:58.703 Replicate controller start <0xb68b5b90>
40 06/18/09 19:57:58.737 Sending job 0x80c2cd0 (cb 0) - 0x1 0x4 0x0 0x50 0x1 0xaa (###P##) <0xb78b7b90>
41 06/18/09 19:58:05.605 0x1 0x7 0x0 0x50 0x2 0x1 0x2 0x0 0xa9 (###P#####) <0xb78b7b90>
41 06/18/09 19:58:15.105 0x1 0x6 0x0 0x49 0x10 0x0 0x0 0xa0 (###I####) <0xb78b7b90>
41 06/18/09 19:58:15.197 0x1 0x7 0x0 0x50 0x2 0x6 0x2 0x0 0xae (###P#####) <0xb78b7b90>
41 06/18/09 19:58:21.629 0x1 0x13 0x0 0x49 0x84 0x2 0xd 0x1 0x12 0x0 0x72 0x86 0x70 0x85 0x8e 0xef 0x85 0x20 0x26 0x50 0x8e (###I##\r###r#p#### &P#) <0xb78b7b90>
36 06/18/09 19:58:21.629 FUNC_ID_ZW_APPLICATION_UPDATE:UPDATE_STATE_NODE_INFO_RECEIVED received from node 2 -  <0xb78b7b90>
36 06/18/09 19:58:51.821 We have been idle for 30 seconds, polling device states <0xb78b7b90>
40 06/18/09 19:58:51.921 Sending job 0x80c2ef0 (cb 18) - 0x1 0x9 0x0 0x13 0xff 0x2 0x20 0x2 0x5 0x12 0x2d (###### ###-) <0xb78b7b90>
41 06/18/09 19:58:51.929 0x1 0x4 0x1 0x13 0x1 0xe8 (######) <0xb78b7b90>
36 06/18/09 19:58:51.929 ZW_SEND delivered to Z-Wave stack <0xb78b7b90>
41 06/18/09 19:58:51.949 0x1 0x5 0x0 0x13 0x12 0x0 0xfb (#######) <0xb78b7b90>
36 06/18/09 19:58:51.949 ZW_SEND Response with callback 18 received <0xb78b7b90>
36 06/18/09 19:58:51.949 ZW_SEND was successful, removing job <0xb78b7b90>
41 06/18/09 19:58:52.029 0x1 0x9 0x0 0x4 0x0 0x26 0x3 0x20 0x3 0x0 0xf4 (#####&# ###) <0xb78b7b90>
36 06/18/09 19:58:52.029 FUNC_ID_APPLICATION_COMMAND_HANDLER: <0xb78b7b90>
36 06/18/09 19:58:52.029 COMMAND_CLASS_BASIC -  <0xb78b7b90>
36 06/18/09 19:58:52.029 Got basic report from node 38, value: 0 <0xb78b7b90>
41 06/18/09 19:58:52.201 0x1 0x9 0x0 0x4 0x0 0x27 0x3 0x20 0x3 0x0 0xf5 (#####'# ###) <0xb78b7b90>
36 06/18/09 19:58:52.201 FUNC_ID_APPLICATION_COMMAND_HANDLER: <0xb78b7b90>
36 06/18/09 19:58:52.201 COMMAND_CLASS_BASIC -  <0xb78b7b90>
36 06/18/09 19:58:52.201 Got basic report from node 39, value: 0 <0xb78b7b90>
36 06/18/09 19:58:58.717 Download configuration end <0xb68b5b90>
36 06/18/09 19:58:58.717 Replicate controller end <0xb68b5b90>
36 06/18/09 19:58:58.717 Get new init data after replication <0xb68b5b90>
10 06/18/09 19:58:58.717 Socket::SendMessage type 2 id 55 from 387 to -1001 <0xb68b5b90>
05 06/18/09 19:58:58.718 Socket::ReceiveData 0x80817a0 failed, bytes left 0 start: 10000 1: 0 1b: 0 2: 0 2b: 0 m_Socket: 7 Command_Impl1 Dev #387 <0xb68b5b90>
13 06/18/09 19:58:58.718 Socket::Close() m_Socket 7 <0xb68b5b90>
13 06/18/09 19:58:58.718 Socket::Close() m_Socket 7 closesocket: 0 <0xb68b5b90>
05 06/18/09 19:58:58.718 Socket::ReceiveString2 ReceiveData failed m_Socket: -1 Command_Impl1 Dev #387 <0xb68b5b90>
01 06/18/09 19:58:58.718 Receive string failed in HandleRequestSocket 18:ReceiveData failed Command_Impl1 Dev #387 <0xb68b5b90>
40 06/18/09 19:58:58.733 Sending job 0x80c3110 (cb 0) - 0x1 0x4 0x0 0x50 0x0 0xab (###P##) <0xb78b7b90>
21 06/18/09 19:58:58.740 Dumping 1 locks <0xb68b5b90>
21 06/18/09 19:58:58.740 Size of locks: 1
 <0xb68b5b90>
21 06/18/09 19:58:58.761 logging message Dumping 1 locks
 <0xb68b5b90>
05 06/18/09 19:58:58.761 Dumping 1 locks <0xb68b5b90>
21 06/18/09 19:58:58.761 logging message finished check for exceptions
 <0xb68b5b90>
05 06/18/09 19:58:58.761 finished check for exceptions <0xb68b5b90>
21 06/18/09 19:58:58.761 logging message OL: (0x80818ec) (>132) MessageQueue Command_Impl.cpp l:822 time: 1:00:00a (1245347938 s) thread: 3070978960 Rel: Y Got: Y
 <0xb68b5b90>
05 06/18/09 19:58:58.761 OL: (0x80818ec) (>132) MessageQueue Command_Impl.cpp l:822 time: 1:00:00a (1245347938 s) thread: 3070978960 Rel: Y Got: Y <0xb68b5b90>
10 06/18/09 19:58:58.761 Requesthandler 0x80817a0 (device: 387) Closing request handler connection <0xb68b5b90>
10 06/18/09 19:58:58.761 Command_Impl::OnReload 387 <0xb68b5b90>
10 06/18/09 19:58:58.761 Socket m_Socket -1/0x80817a0 Command_Impl1 Dev #387 m_bQuit=1 <0xb68b5b90>
21 06/18/09 19:58:58.761 end cond wait Command_Impl.cpp:822 (0x80818ec)  <0xb70b6b90>
21 06/18/09 19:58:58.761 unlock(0x80818ec) #0 (>132) MessageQueue: Command_Impl.cpp:822  <0xb70b6b90>
21 06/18/09 19:58:58.761 removed from map (0x80818ec) #0 (>132) MessageQueue: Command_Impl.cpp:822  was: 1 size, now 0 Rel: Y Got: Y <0xb70b6b90>
13 06/18/09 19:58:58.761 Exiting MessageQueueThread_DCECI thread... <0xb70b6b90>
13 06/18/09 19:58:58.761 Exiting BeginHandleRequestThread thread... <0xb68b5b90>
10 06/18/09 19:58:58.761 Waiting for message queue thread to quit <0xb78b86c0>
10 06/18/09 19:58:58.761 Socket m_Socket -1/0x80817a0 Command_Impl1 Dev #387 m_bQuit=1 <0xb78b86c0>
10 06/18/09 19:58:58.762 Socket m_Socket -1/0x80817a0 Command_Impl1 Dev #387 m_bQuit=1 <0xb78b86c0>
13 06/18/09 19:58:58.762 Socket::Close() m_Socket 4 <0xb78b86c0>
13 06/18/09 19:58:58.762 Socket::Close() m_Socket 4 closesocket: 0 <0xb78b86c0>
13 06/18/09 19:58:58.762 Socket::Close() m_Socket 5 <0xb78b86c0>
13 06/18/09 19:58:58.762 Socket::Close() m_Socket 5 closesocket: 0 <0xb78b86c0>
10 06/18/09 19:58:58.762 Message queue thread quit <0xb78b86c0>
10 06/18/09 19:58:58.762 Message queue thread joined <0xb78b86c0>
10 06/18/09 19:58:58.762 About to call kill spawned devices <0xb78b86c0>
10 06/18/09 19:58:58.762 Need to kill 0 child devices <0xb78b86c0>
10 06/18/09 19:58:58.762 Killing completed. <0xb78b86c0>
13 06/18/09 19:58:58.763 Socket::~Socket(): deleting socket @0x80811a0 Event Dev #387 (socket id in destructor: m_Socket: -1) <0xb78b86c0>
13 06/18/09 19:58:58.763 Socket::~Socket(): deleting socket @0x80870c8 Event Dev #387 (socket id in destructor: m_Socket: -1) <0xb78b86c0>
10 06/18/09 19:58:58.763 ~Command_Impl finished <0xb78b86c0>
13 06/18/09 19:58:58.763 ~HandleRequestSocket 0x80817a0 device: 387 ip: 127.0.0.1 <0xb78b86c0>
13 06/18/09 19:58:58.763 RequestSocket::Disconnect 0x80817a0 device: 387 <0xb78b86c0>
13 06/18/09 19:58:58.763 Socket::~Socket(): deleting socket @0x80817a0 Command_Impl1 Dev #387 (socket id in destructor: m_Socket: -1) <0xb78b86c0>
10 06/18/09 19:58:58.763 Device: 387 ending <0xb78b86c0>
Return code: 2
2 06/18/09 19:58:58 387 (spawning-device) Device requests restart... count=1/50 dev=387
Thu Jun 18 19:58:58 CEST 2009 Restart
========== NEW LOG SECTION ==========
1 06/18/09 19:59:06 387 (spawning-device) Starting... 1
1 06/18/09 19:59:06 387 (spawning-device) Found /usr/pluto/bin/ZWave
10 06/18/09 19:59:06.915 Device: 387 starting.  Connecting to: localhost <0xb795d6c0>
10 06/18/09 19:59:06.918 Setting timeout for socket 4 to 20 <0xb795d6c0>
10 06/18/09 19:59:07.003 Socket::SendMessage type 5 id 37 from 387 to -1000 <0xb795d6c0>
10 06/18/09 19:59:07.069 TranslateSerialUSB Cmd find /sys/devices -name '*tty*' | grep '/tty:' | grep usb | grep 'pci0000:00/0000:00:02.0.*-4:.*' | sed 's/tty://g' >/tmp/devusb6tBEJT size 1 <0xb795d6c0>
10 06/18/09 19:59:07.070 TranslateSerialUSB found /sys/devices/pci0000:00/0000:00:02.0/usb3/3-4/3-4:1.0/ttyUSB1/ttyUSB1, returning /dev/ttyUSB1 <0xb795d6c0>
36 06/18/09 19:59:07.070 Initialization... <0xb795d6c0>
36 06/18/09 19:59:07.070 Open serial port /dev/ttyUSB1 <0xb795d6c0>
36 06/18/09 19:59:07.143 receiveFunction started <0xb795cb90>
36 06/18/09 19:59:07.143 Get version <0xb795d6c0>
36 06/18/09 19:59:07.143 Get home/node id <0xb795d6c0>
36 06/18/09 19:59:07.143 Get capabilities <0xb795d6c0>
36 06/18/09 19:59:07.143 Get SUC node id <0xb795d6c0>
36 06/18/09 19:59:07.143 Get init data <0xb795d6c0>
10 06/18/09 19:59:07.145 Connect OK <0xb795d6c0>
05 06/18/09 19:59:07.145 Creating child 388 <0xb795d6c0>
10 06/18/09 19:59:07.145 Got CreateEvent for unknown type 1820. <0xb795d6c0>
05 06/18/09 19:59:07.145 Note: Device manager has attached a device of type 1820 that this has no custom event handler for.  It will not fire events. <0xb795d6c0>
10 06/18/09 19:59:07.145 Got CreateCommand for unknown type 1820. <0xb795d6c0>
05 06/18/09 19:59:07.145 Note: Device manager has attached a device of type 1820 that this has no custom handler for.  This is normal for IR. <0xb795d6c0>
05 06/18/09 19:59:07.145 Creating child 389 <0xb795d6c0>
10 06/18/09 19:59:07.145 Got CreateEvent for unknown type 1922. <0xb795d6c0>
05 06/18/09 19:59:07.145 Note: Device manager has attached a device of type 1922 that this has no custom event handler for.  It will not fire events. <0xb795d6c0>
10 06/18/09 19:59:07.145 Got CreateCommand for unknown type 1922. <0xb795d6c0>
05 06/18/09 19:59:07.145 Note: Device manager has attached a device of type 1922 that this has no custom handler for.  This is normal for IR. <0xb795d6c0>
21 06/18/09 19:59:07.145 lock(0x80818ec) (>107) MessageQueue: Command_Impl.cpp:822  <0xb715bb90>
21 06/18/09 19:59:07.145 acquired(0x80818ec) #0 (>107) MessageQueue Command_Impl.cpp:822  <0xb715bb90>
21 06/18/09 19:59:07.145 start cond wait Command_Impl.cpp:822 (0x80818ec)  <0xb715bb90>
10 06/18/09 19:59:07.145 Requesthandler 0x80817a0 (device: 387) runThread now running <0xb695ab90>
36 06/18/09 19:59:10.241 No callback received: await_callback: 134744472 timer: 31 <0xb795cb90>
40 06/18/09 19:59:10.341 Sending job 0x8089440 (cb 0) - 0x1 0x3 0x0 0x15 0xe9 (#####) <0xb795cb90>
41 06/18/09 19:59:10.345 0x1 0x10 0x1 0x15 0x5a 0x2d 0x57 0x61 0x76 0x65 0x20 0x32 0x2e 0x34 0x38 0x0 0x1 0x98 (####Z-Wave 2.48###) <0xb795cb90>
36 06/18/09 19:59:10.345 TODO: handle response for 0x15  <0xb795cb90>
40 06/18/09 19:59:10.445 Sending job 0x8089660 (cb 0) - 0x1 0x3 0x0 0x20 0xdc (### #) <0xb795cb90>
41 06/18/09 19:59:10.449 0x1 0x8 0x1 0x20 0xf1 0x99 0x13 0x34 0x29 0xb0 (### ###4)#) <0xb795cb90>
36 06/18/09 19:59:10.449 Got reply to ZW_MEMORY_GET_ID, Home id: 0xf1991334, our node id: 41 <0xb795cb90>
40 06/18/09 19:59:10.549 Sending job 0x8089880 (cb 0) - 0x1 0x3 0x0 0x7 0xfb (#####) <0xb795cb90>
41 06/18/09 19:59:10.557 0x1 0x2b 0x1 0x7 0x2 0x52 0x0 0x0 0x0 0x1 0x0 0x1 0xfe 0x80 0xfe 0x88 0xf 0x0 0x0 0x0 0xfb 0x9f 0x7f 0x80 0x7 0x0 0x0 0x80 0x0 0x80 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x19 (#+###R#######################################) <0xb795cb90>
36 06/18/09 19:59:10.557 TODO: handle response for 0x7  <0xb795cb90>
40 06/18/09 19:59:10.657 Sending job 0x8089aa0 (cb 0) - 0x1 0x3 0x0 0x56 0xaa (###V#) <0xb795cb90>
41 06/18/09 19:59:10.661 0x1 0x4 0x1 0x56 0x0 0xac (###V##) <0xb795cb90>
36 06/18/09 19:59:10.661 Got reply to GET_SUC_NODE_ID, node: 0 <0xb795cb90>
36 06/18/09 19:59:10.661 No SUC, we become SUC <0xb795cb90>
40 06/18/09 19:59:10.761 Sending job 0x8089cc0 (cb 0) - 0x1 0x3 0x0 0x2 0xfe (#####) <0xb795cb90>
41 06/18/09 19:59:10.813 0x1 0x25 0x1 0x2 0x4 0x4 0x1d 0xba 0xca 0x41 0xf0 0xff 0x1 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x0 0x3 0x1 0xf9 (#0X0.0000008078E7P-1022#############################) <0xb795cb90>
36 06/18/09 19:59:10.828 Got reply to FUNC_ID_SERIAL_API_GET_INIT_DATA: <0xb795cb90>
40 06/18/09 19:59:10.925 Sending job 0x808e4e8 (cb 0) - 0x1 0x5 0x0 0x52 0x1 0x1 0xa8 (###R###) <0xb795cb90>
41 06/18/09 19:59:10.929 0x1 0x4 0x1 0x52 0x1 0xa9 (###R##) <0xb795cb90>
36 06/18/09 19:59:10.929 TODO: handle response for 0x52  <0xb795cb90>
40 06/18/09 19:59:11.029 Sending job 0x808e708 (cb 1) - 0x1 0x8 0x0 0x54 0x29 0x1 0x0 0x1 0x1 0x8b (###T)#####) <0xb795cb90>
41 06/18/09 19:59:11.033 0x1 0x4 0x1 0x54 0x0 0xae (###T##) <0xb795cb90>
36 06/18/09 19:59:11.033 TODO: handle response for 0x54  <0xb795cb90>
36 06/18/09 19:59:14.153 No callback received: await_callback: 1 timer: 31 <0xb795cb90>
40 06/18/09 19:59:14.253 Sending job 0x808e708 (cb 1) - 0x1 0x8 0x0 0x54 0x29 0x1 0x0 0x1 0x1 0x8b (###T)#####) <0xb795cb90>
41 06/18/09 19:59:14.257 0x1 0x4 0x1 0x54 0x0 0xae (###T##) <0xb795cb90>
36 06/18/09 19:59:14.257 TODO: handle response for 0x54  <0xb795cb90>
36 06/18/09 19:59:17.357 No callback received: await_callback: 1 timer: 31 <0xb795cb90>
40 06/18/09 19:59:17.481 Sending job 0x808e708 (cb 1) - 0x1 0x8 0x0 0x54 0x29 0x1 0x0 0x1 0x1 0x8b (###T)#####) <0xb795cb90>
41 06/18/09 19:59:17.485 0x1 0x4 0x1 0x54 0x0 0xae (###T##) <0xb795cb90>
36 06/18/09 19:59:17.485 TODO: handle response for 0x54  <0xb795cb90>
36 06/18/09 19:59:20.609 No callback received: await_callback: 1 timer: 31 <0xb795cb90>
36 06/18/09 19:59:20.609 ERROR: Dropping command, no callback received after three resends <0xb795cb90>
40 06/18/09 19:59:20.709 Sending job 0x808e970 (cb 0) - 0x1 0x4 0x0 0x41 0x2 0xb8 (###A##) <0xb795cb90>
41 06/18/09 19:59:20.713 0x1 0x9 0x1 0x41 0xa 0x6 0x0 0x1 0x12 0x0 0xa9 (###A\n######) <0xb795cb90>
36 06/18/09 19:59:20.713 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:20.713 ***FOUND NODE: 2 <0xb795cb90>
36 06/18/09 19:59:20.713 sleeping node <0xb795cb90>
36 06/18/09 19:59:20.713 BASIC TYPE: Controller <0xb795cb90>
36 06/18/09 19:59:20.713 GENERIC TYPE: Remote Switch <0xb795cb90>
36 06/18/09 19:59:20.713 SPECIFIC TYPE: 0x0 <0xb795cb90>
40 06/18/09 19:59:20.813 Sending job 0x808eb90 (cb 0) - 0x1 0x4 0x0 0x41 0x4 0xbe (###A##) <0xb795cb90>
41 06/18/09 19:59:20.817 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:20.817 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:20.817 ***FOUND NODE: 4 <0xb795cb90>
36 06/18/09 19:59:20.817 listening node <0xb795cb90>
36 06/18/09 19:59:20.817 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:20.817 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:20.817 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:20.817 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:20.817 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:20.899 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c37f8 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:20.899 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:20.997 Sending job 0x808edb0 (cb 0) - 0x1 0x4 0x0 0x41 0x5 0xbf (###A##) <0xb795cb90>
41 06/18/09 19:59:21.001 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:21.001 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:21.001 ***FOUND NODE: 5 <0xb795cb90>
36 06/18/09 19:59:21.001 listening node <0xb795cb90>
36 06/18/09 19:59:21.001 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:21.001 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:21.001 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:21.001 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:21.001 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:21.010 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c37b0 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:21.010 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:21.109 Sending job 0x808efd0 (cb 0) - 0x1 0x4 0x0 0x41 0x6 0xbc (###A##) <0xb795cb90>
41 06/18/09 19:59:21.113 0x1 0x9 0x1 0x41 0xca 0x6 0x0 0x2 0x2 0x1 0x7b (###A######{) <0xb795cb90>
36 06/18/09 19:59:21.113 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
>> to be continued >>
« Last Edit: June 18, 2009, 08:01:11 pm by Domodude »

Domodude

  • Guest
Re: ZWave USB serial problem
« Reply #13 on: June 18, 2009, 08:25:25 pm »
>> previously on Z-Men, the series >>
... see above ;)
Code: [Select]
36 06/18/09 19:59:21.113 ***FOUND NODE: 6 <0xb795cb90>
36 06/18/09 19:59:21.113 listening node <0xb795cb90>
36 06/18/09 19:59:21.113 BASIC TYPE: Static Controller <0xb795cb90>
36 06/18/09 19:59:21.113 GENERIC TYPE: Static Controller <0xb795cb90>
36 06/18/09 19:59:21.113 SPECIFIC TYPE: 0x1 <0xb795cb90>
40 06/18/09 19:59:21.213 Sending job 0x808f1f0 (cb 0) - 0x1 0x4 0x0 0x41 0x8 0xb2 (###A##) <0xb795cb90>
41 06/18/09 19:59:21.217 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:21.217 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:21.217 ***FOUND NODE: 8 <0xb795cb90>
36 06/18/09 19:59:21.217 listening node <0xb795cb90>
36 06/18/09 19:59:21.217 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:21.217 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:21.217 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:21.217 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:21.217 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:21.356 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c37b0 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:21.356 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:21.453 Sending job 0x808f410 (cb 0) - 0x1 0x4 0x0 0x41 0xa 0xb0 (###A\n#) <0xb795cb90>
41 06/18/09 19:59:21.457 0x1 0x9 0x1 0x41 0xa 0x6 0x0 0x1 0x12 0x0 0xa9 (###A\n######) <0xb795cb90>
36 06/18/09 19:59:21.457 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:21.457 ***FOUND NODE: 10 <0xb795cb90>
36 06/18/09 19:59:21.457 sleeping node <0xb795cb90>
36 06/18/09 19:59:21.457 BASIC TYPE: Controller <0xb795cb90>
36 06/18/09 19:59:21.457 GENERIC TYPE: Remote Switch <0xb795cb90>
36 06/18/09 19:59:21.457 SPECIFIC TYPE: 0x0 <0xb795cb90>
40 06/18/09 19:59:21.557 Sending job 0x808f630 (cb 0) - 0x1 0x4 0x0 0x41 0xc 0xb6 (###A##) <0xb795cb90>
41 06/18/09 19:59:21.561 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:21.561 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:21.561 ***FOUND NODE: 12 <0xb795cb90>
36 06/18/09 19:59:21.561 listening node <0xb795cb90>
36 06/18/09 19:59:21.561 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:21.561 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:21.561 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:21.561 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:21.561 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:21.594 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c37b0 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:21.594 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:21.694 Sending job 0x808f850 (cb 0) - 0x1 0x4 0x0 0x41 0xf 0xb5 (###A##) <0xb795cb90>
41 06/18/09 19:59:21.705 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:21.705 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:21.705 ***FOUND NODE: 15 <0xb795cb90>
36 06/18/09 19:59:21.705 listening node <0xb795cb90>
36 06/18/09 19:59:21.705 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:21.705 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:21.705 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:21.705 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:21.705 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:21.724 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c37b0 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:21.724 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:21.821 Sending job 0x80c1350 (cb 0) - 0x1 0x4 0x0 0x41 0x10 0xaa (###A##) <0xb795cb90>
41 06/18/09 19:59:21.825 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:21.825 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:21.825 ***FOUND NODE: 16 <0xb795cb90>
36 06/18/09 19:59:21.825 listening node <0xb795cb90>
36 06/18/09 19:59:21.825 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:21.825 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:21.825 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:21.825 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:21.825 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:21.834 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c3798 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:21.834 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:21.933 Sending job 0x80c1570 (cb 0) - 0x1 0x4 0x0 0x41 0x11 0xab (###A##) <0xb795cb90>
41 06/18/09 19:59:21.937 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x10 0x1 0x66 (###A######f) <0xb795cb90>
36 06/18/09 19:59:21.937 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:21.937 ***FOUND NODE: 17 <0xb795cb90>
36 06/18/09 19:59:21.937 listening node <0xb795cb90>
36 06/18/09 19:59:21.937 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:21.937 GENERIC TYPE: Binary Switch <0xb795cb90>
36 06/18/09 19:59:21.937 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:21.937 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:21.937 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:21.954 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c3e68 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:21.954 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:22.053 Sending job 0x80c1790 (cb 0) - 0x1 0x4 0x0 0x41 0x17 0xad (###A##) <0xb795cb90>
41 06/18/09 19:59:22.057 0x1 0x9 0x1 0x41 0xa 0x6 0x0 0x1 0x12 0x0 0xa9 (###A\n######) <0xb795cb90>
36 06/18/09 19:59:22.057 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:22.057 ***FOUND NODE: 23 <0xb795cb90>
36 06/18/09 19:59:22.057 sleeping node <0xb795cb90>
36 06/18/09 19:59:22.057 BASIC TYPE: Controller <0xb795cb90>
36 06/18/09 19:59:22.057 GENERIC TYPE: Remote Switch <0xb795cb90>
36 06/18/09 19:59:22.057 SPECIFIC TYPE: 0x0 <0xb795cb90>
40 06/18/09 19:59:22.158 Sending job 0x80c19b0 (cb 0) - 0x1 0x4 0x0 0x41 0x1d 0xa7 (###A##) <0xb795cb90>
41 06/18/09 19:59:22.161 0x1 0x9 0x1 0x41 0xa 0x6 0x0 0x1 0x12 0x0 0xa9 (###A\n######) <0xb795cb90>
36 06/18/09 19:59:22.161 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:22.161 ***FOUND NODE: 29 <0xb795cb90>
36 06/18/09 19:59:22.161 sleeping node <0xb795cb90>
36 06/18/09 19:59:22.161 BASIC TYPE: Controller <0xb795cb90>
36 06/18/09 19:59:22.161 GENERIC TYPE: Remote Switch <0xb795cb90>
36 06/18/09 19:59:22.161 SPECIFIC TYPE: 0x0 <0xb795cb90>
40 06/18/09 19:59:22.261 Sending job 0x80c1bd0 (cb 0) - 0x1 0x4 0x0 0x41 0x1e 0xa4 (###A##) <0xb795cb90>
41 06/18/09 19:59:22.265 0x1 0x9 0x1 0x41 0xa 0x6 0x0 0x1 0x12 0x0 0xa9 (###A\n######) <0xb795cb90>
36 06/18/09 19:59:22.265 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:22.265 ***FOUND NODE: 30 <0xb795cb90>
36 06/18/09 19:59:22.265 sleeping node <0xb795cb90>
36 06/18/09 19:59:22.265 BASIC TYPE: Controller <0xb795cb90>
36 06/18/09 19:59:22.265 GENERIC TYPE: Remote Switch <0xb795cb90>
36 06/18/09 19:59:22.265 SPECIFIC TYPE: 0x0 <0xb795cb90>
40 06/18/09 19:59:22.365 Sending job 0x80c1df0 (cb 0) - 0x1 0x4 0x0 0x41 0x1f 0xa5 (###A##) <0xb795cb90>
41 06/18/09 19:59:22.369 0x1 0x9 0x1 0x41 0xa 0x6 0x0 0x1 0x12 0x0 0xa9 (###A\n######) <0xb795cb90>
36 06/18/09 19:59:22.369 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:22.369 ***FOUND NODE: 31 <0xb795cb90>
36 06/18/09 19:59:22.369 sleeping node <0xb795cb90>
36 06/18/09 19:59:22.369 BASIC TYPE: Controller <0xb795cb90>
36 06/18/09 19:59:22.369 GENERIC TYPE: Remote Switch <0xb795cb90>
36 06/18/09 19:59:22.369 SPECIFIC TYPE: 0x0 <0xb795cb90>
40 06/18/09 19:59:22.469 Sending job 0x80c2028 (cb 0) - 0x1 0x4 0x0 0x41 0x20 0x9a (###A #) <0xb795cb90>
41 06/18/09 19:59:22.473 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:22.473 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:22.473 ***FOUND NODE: 32 <0xb795cb90>
36 06/18/09 19:59:22.473 listening node <0xb795cb90>
36 06/18/09 19:59:22.473 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:22.473 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:22.473 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:22.473 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:22.473 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:22.490 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c3798 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:22.490 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:22.589 Sending job 0x80c2260 (cb 0) - 0x1 0x4 0x0 0x41 0x21 0x9b (###A!#) <0xb795cb90>
41 06/18/09 19:59:22.593 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:22.593 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:22.593 ***FOUND NODE: 33 <0xb795cb90>
36 06/18/09 19:59:22.593 listening node <0xb795cb90>
36 06/18/09 19:59:22.593 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:22.593 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:22.593 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:22.593 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:22.593 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:22.603 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c4058 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:22.603 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:22.701 Sending job 0x80c2498 (cb 0) - 0x1 0x4 0x0 0x41 0x22 0x98 (###A"#) <0xb795cb90>
41 06/18/09 19:59:22.705 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:22.705 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:22.705 ***FOUND NODE: 34 <0xb795cb90>
36 06/18/09 19:59:22.705 listening node <0xb795cb90>
36 06/18/09 19:59:22.705 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:22.705 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:22.705 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:22.705 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:22.705 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:22.724 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c3be0 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:22.724 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:22.821 Sending job 0x80c26d0 (cb 0) - 0x1 0x4 0x0 0x41 0x23 0x99 (###A##) <0xb795cb90>
41 06/18/09 19:59:22.825 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x10 0x1 0x66 (###A######f) <0xb795cb90>
36 06/18/09 19:59:22.825 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:22.825 ***FOUND NODE: 35 <0xb795cb90>
36 06/18/09 19:59:22.825 listening node <0xb795cb90>
36 06/18/09 19:59:22.825 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:22.825 GENERIC TYPE: Binary Switch <0xb795cb90>
36 06/18/09 19:59:22.825 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:22.825 InternalSendCommand id 718 out parm conf -1 resp 0x808fb00 <0xb795cb90>
10 06/18/09 19:59:22.825 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:22.835 InternalSendCommand out done id 718 conf -1 resp 0x808fb00 0x80c3be0 0 type 1 id 718 to 4 <0xb795cb90>

blah blah etcetera

10 06/18/09 19:59:23.065 InternalSendCommand out id 718 parm exiting conf -1 resp 0x808fb00 <0xb795cb90>
40 06/18/09 19:59:23.165 Sending job 0x80c2d78 (cb 0) - 0x1 0x4 0x0 0x41 0x26 0x9c (###A&#) <0xb795cb90>
41 06/18/09 19:59:23.169 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:23.169 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:23.169 ***FOUND NODE: 38 <0xb795cb90>
36 06/18/09 19:59:23.169 listening node <0xb795cb90>
36 06/18/09 19:59:23.169 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:23.169 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:23.169 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:23.169 InternalSendCommand id 718 out parm conf -1 resp 0x80c3b70 <0xb795cb90>
10 06/18/09 19:59:23.169 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:23.181 InternalSendCommand out done id 718 conf -1 resp 0x80c3b70 0x80c3be0 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:23.181 InternalSendCommand out id 718 parm exiting conf -1 resp 0x80c3b70 <0xb795cb90>
40 06/18/09 19:59:23.277 Sending job 0x80c2fb0 (cb 0) - 0x1 0x4 0x0 0x41 0x27 0x9d (###A'#) <0xb795cb90>
41 06/18/09 19:59:23.281 0x1 0x9 0x1 0x41 0xc9 0xc 0x0 0x4 0x11 0x1 0x67 (###A######g) <0xb795cb90>
36 06/18/09 19:59:23.281 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:23.281 ***FOUND NODE: 39 <0xb795cb90>
36 06/18/09 19:59:23.281 listening node <0xb795cb90>
36 06/18/09 19:59:23.281 BASIC TYPE: Routing Slave <0xb795cb90>
36 06/18/09 19:59:23.281 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:23.281 SPECIFIC TYPE: 0x1 <0xb795cb90>
10 06/18/09 19:59:23.281 InternalSendCommand id 718 out parm conf -1 resp 0x80c3b70 <0xb795cb90>
10 06/18/09 19:59:23.281 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:23.429 InternalSendCommand out done id 718 conf -1 resp 0x80c3b70 0x80c41e8 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:23.429 InternalSendCommand out id 718 parm exiting conf -1 resp 0x80c3b70 <0xb795cb90>
40 06/18/09 19:59:23.525 Sending job 0x80c31e8 (cb 0) - 0x1 0x4 0x0 0x41 0x28 0x92 (###A(#) <0xb795cb90>
41 06/18/09 19:59:23.529 0x1 0x9 0x1 0x41 0xc9 0x4 0x0 0x3 0x11 0x0 0x69 (###A######i) <0xb795cb90>
36 06/18/09 19:59:23.529 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:23.529 ***FOUND NODE: 40 <0xb795cb90>
36 06/18/09 19:59:23.529 listening node <0xb795cb90>
36 06/18/09 19:59:23.529 BASIC TYPE: Slave <0xb795cb90>
36 06/18/09 19:59:23.529 GENERIC TYPE: Multilevel Switch <0xb795cb90>
36 06/18/09 19:59:23.529 SPECIFIC TYPE: 0x0 <0xb795cb90>
10 06/18/09 19:59:23.529 InternalSendCommand id 718 out parm conf -1 resp 0x80c3b70 <0xb795cb90>
10 06/18/09 19:59:23.529 Socket::SendMessage type 1 id 718 from 387 to 4 <0xb795cb90>
10 06/18/09 19:59:23.558 InternalSendCommand out done id 718 conf -1 resp 0x80c3b70 0x80c41e8 0 type 1 id 718 to 4 <0xb795cb90>
10 06/18/09 19:59:23.558 InternalSendCommand out id 718 parm exiting conf -1 resp 0x80c3b70 <0xb795cb90>
40 06/18/09 19:59:23.657 Sending job 0x80c3420 (cb 0) - 0x1 0x4 0x0 0x41 0x29 0x93 (###A)#) <0xb795cb90>
41 06/18/09 19:59:23.661 0x1 0x9 0x1 0x41 0xd2 0x16 0x0 0x2 0x2 0x1 0x73 (###A######s) <0xb795cb90>
36 06/18/09 19:59:23.661 Got reply to FUNC_ID_ZW_GET_NODE_PROTOCOL_INFO: <0xb795cb90>
36 06/18/09 19:59:23.661 ***FOUND NODE: 41 <0xb795cb90>
36 06/18/09 19:59:23.661 listening node <0xb795cb90>
36 06/18/09 19:59:23.661 BASIC TYPE: Static Controller <0xb795cb90>
36 06/18/09 19:59:23.661 GENERIC TYPE: Static Controller <0xb795cb90>
36 06/18/09 19:59:23.661 SPECIFIC TYPE: 0x1 <0xb795cb90>
36 06/18/09 19:59:23.661 Finished building node list: <0xb795cb90>
36 06/18/09 19:59:23.661 Node: 2 basic: 0x1 generic: 0x12 specific: 0x0 pluto: 0 <0xb795cb90>
36 06/18/09 19:59:23.661 Node: 4 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.661 Node: 5 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.661 Node: 6 basic: 0x2 generic: 0x2 specific: 0x1 pluto: 0 <0xb795cb90>
36 06/18/09 19:59:23.661 Node: 8 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.661 Node: 10 basic: 0x1 generic: 0x12 specific: 0x0 pluto: 0 <0xb795cb90>
36 06/18/09 19:59:23.661 Node: 12 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.661 Node: 15 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 16 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 17 basic: 0x4 generic: 0x10 specific: 0x1 pluto: 37 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 23 basic: 0x1 generic: 0x12 specific: 0x0 pluto: 0 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 29 basic: 0x1 generic: 0x12 specific: 0x0 pluto: 0 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 30 basic: 0x1 generic: 0x12 specific: 0x0 pluto: 0 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 31 basic: 0x1 generic: 0x12 specific: 0x0 pluto: 0 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 32 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 33 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 34 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 35 basic: 0x4 generic: 0x10 specific: 0x1 pluto: 37 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 36 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 37 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 38 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 39 basic: 0x4 generic: 0x11 specific: 0x1 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 40 basic: 0x3 generic: 0x11 specific: 0x0 pluto: 38 <0xb795cb90>
36 06/18/09 19:59:23.662 Node: 41 basic: 0x2 generic: 0x2 specific: 0x1 pluto: 0 <0xb795cb90>

And I thought I had seen the weirdest part. It now turns out that when I try to turn a light on (using web interface) that nothing happens at all. It may have to do with my manually adding the zwave stick (see a few posts above). The command does NOT get logged!

Strange stuff, I tell you....

hari

  • Administrator
  • LinuxMCE God
  • *****
  • Posts: 2421
    • View Profile
    • ago control
Re: ZWave USB serial problem
« Reply #14 on: June 19, 2009, 03:30:40 am »
did you quick reload after the download config? lmce needs a reload for the freshly created childs to become active..

br
rock your home - http://www.agocontrol.com home automation