Brand new Vera controller
-
@korttoma I am not sure what device 8 is. The MySensors device is 5 if I am reading this correctly:
I am assuming that this is what you are referring to when you say "Your installation is not complete" :
That was in the beginning, but if you notice it says "still no device is connected". I am sure that is why it says it is not complete. Here is the current status from the dashboard:
I am beginning to wondering if I shouldn't do a factory reset and start over. I think before I do that I am going to use the "COntact Customer Care" button.
@dbemowsk Seems like the GET_LANG system error is not related to MySensors then. What else have you installed? Can you find this Device 8?
Contacting Customer Care is a good idea but then you have to be patient because it can take a days before you get any answer and if you have not enabled the remote access and sent them the code they will just ask you to do this in their first answer and then you might have to wait for days again.
Also take a look at the thread @blacey mentioned about how you could check that the plugin files are correct.
-
I found this in the Vera forums:
The GET_LANG(system_error,System error) is a small displaying error caused by our language tool that failed to import this language token.
Regarding "Fail to load implementation file" issue, due to an old bug that we fixed recently, this message was not displayed. It appears when the implementation file for a device is not found on the gateway of the device parameters are wrong specified. This can be caused by manually created device from what I could see after debugging some units with this issue. To fix this issue you will need to delete the device that is showing the error like this :Code: [Select]
http://gateway_address:3480/data_request?id=device&action=delete&device=device_id -
@r-nox What should the lib version be?
So just to rule out other things that I may have done when trying to install some other apps, which by the way may have caused the error with device 8, I did a factory reset of the device and ran through the setup one more time. With the reset I was upgraded to a newer firmware version (1.7.2414). I re-uploaded the arduino files and created the device using the instructions on the MySensors website under the Vera controller. One thing I found curious is that when creating the device, the only thing it says to fill in on the "Create Device" page is the "Upnp Device FIlename". I was surprised that I didn't have to fill in any of the other fields such as the "Device Type" or the "Upnp Implementation Filename" . Again the device was created, and I configured the serial port as follows:
When I go to devices, things look the same as before. Here are the current screen shots:
-
Hi @dbemowsk
You setup stil looked different from mine so I decided to wipe my VeraLite clean and see what I get.
Now my setup looks exactly like yours except I did get the Lib version ( witch should show the Library version used in your MySensors Gateway ) efter hitting the reset button on my GW arduino and restart the Luup engine a few times.
Then when I press the "Start" button I get the text bellow the buttons like this:
As I then restart a Sensor node the number count up according to the devices found and when I know it has fund them all I press "Stop". Then the luup engine restarts automatically and the new devices are created.
I hit ctrl + F5 to refresh my browser and then go to devises and find this:
So I think your system is fine, you just need to restart the GW and run a few luup restarts and refresh your browser. Then try including a Sensor.
- Tomas
-
Hi @dbemowsk
You setup stil looked different from mine so I decided to wipe my VeraLite clean and see what I get.
Now my setup looks exactly like yours except I did get the Lib version ( witch should show the Library version used in your MySensors Gateway ) efter hitting the reset button on my GW arduino and restart the Luup engine a few times.
Then when I press the "Start" button I get the text bellow the buttons like this:
As I then restart a Sensor node the number count up according to the devices found and when I know it has fund them all I press "Stop". Then the luup engine restarts automatically and the new devices are created.
I hit ctrl + F5 to refresh my browser and then go to devises and find this:
So I think your system is fine, you just need to restart the GW and run a few luup restarts and refresh your browser. Then try including a Sensor.
@korttoma Is there any kind of command line serial monitor that I can use on the Vera to test my gateway communication coming into it? If not, that may be something for them to include on the unit. I double checked my wiring from my USB FTDI adapter to the gateway last night and I have my 3 wires as follows:
FTDI.......GW
GND ----GND
TX --------- RX
RX --------- TXI tried hitting the reset button on the gateway a number of times and restarted the luup engine a few times and also rebooted the Vera a few times. That is why I want to test that the Vera is receiving data from the FTDI properly.
I am betting that it is something that I am doing wrong, and I am going to kick myself in the arse when I figure out what it is.
-
You can see the vera log file if you enter this adress in your browser
http://<YourVeraIP>/cgi-bin/cmh/log.sh?Device=LuaUPnP -
@korttoma Is there any kind of command line serial monitor that I can use on the Vera to test my gateway communication coming into it? If not, that may be something for them to include on the unit. I double checked my wiring from my USB FTDI adapter to the gateway last night and I have my 3 wires as follows:
FTDI.......GW
GND ----GND
TX --------- RX
RX --------- TXI tried hitting the reset button on the gateway a number of times and restarted the luup engine a few times and also rebooted the Vera a few times. That is why I want to test that the Vera is receiving data from the FTDI properly.
I am betting that it is something that I am doing wrong, and I am going to kick myself in the arse when I figure out what it is.
-
Check out this tool if you don't know about it already.
https://www.mysensors.org/controller/myscontroller@jlieffort I know about this tool, but this will not help. I need to debug the serial connection from my gateway to my Vera controller. This is a Windows based tool.
-
OK, I have an update with some log information, thanks @korttoma for the link. This is a snipet of the log:
50 12/22/16 6:06:48.240 luup_log:9: Arduino: Requesting status for: 20;3 <0x74229520> 50 12/22/16 6:06:49.270 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=0,pt=7,l=5,sg=0:19.44 <0x74229520> 50 12/22/16 6:06:49.274 luup_log:9: Arduino: Set variable: 20;0;1;0;0;19.44 <0x74229520> 50 12/22/16 6:06:49.279 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=44,pt=7,l=5,sg=0:18.89 <0x74229520> 50 12/22/16 6:06:49.280 luup_log:9: Arduino: Set variable: 20;0;1;0;44;18.89 <0x74229520> 50 12/22/16 6:06:49.297 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=45,pt=7,l=5,sg=0:18.89 <0x74229520> 50 12/22/16 6:06:49.298 luup_log:9: Arduino: Set variable: 20;0;1;0;45;18.89 <0x74229520> 50 12/22/16 6:06:49.305 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=44,pt=7,l=5,sg=0:27.22 <0x74229520> 50 12/22/16 6:06:49.306 luup_log:9: Arduino: Set variable: 20;0;1;0;44;27.22 <0x74229520> 50 12/22/16 6:06:49.857 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=2,c=2,t=47,pt=0,l=0,sg=0: <0x74229520> 50 12/22/16 6:06:49.858 luup_log:9: Arduino: Request: 20;2;2;0;47; <0x74229520> 50 12/22/16 6:06:49.859 luup_log:9: Arduino: Requesting status for: 20;2 <0x74229520> 50 12/22/16 6:06:51.416 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=3,c=2,t=47,pt=0,l=0,sg=0: <0x74229520> 50 12/22/16 6:06:51.417 luup_log:9: Arduino: Request: 20;3;2;0;47; <0x74229520> 50 12/22/16 6:06:51.417 luup_log:9: Arduino: Requesting status for: 20;3 <0x74229520> 50 12/22/16 6:06:52.445 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=0,pt=7,l=5,sg=0:19.44 <0x74229520> 50 12/22/16 6:06:52.447 luup_log:9: Arduino: Set variable: 20;0;1;0;0;19.44 <0x74229520> 50 12/22/16 6:06:52.496 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=45,pt=7,l=5,sg=0:18.89 <0x74229520> 50 12/22/16 6:06:52.497 luup_log:9: Arduino: Set variable: 20;0;1;0;45;18.89 <0x74229520> 50 12/22/16 6:06:53.090 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=2,c=2,t=47,pt=0,l=0,sg=0: <0x74229520> 50 12/22/16 6:06:53.091 luup_log:9: Arduino: Request: 20;2;2;0;47; <0x74229520> 50 12/22/16 6:06:53.091 luup_log:9: Arduino: Requesting status for: 20;2 <0x74229520> 50 12/22/16 6:06:54.657 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=3,c=2,t=47,pt=0,l=0,sg=0: <0x74229520> 50 12/22/16 6:06:54.657 luup_log:9: Arduino: Request: 20;3;2;0;47; <0x74229520> 50 12/22/16 6:06:54.658 luup_log:9: Arduino: Requesting status for: 20;3 <0x74229520> 50 12/22/16 6:06:55.160 luup_log:9: Arduino: Log: TSP:MSG:READ 255-255-255 s=255,c=3,t=7,pt=0,l=0,sg=0: <0x74229520> 50 12/22/16 6:06:55.161 luup_log:9: Arduino: Log: TSP:MSG:BC <0x74229520> 50 12/22/16 6:06:55.164 luup_log:9: Arduino: Log: TSP:MSG:FPAR REQ (sender=255) <0x74229520> 50 12/22/16 6:06:55.165 luup_log:9: Arduino: Log: TSP:CHKUPL:OK <0x74229520> 50 12/22/16 6:06:55.167 luup_log:9: Arduino: Log: TSP:MSG:GWL OK <0x74229520> 50 12/22/16 6:06:55.750 luup_log:9: Arduino: Log: TSP:MSG:SEND 0-0-255-255 s=255,c=3,t=8,pt=1,l=1,sg=0,ft=0,st=bc:0 <0x74229520> 50 12/22/16 6:06:55.758 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=0,pt=7,l=5,sg=0:19.44 <0x74229520> 50 12/22/16 6:06:55.761 luup_log:9: Arduino: Set variable: 20;0;1;0;0;19.44 <0x74229520> 50 12/22/16 6:06:55.764 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=44,pt=7,l=5,sg=0:18.89 <0x74229520> 50 12/22/16 6:06:55.765 luup_log:9: Arduino: Set variable: 20;0;1;0;44;18.89 <0x74229520> 50 12/22/16 6:06:56.348 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=2,c=2,t=47,pt=0,l=0,sg=0: <0x74229520> 50 12/22/16 6:06:56.349 luup_log:9: Arduino: Request: 20;2;2;0;47; <0x74229520> 50 12/22/16 6:06:56.350 luup_log:9: Arduino: Requesting status for: 20;2 <0x74229520> 50 12/22/16 6:06:57.178 luup_log:9: Arduino: Log: TSP:MSG:READ 255-255-255 s=255,c=3,t=7,pt=0,l=0,sg=0: <0x74229520> 50 12/22/16 6:06:57.180 luup_log:9: Arduino: Log: TSP:MSG:BC <0x74229520> 50 12/22/16 6:06:57.186 luup_log:9: Arduino: Log: TSP:MSG:FPAR REQ (sender=255) <0x74229520> 50 12/22/16 6:06:57.188 luup_log:9: Arduino: Log: TSP:CHKUPL:OK (FLDCTRL) <0x74229520> 50 12/22/16 6:06:57.189 luup_log:9: Arduino: Log: TSP:MSG:GWL OK <0x74229520> 50 12/22/16 6:06:57.735 luup_log:9: Arduino: Log: TSP:MSG:SEND 0-0-255-255 s=255,c=3,t=8,pt=1,l=1,sg=0,ft=0,st=bc:0 <0x74229520> 50 12/22/16 6:06:57.920 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=3,c=2,t=47,pt=0,l=0,sg=0: <0x74229520> 50 12/22/16 6:06:57.920 luup_log:9: Arduino: Request: 20;3;2;0;47; <0x74229520> 50 12/22/16 6:06:57.921 luup_log:9: Arduino: Requesting status for: 20;3 <0x74229520> 50 12/22/16 6:06:58.941 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=0,pt=7,l=5,sg=0:19.44 <0x74229520> 50 12/22/16 6:06:58.943 luup_log:9: Arduino: Set variable: 20;0;1;0;0;19.44 <0x74229520> 50 12/22/16 6:06:58.961 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=44,pt=7,l=5,sg=0:18.89 <0x74229520> 50 12/22/16 6:06:58.962 luup_log:9: Arduino: Set variable: 20;0;1;0;44;18.89 <0x74229520> 50 12/22/16 6:06:58.973 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=45,pt=7,l=5,sg=0:18.89To me that looks like the gateway is receiving data. As I scanned through the log though, I noticed this:
01 12/22/16 4:29:02.122 UserData::WriteUserData saved--before move File Size: 4541 save size 4541 <0x77229520> 02 12/22/16 4:29:02.122 UserData::TempLogFileSystemFailure start 0 <0x77229520> 02 12/22/16 4:29:02.140 UserData::TempLogFileSystemFailure 4287 res:1 -rw-r--r-- 1 root root 33 Dec 20 16:30 /etc/cmh/HW_Key -rw-r--r-- 1 root root 32 Dec 31 1999 /etc/cmh/HW_Key2 -rw-r--r-- 1 root root 9 Dec 20 16:30 /etc/cmh/PK_AccessPoint -rw-r--r-- 1 root root 7 Dec 20 17:14 /etc/cmh/PK_Account -rw-r--r-- 1 root root 425 Dec 21 01:29 /etc/cmh/cmh.conf -rw-r--r-- 1 root root 0 Aug 22 08:36 /etc/cmh/devices -rw-r--r-- 1 root root 16383 Dec 21 03:00 /etc/cmh/dongle.4.5.dump.0 -rw-r--r-- 1 root root 41 Dec 20 16:21 /etc/cmh/ergy_key -rw-r--r-- 1 root root 0 Aug 22 08:36 /etc/cmh/first_boot -rw-r--r-- 1 root root 0 Dec 21 01:25 /etc/cmh/fresh_install -rw-r--r-- 1 root root 1 Dec 21 01:52 /etc/cmh/ip_mode -rw-r--r-- 1 root root 48 Dec 31 1999 /etc/cmh/keys -rw-r--r-- 1 root root 3 Dec 9 09:30 /etc/cmh/language -rw-r--r-- 1 root root 2 Dec 9 09:30 /etc/cmh/language_id -rw-r--r-- 1 root root 10 Dec 21 16:34 /etc/cmh/last_backup -rw-r--r-- 1 root root 11 Dec 22 01:52 /etc/cmh/last_report -rw-r--r-- 1 root root 70 Dec 20 16:36 /etc/cmh/lighttpd_failures -rw-r--r-- 1 root root 36316 Oct 3 00:25 /etc/cmh/network_pnp.lua -rw-r--r-- 1 root root 12 Dec 9 09:30 /etc/cmh/platform -rw-r--r-- 1 root root 458 Oct 3 00:25 /etc/cmh/ra_key -rw-r--r-- 1 root root 0 Dec 9 09:30 /etc/cmh/scenarios -rw-r--r-- 1 root root 2032 Dec 20 16:30 /etc/cmh/servers.conf -rw-r--r-- 1 root root 1520 Aug 22 08:34 /etc/cmh/servers.conf.default -rw-r--r-- 1 root root 20 Dec 20 16:35 /etc/cmh/servers.conf.timestamp -rw-r--r-- 1 root root 154 Oct 3 00:25 /etc/cmh/servers_whitelist -rw-r--r-- 1 root root 1598 Dec 22 01:52 /etc/cmh/services.conf -rw-r--r-- 1 root root 20 Dec 20 16:19 /etc/cmh/sync_kit -rw-r--r-- 1 root root 20 Dec 20 16:19 /etc/cmh/sync_rediscover -rw-r--r-- 1 root root 2 Dec 9 09:30 /etc/cmh/ui -rw-r--r-- 1 root root 2 Dec 9 09:30 /etc/cmh/ui_man -rw-r--r-- 1 root root 5 Dec 9 09:30 /etc/cmh/ui_skin -rw-r--r-- 1 root root 504 Jul 22 09:31 /etc/cmh/user_data.json.luup.lzo -rw-r--r-- 1 root root 4541 Dec 22 02:41 /etc/cmh/user_data.json.lzo -rw-r--r-- 1 root root 4540 Dec 22 02:05 /etc/cmh/user_data.json.lzo.1 -rw-r--r-- 1 root root 4540 Dec 21 23:17 /etc/cmh/user_data.json.lzo.2 -rw-r--r-- 1 root root 4541 Dec 21 21:53 /etc/cmh/user_data.json.lzo.3 -rw-r--r-- 1 root root 4547 Dec 21 21:23 /etc/cmh/user_data.json.lzo.4 -rw-r--r-- 1 root root 4544 Dec 21 17:05 /etc/cmh/user_data.json.lzo.5 -rw-r--r-- 1 root root 4541 Dec 22 04:29 /etc/cmh/user_data.json.lzo.new -rw-r--r-- 1 root root 21 Dec 20 17:14 /etc/cmh/users.conf -rw-r--r-- 1 root root 20 Dec 20 17:14 /etc/cmh/users.conf.timestamp -rw-r--r-- 1 root root 3 Aug 22 08:36 /etc/cmh/vera_model -rw-r--r-- 1 root root 9 Dec 9 09:30 /etc/cmh/version -rw-r--r-- 1 root root 9 Dec 21 21:24 /etc/cmh/version_latest -rw-r--r-- 1 root root 5 Dec 31 1999 /etc/cmh/zigbee_version -rw-r--r-- 1 root root 8 Dec 22 04:17 /etc/cmh/zwave_house_id -rw-r--r-- 1 root root 3 Dec 31 1999 /etc/cmh/zwave_locale -rw-r--r-- 1 root root 48 Dec 21 01:56 /etc/cmh/zwave_version /etc/cmh/orig: -rw-r--r-- 1 root root 0 Dec 9 09:30 devices -rw-r--r-- 1 root root 0 Dec 9 09:30 first_boot -rw-r--r-- 1 root root 0 Dec 9 09:30 fresh_install -rw-r--r-- 1 root root 0 Dec 9 09:30 scenarios -rw-r--r-- 1 root root 520 Dec 9 09:30 user_data.json.lzo /etc/cmh/wan_failover: -rw-r--r-- 1 root root 44 Jul 22 09:31 check_internet.hosts <0x77229520> 02 12/22/16 4:29:02.204 UserData::TempLogFileSystemFailure start 0 <0x77229520> 02 12/22/16 4:29:02.223 UserData::TempLogFileSystemFailure 4198 res:1 -rw-r--r-- 1 root root 33 Dec 20 16:30 /etc/cmh/HW_Key -rw-r--r-- 1 root root 32 Dec 31 1999 /etc/cmh/HW_Key2 -rw-r--r-- 1 root root 9 Dec 20 16:30 /etc/cmh/PK_AccessPoint -rw-r--r-- 1 root root 7 Dec 20 17:14 /etc/cmh/PK_Account -rw-r--r-- 1 root root 425 Dec 21 01:29 /etc/cmh/cmh.conf -rw-r--r-- 1 root root 0 Aug 22 08:36 /etc/cmh/devices -rw-r--r-- 1 root root 16383 Dec 21 03:00 /etc/cmh/dongle.4.5.dump.0 -rw-r--r-- 1 root root 41 Dec 20 16:21 /etc/cmh/ergy_key -rw-r--r-- 1 root root 0 Aug 22 08:36 /etc/cmh/first_boot -rw-r--r-- 1 root root 0 Dec 21 01:25 /etc/cmh/fresh_install -rw-r--r-- 1 root root 1 Dec 21 01:52 /etc/cmh/ip_mode -rw-r--r-- 1 root root 48 Dec 31 1999 /etc/cmh/keys -rw-r--r-- 1 root root 3 Dec 9 09:30 /etc/cmh/language -rw-r--r-- 1 root root 2 Dec 9 09:30 /etc/cmh/language_id -rw-r--r-- 1 root root 10 Dec 21 16:34 /etc/cmh/last_backup -rw-r--r-- 1 root root 11 Dec 22 01:52 /etc/cmh/last_report -rw-r--r-- 1 root root 70 Dec 20 16:36 /etc/cmh/lighttpd_failures -rw-r--r-- 1 root root 36316 Oct 3 00:25 /etc/cmh/network_pnp.lua -rw-r--r-- 1 root root 12 Dec 9 09:30 /etc/cmh/platform -rw-r--r-- 1 root root 458 Oct 3 00:25 /etc/cmh/ra_key -rw-r--r-- 1 root root 0 Dec 9 09:30 /etc/cmh/scenarios -rw-r--r-- 1 root root 2032 Dec 20 16:30 /etc/cmh/servers.conf -rw-r--r-- 1 root root 1520 Aug 22 08:34 /etc/cmh/servers.conf.default -rw-r--r-- 1 root root 20 Dec 20 16:35 /etc/cmh/servers.conf.timestamp -rw-r--r-- 1 root root 154 Oct 3 00:25 /etc/cmh/servers_whitelist -rw-r--r-- 1 root root 1598 Dec 22 01:52 /etc/cmh/services.conf -rw-r--r-- 1 root root 20 Dec 20 16:19 /etc/cmh/sync_kit -rw-r--r-- 1 root root 20 Dec 20 16:19 /etc/cmh/sync_rediscover -rw-r--r-- 1 root root 2 Dec 9 09:30 /etc/cmh/ui -rw-r--r-- 1 root root 2 Dec 9 09:30 /etc/cmh/ui_man -rw-r--r-- 1 root root 5 Dec 9 09:30 /etc/cmh/ui_skin -rw-r--r-- 1 root root 504 Jul 22 09:31 /etc/cmh/user_data.json.luup.lzo -rw-r--r-- 1 root root 4541 Dec 22 04:29 /etc/cmh/user_data.json.lzo -rw-r--r-- 1 root root 4541 Dec 22 02:41 /etc/cmh/user_data.json.lzo.1 -rw-r--r-- 1 root root 4540 Dec 22 02:05 /etc/cmh/user_data.json.lzo.2 -rw-r--r-- 1 root root 4540 Dec 21 23:17 /etc/cmh/user_data.json.lzo.3 -rw-r--r-- 1 root root 4541 Dec 21 21:53 /etc/cmh/user_data.json.lzo.4 -rw-r--r-- 1 root root 4547 Dec 21 21:23 /etc/cmh/user_data.json.lzo.5 -rw-r--r-- 1 root root 21 Dec 20 17:14 /etc/cmh/users.conf -rw-r--r-- 1 root root 20 Dec 20 17:14 /etc/cmh/users.conf.timestamp -rw-r--r-- 1 root root 3 Aug 22 08:36 /etc/cmh/vera_model -rw-r--r-- 1 root root 9 Dec 9 09:30 /etc/cmh/version -rw-r--r-- 1 root root 9 Dec 21 21:24 /etc/cmh/version_latest -rw-r--r-- 1 root root 5 Dec 31 1999 /etc/cmh/zigbee_version -rw-r--r-- 1 root root 8 Dec 22 04:17 /etc/cmh/zwave_house_id -rw-r--r-- 1 root root 3 Dec 31 1999 /etc/cmh/zwave_locale -rw-r--r-- 1 root root 48 Dec 21 01:56 /etc/cmh/zwave_version /etc/cmh/orig: -rw-r--r-- 1 root root 0 Dec 9 09:30 devices -rw-r--r-- 1 root root 0 Dec 9 09:30 first_boot -rw-r--r-- 1 root root 0 Dec 9 09:30 fresh_install -rw-r--r-- 1 root root 0 Dec 9 09:30 scenarios -rw-r--r-- 1 root root 520 Dec 9 09:30 user_data.json.lzo /etc/cmh/wan_failover: -rw-r--r-- 1 root root 44 Jul 22 09:31 check_internet.hosts <0x77229520>The things that say TempLogFileSystemFailure are a bit of a red flag for me.
Also, here is a log of what happens when I hit the start button to start inclusion.
50 12/22/16 6:12:44.804 luup_log:9: Arduino: Requesting status for: 20;2 <0x74229520> 08 12/22/16 6:12:45.587 JobHandler_LuaUPnP::HandleActionRequest device: 9 service: urn:upnp-arduino-cc:serviceId:arduino1 action: StartInclusion <0x75429520> 08 12/22/16 6:12:45.588 JobHandler_LuaUPnP::HandleActionRequest argument DeviceNum=9 <0x75429520> 08 12/22/16 6:12:45.588 JobHandler_LuaUPnP::HandleActionRequest argument serviceId=urn:upnp-arduino-cc:serviceId:arduino1 <0x75429520> 08 12/22/16 6:12:45.588 JobHandler_LuaUPnP::HandleActionRequest argument action=StartInclusion <0x75429520> 50 12/22/16 6:12:45.590 luup_log:9: Arduino: Sending: 0;0;3;0;5;1 <0x77bf1320> 04 12/22/16 6:12:45.593 <0x77bf1320> 50 12/22/16 6:12:46.361 luup_log:9: Arduino: Log: TSP:MSG:READ 20-20-0 s=3,c=2,t=47,pt=0,l=0,sg=0: <0x74229520>It looks as if inclusion mode is starting, but nothing is happening.
Maybe one of you has some insight as to what all of this information means.
-
I am leaving for work in a few minutes, but if I don't hear something by the time I get off work, I am going to call tech support. I REALLY appreciate the help everyone has given.
Vera Plus running UI7 with MySensors, Sonoffs and 1-Wire devices
Visit my website for more Bits, Bytes and Ramblings from me: http://dan.bemowski.info/ -
I am leaving for work in a few minutes, but if I don't hear something by the time I get off work, I am going to call tech support. I REALLY appreciate the help everyone has given.
Hi @dbemowsk ,
I wish I could do more to help you. I took a look at the log in my test environment and I found that I also have this:
TempLogFileSystemFailureMaybe this is something that is printed each time the device restarts?? Let me know if Vera support gives you any explanation for it.
But the MySensors Part seems to work fine for me:
Here the USB port gets connected and Vera receives the Lib version of the GW:
50 12/23/16 7:51:43.454 luup_log:5: Arduino: Trying for a serial connection <0x2bf65680> 50 12/23/16 7:51:43.454 luup_log:5: Arduino: Serial port is connected <0x2bf65680> 50 12/23/16 7:51:43.455 luup_log:5: Arduino: Baud is 115200 <0x2bf65680> 50 12/23/16 7:51:43.456 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduino1,GWAddress, 4(115200), 5 <0x2bf65680> 06 12/23/16 7:51:43.456 Device_Variable::m_szValue_set device: 5 service: urn:upnp-arduino-cc:serviceId:arduino1 variable: GWAddress was: - now: 4(115200) #hooks: 0 upnp: 0 skip: 0 v:0xbcbed0/NONE duplicate:0 <0x2bf65680> 50 12/23/16 7:51:43.459 luup_log:5: Arduino: Sending: 0;0;3;0;2;Get Version <0x2bf65680> 50 12/23/16 7:51:43.471 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduino1,ArduinoLibVersion, 2.0.0, 5 <0x2d565680>Here is what it looks like when I start inclusion mode and find one device:
50 12/23/16 7:52:20.057 luup_log:5: Arduino: Sending: 0;0;3;0;5;1 <0x2b51c310> 04 12/23/16 7:52:20.059 <0x2b51c310> 50 12/23/16 7:52:20.070 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduino1,InclusionMode, 1, 5 <0x2d565680> 06 12/23/16 7:52:20.071 Device_Variable::m_szValue_set device: 5 service: urn:upnp-arduino-cc:serviceId:arduino1 variable: InclusionMode was: 0 now: 1 #hooks: 0 upnp: 0 skip: 0 v:0xbb2eb8/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:52:20.072 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduino1,InclusionFoundCountHR, 0 devices found, 5 <0x2d565680> 06 12/23/16 7:52:20.073 Device_Variable::m_szValue_set device: 5 service: urn:upnp-arduino-cc:serviceId:arduino1 variable: InclusionFoundCountHR was: now: 0 devices found #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:52:35.941 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-255 s=255,c=3,t=7,pt=0,l=0,sg=0: <0x2d565680> 50 12/23/16 7:52:35.950 luup_log:5: Arduino: Log: TSP:MSG:BC <0x2d565680> 50 12/23/16 7:52:35.952 luup_log:5: Arduino: Log: TSP:MSG:FPAR REQ (sender=3) <0x2d565680> 50 12/23/16 7:52:35.954 luup_log:5: Arduino: Log: TSP:CHKUPL:OK <0x2d565680> 50 12/23/16 7:52:35.955 luup_log:5: Arduino: Log: TSP:MSG:GWL OK <0x2d565680> 50 12/23/16 7:52:36.711 luup_log:5: Arduino: Log: TSP:MSG:SEND 0-0-3-3 s=255,c=3,t=8,pt=1,l=1,sg=0,ft=0,st=ok:0 <0x2d565680> 50 12/23/16 7:52:37.981 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=255,c=3,t=24,pt=1,l=1,sg=0:1 <0x2d565680> 50 12/23/16 7:52:37.991 luup_log:5: Arduino: Log: TSP:MSG:PINGED (ID=3, hops=1) <0x2d565680> 50 12/23/16 7:52:38.001 luup_log:5: Arduino: Log: TSP:MSG:SEND 0-0-3-3 s=255,c=3,t=25,pt=1,l=1,sg=0,ft=0,st=ok:1 <0x2d565680> 50 12/23/16 7:52:38.003 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=255,c=3,t=15,pt=6,l=2,sg=0:0100 <0x2d565680> 50 12/23/16 7:52:38.011 luup_log:5: Arduino: Log: TSP:MSG:SEND 0-0-3-3 s=255,c=3,t=15,pt=6,l=2,sg=0,ft=0,st=ok:0100 <0x2d565680> 50 12/23/16 7:52:38.021 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=255,c=0,t=17,pt=0,l=10,sg=0:2.0.1-beta <0x2d565680> 50 12/23/16 7:52:38.022 luup_log:5: Arduino: Presentation: 3;255;0;0;17;2.0.1-beta <0x2d565680> 50 12/23/16 7:52:38.025 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=255,c=3,t=6,pt=1,l=1,sg=0:0 <0x2d565680> 50 12/23/16 7:52:38.031 luup_log:5: Arduino: urn:micasaverde-com:serviceId:HaDevice1,LastUpdate, 1482472358, 7 <0x2d565680> 06 12/23/16 7:52:38.031 Device_Variable::m_szValue_set device: 7 service: urn:micasaverde-com:serviceId:HaDevice1 variable: LastUpdate was: 1482411882 now: 1482472358 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:52:38.033 luup_log:5: Arduino: urn:micasaverde-com:serviceId:HaDevice1,LastUpdateHR, 07:52, 7 <0x2d565680> 06 12/23/16 7:52:38.033 Device_Variable::m_szValue_set device: 7 service: urn:micasaverde-com:serviceId:HaDevice1 variable: LastUpdateHR was: 15:04 now: 07:52 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:52:38.034 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduinonode1,RelayNode, 0, 7 <0x2d565680> 50 12/23/16 7:52:38.035 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduinonode1,RelayNodeHR, GW, 7 <0x2d565680> 50 12/23/16 7:52:38.036 luup_log:5: Arduino: Sending: 3;255;3;0;6;M <0x2d565680> 50 12/23/16 7:52:38.061 luup_log:5: Arduino: Log: TSP:MSG:SEND 0-0-3-3 s=255,c=3,t=6,pt=0,l=1,sg=0,ft=0,st=ok:M <0x2d565680> 50 12/23/16 7:52:38.261 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=255,c=3,t=11,pt=0,l=7,sg=0:TempLux <0x2d565680> 50 12/23/16 7:52:38.263 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduinonode1,SketchName, TempLux, 7 <0x2d565680> 50 12/23/16 7:52:38.265 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=255,c=3,t=12,pt=0,l=3,sg=0:2.0 <0x2d565680> 50 12/23/16 7:52:38.270 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduinonode1,SketchVersion, 2.0, 7 <0x2d565680> 50 12/23/16 7:52:38.461 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=20,c=0,t=16,pt=0,l=0,sg=0: <0x2d565680> 50 12/23/16 7:52:38.462 luup_log:5: Arduino: Presentation: 3;20;0;0;16; <0x2d565680> 50 12/23/16 7:52:38.463 luup_log:5: Arduino: Found new device 3;20 <0x2d565680> 50 12/23/16 7:52:38.464 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduino1,InclusionFoundCountHR, 1 devices found, 5 <0x2d565680> 06 12/23/16 7:52:38.465 Device_Variable::m_szValue_set device: 5 service: urn:upnp-arduino-cc:serviceId:arduino1 variable: InclusionFoundCountHR was: 0 devices found now: 1 devices found #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:52:38.471 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=0,c=0,t=6,pt=0,l=0,sg=0: <0x2d565680> 50 12/23/16 7:52:38.472 luup_log:5: Arduino: Presentation: 3;0;0;0;6; <0x2d565680> 50 12/23/16 7:52:38.474 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=255,c=3,t=26,pt=1,l=1,sg=0:2 <0x2d565680> 50 12/23/16 7:52:38.521 luup_log:5: Arduino: Log: !TSP:MSG:SEND 0-0-3-3 s=255,c=3,t=27,pt=1,l=1,sg=0,ft=0,st=fail:1 <0x2d565680> 50 12/23/16 7:52:39.041 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=20,c=1,t=23,pt=2,l=2,sg=0:912 <0x2d565680> 50 12/23/16 7:52:39.042 luup_log:5: Arduino: Set variable: 3;20;1;0;23;912 <0x2d565680> 50 12/23/16 7:52:39.901 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=0,c=1,t=0,pt=7,l=5,sg=0:22.6 <0x2d565680> 50 12/23/16 7:52:39.902 luup_log:5: Arduino: Set variable: 3;0;1;0;0;22.6 <0x2d565680> 50 12/23/16 7:52:39.903 luup_log:5: Arduino: Setting variable 'CurrentTemperature' to value '22.6' <0x2d565680> 50 12/23/16 7:52:39.904 luup_log:5: Arduino: urn:upnp-org:serviceId:TemperatureSensor1,CurrentTemperature, 22.6, 6 <0x2d565680> 06 12/23/16 7:52:39.905 Device_Variable::m_szValue_set device: 6 service: urn:upnp-org:serviceId:TemperatureSensor1 variable: CurrentTemperature was: 23.1 now: 22.6 #hooks: 0 upnp: 0 skip: 0 v:0xbcdf98/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:52:39.906 luup_log:5: Arduino: urn:micasaverde-com:serviceId:HaDevice1,LastUpdate, 1482472359, 6 <0x2d565680> 06 12/23/16 7:52:39.906 Device_Variable::m_szValue_set device: 6 service: urn:micasaverde-com:serviceId:HaDevice1 variable: LastUpdate was: 1482411882 now: 1482472359 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:52:39.907 luup_log:5: Arduino: urn:micasaverde-com:serviceId:HaDevice1,LastUpdate, 1482472359, 7 <0x2d565680> 06 12/23/16 7:52:39.908 Device_Variable::m_szValue_set device: 7 service: urn:micasaverde-com:serviceId:HaDevice1 variable: LastUpdate was: 1482472358 now: 1482472359 #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:52:39.909 luup_log:5: Arduino: urn:micasaverde-com:serviceId:HaDevice1,LastUpdateHR, 07:52, 7 <0x2d565680> 08 12/23/16 7:53:00.180 JobHandler_LuaUPnP::HandleActionRequest device: 0 service: urn:micasaverde-com:serviceId:HomeAutomationGateway1 action: LogIpRequest <0x2e565680> 08 12/23/16 7:53:00.181 JobHandler_LuaUPnP::HandleActionRequest argument serviceId=urn:micasaverde-com:serviceId:HomeAutomationGateway1 <0x2e565680> 08 12/23/16 7:53:00.181 JobHandler_LuaUPnP::HandleActionRequest argument action=LogIpRequest <0x2e565680> 08 12/23/16 7:53:00.182 JobHandler_LuaUPnP::HandleActionRequest argument IpAddress=192.168.1.6 <0x2e565680> 08 12/23/16 7:53:00.182 JobHandler_LuaUPnP::HandleActionRequest argument MacAddress=e0:5f:45:12:68:73 <0x2e565680> 08 12/23/16 7:53:03.507 JobHandler_LuaUPnP::HandleActionRequest device: 5 service: urn:upnp-arduino-cc:serviceId:arduino1 action: StopInclusion <0x2e565680> 08 12/23/16 7:53:03.507 JobHandler_LuaUPnP::HandleActionRequest argument DeviceNum=5 <0x2e565680> 08 12/23/16 7:53:03.508 JobHandler_LuaUPnP::HandleActionRequest argument serviceId=urn:upnp-arduino-cc:serviceId:arduino1 <0x2e565680> 08 12/23/16 7:53:03.508 JobHandler_LuaUPnP::HandleActionRequest argument action=StopInclusion <0x2e565680> 50 12/23/16 7:53:03.510 luup_log:5: Arduino: Sending: 0;0;3;0;5;0 <0x2b51c310> 04 12/23/16 7:53:03.512 <0x2b51c310> 50 12/23/16 7:53:03.521 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduino1,InclusionMode, 0, 5 <0x2d565680> 06 12/23/16 7:53:03.521 Device_Variable::m_szValue_set device: 5 service: urn:upnp-arduino-cc:serviceId:arduino1 variable: InclusionMode was: 1 now: 0 #hooks: 0 upnp: 0 skip: 0 v:0xbb2eb8/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:53:03.522 luup_log:5: Arduino: urn:upnp-arduino-cc:serviceId:arduino1,InclusionFoundCountHR, , 5 <0x2d565680> 06 12/23/16 7:53:03.523 Device_Variable::m_szValue_set device: 5 service: urn:upnp-arduino-cc:serviceId:arduino1 variable: InclusionFoundCountHR was: 1 devices found now: #hooks: 0 upnp: 0 skip: 0 v:(nil)/NONE duplicate:0 <0x2d565680> 50 12/23/16 7:53:03.524 luup_log:5: Arduino: Inclusion mode ended. <0x2d565680> 02 12/23/16 7:53:03.525 luup_log:5: Arduino: Found new sensor(s). Need to restart. Please wait. <0x2d565680> 09 12/23/16 7:53:03.528 Child_Devices::ProcessChildDevice created device 10 id 3;20 under 5 topmost parent 5 <0x2d565680>Here is what it looks like when the device receives a value:
50 12/23/16 7:54:15.122 luup_log:5: Arduino: Log: TSP:SANCHK:OK <0x2e07b680> 50 12/23/16 7:54:52.352 luup_log:5: Arduino: Log: TSP:MSG:READ 3-3-0 s=20,c=1,t=23,pt=2,l=2,sg=0:913 <0x2e07b680> 50 12/23/16 7:54:52.354 luup_log:5: Arduino: Set variable: 3;20;1;0;23;913 <0x2e07b680> 50 12/23/16 7:54:52.354 luup_log:5: Arduino: Setting variable 'CurrentLevel' to value '913' <0x2e07b680> 50 12/23/16 7:54:52.355 luup_log:5: Arduino: urn:micasaverde-com:serviceId:LightSensor1,CurrentLevel, 913, 10 <0x2e07b680> 06 12/23/16 7:54:52.356 Device_Variable::m_szValue_set device: 10 service: urn:micasaverde-com:serviceId:LightSensor1 variable: CurrentLevel was: EMPTY now: 913 #hooks: 0 upnp: 0 skip: 0 v:0x911d88/NONE duplicate:0 <0x2e07b680> 50 12/23/16 7:54:52.357 luup_log:5: Arduino: urn:micasaverde-com:serviceId:HaDevice1,LastUpdate, 1482472492, 10 <0x2e07b680> -
I placed a call to Vera yesterday The lady that I spoke with wasn't able to get anywhere and suggested that I email support@getvera.com and to leave remote assistance on. I referenced this thread in the email. Hopefully they will get back to me sometime today.
-
Another thing. Last night I decided that I would try getting some of my X10 stuff going with the Mochad X10 Gateway plugin. I seem to be having trouble with that too. I thought I would then just uninstall the plugin and wait for the Vera team to do their thing today, but it won't let me uninstall the plugin now. I click uninstall, it asks if I am sure I want to uninstall, I say yes, the green spinner comes up for about 10 seconds and then it says "Error uninstalling app, please try again".
I have owned this box for going on a week now and I don't have anything running on it yet.
-
Can anyone tell me what this means? Specifically the lines that end in "discarded for child: nil". In the Vera log, these lines show in yellow.
50 12/25/16 23:01:50.974 luup_log:10: Arduino: Log: TSP:MSG:READ 4-4-0 s=255,c=3,t=6,pt=1,l=1,sg=0:0 <0x7438f520> 02 12/25/16 23:01:50.975 luup_log:10: Arduino: Incoming internal command '4;255;3;0;6;0' discarded for child: nil <0x7438f520> 50 12/25/16 23:01:51.692 luup_log:10: Arduino: Log: TSP:MSG:READ 20-20-0 s=3,c=2,t=47,pt=0,l=0,sg=0: <0x7438f520> 50 12/25/16 23:01:51.693 luup_log:10: Arduino: Request: 20;3;2;0;47; <0x7438f520> 50 12/25/16 23:01:51.693 luup_log:10: Arduino: Requesting status for: 20;3 <0x7438f520> 50 12/25/16 23:01:52.728 luup_log:10: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=0,pt=7,l=5,sg=0:21.11 <0x7438f520> 50 12/25/16 23:01:52.729 luup_log:10: Arduino: Set variable: 20;0;1;0;0;21.11 <0x7438f520> 50 12/25/16 23:01:52.735 luup_log:10: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=44,pt=7,l=5,sg=0:21.11 <0x7438f520> 50 12/25/16 23:01:52.738 luup_log:10: Arduino: Set variable: 20;0;1;0;44;21.11 <0x7438f520> 50 12/25/16 23:01:52.743 luup_log:10: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=45,pt=7,l=5,sg=0:21.11 <0x7438f520> 50 12/25/16 23:01:52.747 luup_log:10: Arduino: Set variable: 20;0;1;0;45;21.11 <0x7438f520> 50 12/25/16 23:01:52.763 luup_log:10: Arduino: Log: TSP:MSG:READ 20-20-0 s=0,c=1,t=44,pt=7,l=5,sg=0:27.22 <0x7438f520> 50 12/25/16 23:01:52.765 luup_log:10: Arduino: Set variable: 20;0;1;0;44;27.22 <0x7438f520> 50 12/25/16 23:01:52.966 luup_log:10: Arduino: Log: TSP:MSG:READ 4-4-0 s=255,c=3,t=11,pt=0,l=12,sg=0:MyGarageDoor <0x7438f520> 02 12/25/16 23:01:52.968 luup_log:10: Arduino: Incoming internal command '4;255;3;0;11;MyGarageDoor' discarded for child: nil <0x7438f520> 50 12/25/16 23:01:52.976 luup_log:10: Arduino: Log: TSP:MSG:READ 4-4-0 s=255,c=3,t=12,pt=0,l=3,sg=0:1.2 <0x7438f520> 02 12/25/16 23:01:52.977 luup_log:10: Arduino: Incoming internal command '4;255;3;0;12;1.2' discarded for child: nil <0x7438f520> 50 12/25/16 23:01:52.980 luup_log:10: Arduino: Log: TSP:MSG:READ 4-4-0 s=0,c=0,t=3,pt=0,l=0,sg=0: <0x7438f520> -
So I got a response from Vera on my issue. Here was their response:
I’ve checked your unit and the Arduino is flooding the Vera in a such way that it is crashing the engine. There is a configuration on the Arduino that is flooding the Vera unit or maybe there is an issue with the Arduino directly. Can’t tell for sure.
CUT some log info CUT
If you remove the Arduino from the Vera, the engine will stop flooding and you will be able to access it the Vera unit and check it.
Once you do that and check the configuration of the Arduino and also check to see if everything is alright with it, you will be able to plug it back in and the engine should not crash anymore and you shall be able to use the MySensor.
With the configuration of the sensor you will need to check with MySensor directly as they have this information.
Anyways, so I found that I had my thermostat bridge updating too often which was what was causing the supposed flooding. The bridge worked fine with Domoticz, so I really don't think that was the issue, though I could tone down the updates from it. I am not sure how he determined that it was crashing the engine, but for now I have the bridge disconnected and not flooding the gateway, and I still cannot add sensors.
Any help that anyone can provide would be GREATLY appreciated. I have had the unit for over a week now and cannot add my MySensors devices.
One good thing though, I did finally resolve the issue with my 1-wire server and I at least have my temp sensors online.
Thanks guys
-
Sorry I could not assist you during the holidays, I took a brake from tinkering and spent time with the family.
I saw that you managed to narrow down the Vera MySensors issue to the FTDI adapter in the other thread.Just thought I would add the link to this in case someone else experiences the same problem, although it seems quite rare that this happens since you are the only one we know of so far.
Lets hope your continued use of MySensors in Vera is smooth sailing from now on.
- Tomas
-
Sorry I could not assist you during the holidays, I took a brake from tinkering and spent time with the family.
I saw that you managed to narrow down the Vera MySensors issue to the FTDI adapter in the other thread.Just thought I would add the link to this in case someone else experiences the same problem, although it seems quite rare that this happens since you are the only one we know of so far.
Lets hope your continued use of MySensors in Vera is smooth sailing from now on.
@korttoma Thanks. I completely understand the need for family.I should have thought to link the two topics myself.
So far, since changing the FTDI adapter things have been for the most part smooth. The only thing I am having an issue with is my thermostat bridge node. Details are in this thread if you have any suggestions.
