ha-bridge
ha-bridge copied to clipboard
bwssytems
Restoring from backup - Backup DB Restore Error: Undefined with Status: Server Error 500
Hi,
Due to hardware failure I am trying to restore HA-Bridge from a backup (which I have done before) however when I load the device.db backup I get the error above...Backup DB Restore Error: Undefined with Status: Server Error 500. I can restore habridge-config with no issue.
I am using a Pi with a fresh install of Raspbian, HA-Bridge V5.4.1 and java version 11.0.15. I have looked through the issues logs but can't find a solution.
Below is the output of syslog running through starting the service, restoring habridge-config and attempting to restore device.db (the request from 192.168.0.25 are Vera Edge trying to control lights.
Thanks in advance.
May 18 22:25:07 189AusStPi01 java[408]: 2022-05-18 22:25:07,056 [main] INFO com.bwssystems.HABridge.upnp.UpnpListener - UPNP Discovery Listener starting.... May 18 22:25:07 189AusStPi01 java[408]: 2022-05-18 22:25:07,061 [main] INFO com.bwssystems.HABridge.upnp.UpnpListener - Create and run mDNS service. May 18 22:25:07 189AusStPi01 java[408]: 2022-05-18 22:25:07,283 [main] INFO com.bwssystems.HABridge.upnp.UpnpListener - UPNP Discovery Listener running and ready.... May 18 22:25:14 189AusStPi01 dhcpcd[422]: eth0: no IPv6 Routers available May 18 22:25:16 189AusStPi01 kernel: [ 35.049412] cam-dummy-reg: disabling May 18 22:25:24 189AusStPi01 systemd[1]: systemd-fsckd.service: Succeeded. May 18 22:25:26 189AusStPi01 pulseaudio[474]: GetManagedObjects() failed: org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken. May 18 22:26:11 189AusStPi01 java[408]: 2022-05-18 22:26:11,072 [qtp24260130-14] WARN com.bwssystems.HABridge.hue.HueMulator - Could not find device: 13 for hue state change request: VhCh8zjMx0JwfBHu4uZCAdKRYIycGKm8 from 192.168.0.25 body: {"on":true,"bri":254} May 18 22:26:25 189AusStPi01 systemd[1]: Started Session 3 of user pi. May 18 22:26:36 189AusStPi01 systemd[1]: Started Session 4 of user pi. May 18 22:27:12 189AusStPi01 java[408]: 2022-05-18 22:27:12,257 [qtp24260130-18] WARN com.bwssystems.HABridge.hue.HueMulator - Could not find device: 13 for hue state change request: VhCh8zjMx0JwfBHu4uZCAdKRYIycGKm8 from 192.168.0.25 body: {"on":true,"bri":254} May 18 22:27:33 189AusStPi01 java[408]: 2022-05-18 22:27:33,596 [qtp24260130-19] WARN com.bwssystems.HABridge.hue.HueMulator - Could not find device: 21 for hue state change request: VhCh8zjMx0JwfBHu4uZCAdKRYIycGKm8 from 192.168.0.25 body: {"on":true,"bri":254} May 18 22:27:37 189AusStPi01 java[408]: 2022-05-18 22:27:37,198 [qtp24260130-13] WARN com.bwssystems.HABridge.hue.HueMulator - Could not find device: 101 for hue state change request: VhCh8zjMx0JwfBHu4uZCAdKRYIycGKm8 from 192.168.0.25 body: {"on":true,"bri":50} May 18 22:28:02 189AusStPi01 java[408]: 2022-05-18 22:28:02,962 [qtp24260130-13] WARN com.bwssystems.HABridge.BridgeSettings - Issue loading values from file: file:///home/pi/ha-bridge/data/habridge.config, Gson convert failed. Using default settings. May 18 22:28:14 189AusStPi01 java[408]: 2022-05-18 22:28:14,360 [qtp24260130-16] WARN com.bwssystems.HABridge.hue.HueMulator - Could not find device: 13 for hue state change request: VhCh8zjMx0JwfBHu4uZCAdKRYIycGKm8 from 192.168.0.25 body: {"on":true,"bri":254} May 18 22:28:22 189AusStPi01 java[408]: 2022-05-18 22:28:22,239 [qtp24260130-14] ERROR spark.http.matching.GeneralError - May 18 22:28:22 189AusStPi01 java[408]: com.google.gson.JsonSyntaxException: java.lang.IllegalStateException: Expected BEGIN_ARRAY but was STRING at line 1 column 2 path $ May 18 22:28:22 189AusStPi01 java[408]: #011at com.google.gson.Gson.fromJson(Gson.java:891) May 18 22:28:22 189AusStPi01 java[408]: #011at com.google.gson.Gson.fromJson(Gson.java:844) May 18 22:28:22 189AusStPi01 java[408]: #011at com.google.gson.Gson.fromJson(Gson.java:793) May 18 22:28:22 189AusStPi01 java[408]: #011at com.google.gson.Gson.fromJson(Gson.java:765) May 18 22:28:22 189AusStPi01 java[408]: #011at com.bwssystems.HABridge.dao.DeviceRepository._loadRepository(DeviceRepository.java:71) May 18 22:28:22 189AusStPi01 java[408]: #011at com.bwssystems.HABridge.dao.DeviceRepository.loadRepository(DeviceRepository.java:63) May 18 22:28:22 189AusStPi01 java[408]: #011at com.bwssystems.HABridge.devicemanagmeent.DeviceResource.lambda$setupEndpoints$43(DeviceResource.java:473) May 18 22:28:22 189AusStPi01 java[408]: #011at spark.ResponseTransformerRouteImpl$1.handle(ResponseTransformerRouteImpl.java:47) May 18 22:28:22 189AusStPi01 java[408]: #011at spark.http.matching.Routes.execute(Routes.java:61) May 18 22:28:22 189AusStPi01 java[408]: #011at spark.http.matching.MatcherFilter.doFilter(MatcherFilter.java:130) May 18 22:28:22 189AusStPi01 java[408]: #011at spark.embeddedserver.jetty.JettyHandler.doHandle(JettyHandler.java:50) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1568) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.server.Server.handle(Server.java:530) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:347) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:256) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:279) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:124) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:247) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:140) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:131) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:382) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) May 18 22:28:22 189AusStPi01 java[408]: #011at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) May 18 22:28:22 189AusStPi01 java[408]: #011at java.base/java.lang.Thread.run(Thread.java:829) May 18 22:28:22 189AusStPi01 java[408]: Caused by: java.lang.IllegalStateException: Expected BEGIN_ARRAY but was STRING at line 1 column 2 path $ May 18 22:28:22 189AusStPi01 java[408]: #011at com.google.gson.stream.JsonReader.beginArray(JsonReader.java:351) May 18 22:28:22 189AusStPi01 java[408]: #011at com.google.gson.internal.bind.ArrayTypeAdapter.read(ArrayTypeAdapter.java:70) May 18 22:28:22 189AusStPi01 java[408]: #011at com.google.gson.Gson.fromJson(Gson.java:879) May 18 22:28:22 189AusStPi01 java[408]: #011... 26 common frames omitted May 18 22:28:36 189AusStPi01 systemd[1]: Stopping HA Bridge... May 18 22:28:36 189AusStPi01 java[408]: 2022-05-18 22:28:36,546 [Thread-1] INFO com.bwssystems.HABridge.ShutdownHook - Shutdown requested... May 18 22:28:36 189AusStPi01 java[408]: 2022-05-18 22:28:36,548 [Thread-1] INFO com.bwssystems.HABridge.ShutdownHook - Forcing system stop... May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,565 [main] INFO com.bwssystems.HABridge.upnp.UpnpListener - UPNP Discovery Listener - ended, stop found May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,567 [main] INFO com.bwssystems.HABridge.HABridge - Going to close all homes May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,568 [main] INFO com.bwssystems.HABridge.HomeManager - Manager close homes called.... May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,570 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.tcp.TCPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,572 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.NestBridge.NestHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,573 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.hal.HalHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,575 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.NestBridge.NestHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,577 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.lifx.LifxHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,579 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.somfy.SomfyHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,580 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.moziot.MozIotHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,582 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.http.HTTPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,584 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.openhab.OpenHABHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,586 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.hal.HalHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,587 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.homewizard.HomeWizardHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,589 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.fhem.FHEMHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,591 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.http.HTTPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,592 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.udp.UDPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,593 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.hal.HalHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,595 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.broadlink.BroadlinkHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,596 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.exec.CommandHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,598 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.http.HTTPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,599 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.hass.HassHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,600 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.harmony.HarmonyHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,601 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.hal.HalHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,602 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.homegenie.HomeGenieHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,604 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.udp.UDPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,605 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.hue.HueHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,606 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.harmony.HarmonyHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,607 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.tcp.TCPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,609 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.http.HTTPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,610 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.mqtt.MQTTHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,627 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.domoticz.DomoticzHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,628 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.http.HTTPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,629 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.exec.CommandHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,630 [main] INFO com.bwssystems.HABridge.HomeManager - Closing home: com.bwssystems.HABridge.plugins.http.HTTPHome May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,638 [Thread-18] INFO spark.embeddedserver.jetty.EmbeddedJettyServer - >>> Spark shutting down ... May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39.681:INFO:oejs.AbstractConnector:Thread-18: Stopped ServerConnector@1570c81{HTTP/1.1,[http/1.1]}{0.0.0.0:80} May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39.692:INFO:oejs.session:Thread-18: Stopped scavenging May 18 22:28:39 189AusStPi01 java[408]: 2022-05-18 22:28:39,708 [Thread-18] INFO spark.embeddedserver.jetty.EmbeddedJettyServer - done May 18 22:28:41 189AusStPi01 systemd[1]: ha-bridge.service: Main process exited, code=exited, status=143/n/a May 18 22:28:41 189AusStPi01 systemd[1]: ha-bridge.service: Failed with result 'exit-code'. May 18 22:28:41 189AusStPi01 systemd[1]: Stopped HA Bridge. May 18 22:28:41 189AusStPi01 systemd[1]: ha-bridge.service: Consumed 23.899s CPU time.
