Update to r466, now modules broken

[bkenobi]

I was adding some modules yesterday around the same time that I updated HG to r466.  As of this morning I thought things were working, but when I returned home I had lights on everywhere (during daylight hours).  I have Scheduled tasks to turn off my lights at dawn (after I left for work) and some lights turn on at dusk (it was still daylight).

I'm not sure if this is an issue with HG or if I broke something by modifying the modules.xml file.  All I did was change the X10 Address of a couple modules, so nothing SHOULD have gotten broken.  However, I'm now seeing generic icons for all of my modules.  The only thing that appears normal is the widgets (jkutils items for example).

I don't see any errors in the mono log (other than a known mail issue).  I updated to the r466 fix prior to posting without help.  The screen shot shows my issue.  Any thoughts?

[bkenobi]

I guess it's fortunate I keep a backup for every time I make a change.  I restored from my last backup and everything seems restored.  I still don't know what broke though.  It does appear there are new errors in my mono output that I'll have to track down.

[RichieC]

I have the same problem with r466..

All X10 and Z-Wave modules appear to have lost their config..

Rich

[enterprised]

Oh bugger, same thing happened to me today, not a single module showing.

Restore to pre-update archive hopefully will fix this for the moment.

[bkenobi]

This is obviously a bug since others are reporting the same issue.  I'm moving this to the bug tracking thread and will report to github.

https://github.com/genielabs/HomeGenie/issues/115

[nolio]

By "broken" did you mean like the join capture screen ?
On my side, i reboot HG and it appear again, and disappear again ...

[bkenobi]

I mentioned seeing errors in the mono output.  Here is what I found:

Code: [Select]

2015-01-26T19:18:24.0133160-08:00 HomeAutomation.HomeGenie.Automation NetHelper address Exception.StackTrace   at System.Net.Mail.MailAddress..ctor (System.String address, System.String displayName, System.Text.Encoding displayNameEncoding) [0x00000] in <filename unknown>:0
  at System.Net.Mail.MailAddress..ctor (System.String address, System.String displayName) [0x00000] in <filename unknown>:0
  at System.Net.Mail.MailAddress..ctor (System.String address) [0x00000] in <filename unknown>:0
  at System.Net.Mail.MailAddressCollection.Add (System.String addresses) [0x00000] in <filename unknown>:0
  at HomeGenie.Automation.Scripting.NetHelper.SendMessage (System.String from, System.String recipients, System.String subject, System.String messageText) [0x00000] in <filename unknown>:0

Code: [Select]

2015-01-26T19:28:52.9622960-08:00 MIG.Gateways.WebServiceGateway 192.168.0.5 api/MIGService.Interfaces/HomeAutomation.X10/Options.Set/HouseCodes/A%2CB%2CC%2CE%2CO%2CP/1422329332595 HTTP GET
[19:28:52.989189] X10 ! Thread was being aborted
[19:28:52.993237] X10 !   at (wrapper managed-to-native) System.Threading.WaitHandle:WaitAll_internal (System.Threading.WaitHandle[],int,bool)
  at System.Threading.WaitHandle.WaitAll (System.Threading.WaitHandle[] waitHandles, Int32 millisecondsTimeout, Boolean exitContext) [0x00000] in <filename unknown>:0
  at XTenLib.Drivers.CM15.ReadData () [0x00000] in <filename unknown>:0
  at XTenLib.XTenManager.ReaderThreadLoop () [0x00000] in <filename unknown>:0 This one seen several times in the output.

Code: [Select]

2015-01-26T19:28:53.3555130-08:00 MIGService.Interfaces HomeAutomation.X10 MIG Interface Options.HouseCodes A,B,C,E,O,P
2015-01-26T19:28:56.3255640-08:00 MIG.Gateways.WebServiceGateway 192.168.0.5 api/MIGService.Interfaces/HomeAutomation.X10/Options.Set/HouseCodes/A%2CB%2CC%2CE%2CO/1422329335955 HTTP GET
[19:28:56.330916] X10 ! Thread was being aborted
[19:28:56.335895] X10 !   at (wrapper managed-to-native) System.Threading.WaitHandle:WaitAll_internal (System.Threading.WaitHandle[],int,bool)
  at System.Threading.WaitHandle.WaitAll (System.Threading.WaitHandle[] waitHandles, Int32 millisecondsTimeout, Boolean exitContext) [0x00000] in <filename unknown>:0
  at XTenLib.Drivers.CM15.ReadData () [0x00000] in <filename unknown>:0
  at XTenLib.XTenManager.ReaderThreadLoop () [0x00000] in <filename unknown>:0

Code: [Select]

2015-01-26T19:46:31.5000660-08:00 MIG.Gateways.WebServiceGateway 192.168.0.5 api/HomeAutomation.HomeGenie/Config/Interfaces.List/1422330391138 HTTP GET
[19:46:35.360570] X10 > PREVIOUS COMMAND TIMED OUT, RESENDING(1)
[19:46:35.368971] X10 < BB 56 70 05 00 14 20 28 24 29
[19:46:35.388379] X10 > 55
[19:46:35.391675] X10 > COMMAND SUCCESSFUL
[19:46:35.395744] X10 < 8B
[19:46:35.404455] X10 > 00 00 1F 2E 09 19 02 02
[19:46:35.407873] X10 < 00
[19:46:35.414743] X10 > 00 00 00 00 00 00 00 00
[19:46:35.417779] X10 < 00
[19:46:35.493851] X10 ! Thread was being aborted
[19:46:35.498910] X10 !   at (wrapper managed-to-native) System.Threading.WaitHandle:WaitAll_internal (System.Threading.WaitHandle[],int,bool)
  at System.Threading.WaitHandle.WaitAll (System.Threading.WaitHandle[] waitHandles, Int32 millisecondsTimeout, Boolean exitContext) [0x00000] in <filename unknown>:0
  at XTenLib.Drivers.CM15.ReadData () [0x00000] in <filename unknown>:0
  at XTenLib.XTenManager.ReaderThreadLoop () [0x00000] in <filename unknown>:0

Code: [Select]

2015-01-26T19:46:57.9879900-08:00 HomeAutomation.HomeGenie RouteParameterChangedEvent() Collection was modified; enumeration operation may not execute. Exception.StackTrace   at System.Collections.Generic.List`1+Enumerator[HomeGenie.Automation.ProgramBlock].MoveNext () [0x00000] in <filename unknown>:0
  at HomeGenie.Service.HomeGenieService.RouteParameterChangedEvent (System.Object eventData) [0x00000] in <filename unknown>:0
2015-01-26T19:46:58.3985870-08:00 HomeAutomation.HomeGenie RouteParameterChangedEvent() Collection was modified; enumeration operation may not execute. Exception.StackTrace   at System.Collections.Generic.List`1+Enumerator[HomeGenie.Automation.ProgramBlock].MoveNext () [0x00000] in <filename unknown>:0
  at HomeGenie.Service.HomeGenieService.RouteParameterChangedEvent (System.Object eventData) [0x00000] in <filename unknown>:0
2015-01-26T19:46:58.5361710-08:00 MIG.Gateways.WebServiceGateway 192.168.0.5 api/HomeAutomation.HomeGenie/Config/Modules.Get/HomeAutomation.HomeGenie.Automation/1009/1422330417863 HTTP POST
2015-01-26T19:46:58.7431990-08:00 MIG.Gateways.WebServiceGateway 192.168.0.5 api/HomeAutomation.HomeGenie/Config/Modules.Get/HomeAutomation.HomeGenie.Automation/1010/1422330417867 HTTP POST
2015-01-26T19:46:58.8480450-08:00 MIG.Gateways.WebServiceGateway 192.168.0.5 api/HomeAutomation.HomeGenie/Config/Modules.Get/HomeAutomation.HomeGenie.Automation/1006/1422330417870 HTTP POST
2015-01-26T19:46:58.9380810-08:00 HomeAutomation.HomeGenie RouteParameterChangedEvent() Collection was modified; enumeration operation may not execute. Exception.StackTrace   at System.Collections.Generic.List`1+Enumerator[HomeGenie.Automation.ProgramBlock].MoveNext () [0x00000] in <filename unknown>:0
  at HomeGenie.Service.HomeGenieService.RouteParameterChangedEvent (System.Object eventData) [0x00000] in <filename unknown>:0
2015-01-26T19:46:59.2883200-08:00 HomeAutomation.HomeGenie RouteParameterChangedEvent() Collection was modified; enumeration operation may not execute. Exception.StackTrace   at System.Collections.Generic.List`1+Enumerator[HomeGenie.Automation.ProgramBlock].MoveNext () [0x00000] in <filename unknown>:0
  at HomeGenie.Service.HomeGenieService.RouteParameterChangedEvent (System.Object eventData) [0x00000] in <filename unknown>:0
2015-01-26T19:47:00.1676840-08:00 HomeAutomation.HomeGenie RouteParameterChangedEvent() Collection was modified; enumeration operation may not execute. Exception.StackTrace   at System.Collections.Generic.List`1+Enumerator[HomeGenie.Automation.ProgramBlock].MoveNext () [0x00000] in <filename unknown>:0
  at HomeGenie.Service.HomeGenieService.RouteParameterChangedEvent (System.Object eventData) [0x00000] in <filename unknown>:0
2015-01-26T19:47:00.2867940-08:00 HomeAutomation.HomeGenie.Automation 1004 Automation Program Program.Status Running
2015-01-26T19:47:00.7464340-08:00 HomeAutomation.HomeGenie.Automation 1006 Automation Program Ip Information Mail send
2015-01-26T19:47:00.9539500-08:00 HomeAutomation.HomeGenie RouteParameterChangedEvent() Collection was modified; enumeration operation may not execute. Exception.StackTrace   at System.Collections.Generic.List`1+Enumerator[HomeGenie.Automation.ProgramBlock].MoveNext () [0x00000] in <filename unknown>:0
  at HomeGenie.Service.HomeGenieService.RouteParameterChangedEvent (System.Object eventData) [0x00000] in <filename unknown>:0
...
repeated for quite a while...


Code: [Select]

2015-01-27T09:49:34.2918620-08:00 HomeAutomation.HomeGenie.Automation NetHelper The remote server returned an error: (510) . Exception.StackTrace   at System.Net.HttpWebRequest.CheckFinalStatus (System.Net.WebAsyncResult result) [0x00000] in <filename unknown>:0
  at System.Net.HttpWebRequest.SetResponseData (System.Net.WebConnectionData data) [0x00000] in <filename unknown>:0
2015-01-27T09:49:34.3067560-08:00 HomeAutomation.HomeGenie.Automation 503 Automation Program jkutils - OpenWeatherMap Update of data failed.
`string' does not contain a definition for `cod'


But, I haven't seen anything since yesterday morning, so it appears that things settled down for some reason.  I've attached the full log in case some other info is needed.

[flybob]

Same here, cannot update past 466 and i don't know how to proceed without breaking my stuff, since the configuration backup also seems to be broken.

It is possible to manually update without just overwriting everything?

[Gene]

It is possible to update manually with the following procedure:

- rename current homegenie folder
- extract a fresh homegenie folder from the latest tgz archive
- if you are using Windows, copy any sqlite file (dll) and x32/x64 folder from old homegenie to the new folder
- replace all xml files from old homegenie to the new one
- start homegenie

g.