Final 1.0.0 errors and crash report....



  • Here's todays problems with MYC on a pi2......

    2017-10-01 14:44:30,684 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/bin/tmp]
    2017-10-01 14:44:30,700 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/conf/resources/scripts]
    2017-10-01 14:44:30,701 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/conf/resources/scripts/conditions]
    2017-10-01 14:44:30,703 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/conf/resources/scripts/operations]
    2017-10-01 14:44:30,707 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/www/_configurations]
    2017-10-01 14:44:30,708 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/conf/persistent_stores]
    2017-10-01 14:44:30,818 INFO [main] [org.mycontroller.standalone.db.DataBaseUtils:116] Checking migration...
    2017-10-01 14:44:34,229 INFO [main] [org.mycontroller.standalone.db.migration.V1_01__Initial_Configuration:398] Migration completed successfully.
    2017-10-01 14:44:34,486 INFO [main] [org.mycontroller.standalone.db.migration.V1_01_01__SNAPSHOT:63] Migration completed successfully.
    2017-10-01 14:44:34,621 INFO [main] [org.mycontroller.standalone.db.migration.V1_01_02__SNAPSHOT:127] Migration completed successfully.
    2017-10-01 14:44:34,733 INFO [main] [org.mycontroller.standalone.db.migration.V1_01_03__SNAPSHOT:48] Migration completed successfully.
    2017-10-01 14:44:34,834 INFO [main] [org.mycontroller.standalone.db.migration.V1_01_04__SNAPSHOT:107] Migration completed successfully.
    2017-10-01 14:44:34,934 INFO [main] [org.mycontroller.standalone.db.migration.V1_01_05__0_0_3_alpha1:49] Migration completed successfully.
    2017-10-01 14:44:35,193 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_04__2016_Apr_25:58] Migration completed successfully.
    2017-10-01 14:44:35,206 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_01__2016_Mar_24:340] Migration completed successfully.
    2017-10-01 14:44:35,366 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_02__2016_Apr_11:66] Migration completed successfully.
    2017-10-01 14:44:39,448 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_03__2016_Apr_14:85] Migration completed successfully.
    2017-10-01 14:44:39,617 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_04__2016_Apr_25:58] Migration completed successfully.
    2017-10-01 14:44:39,672 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_05__2016_Apr_27:68] Migration completed successfully.
    2017-10-01 14:44:39,723 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_06__2016_May_10:49] Migration completed successfully.
    2017-10-01 14:44:39,769 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_07__2016_May_19:57] Migration completed successfully.
    2017-10-01 14:44:39,834 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_08__2016_Jul_01:108] Migration completed successfully.
    2017-10-01 14:44:39,879 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_09__2016_Jul_16:93] Migration completed successfully.
    2017-10-01 14:44:39,926 INFO [main] [org.mycontroller.standalone.db.migration.V1_02_10__2016_Jul_29:53] Migration completed successfully.
    2017-10-01 14:44:39,977 INFO [main] [org.mycontroller.standalone.db.migration.V1_03_01__2016_Aug_03:66] Migration completed successfully.
    2017-10-01 14:44:40,028 INFO [main] [org.mycontroller.standalone.db.migration.V1_03_02__2016_Aug_06:63] Migration completed successfully.
    2017-10-01 14:44:40,070 INFO [main] [org.mycontroller.standalone.db.migration.V1_03_03__2016_Sep_20:95] Migration completed successfully.
    2017-10-01 14:44:40,109 INFO [main] [org.mycontroller.standalone.db.migration.V1_03_04__2016_Oct_19:61] Migration completed successfully.
    2017-10-01 14:44:40,151 INFO [main] [org.mycontroller.standalone.db.migration.V1_03_05__2016_Nov_18:77] Migration completed successfully.
    2017-10-01 14:44:40,278 INFO [main] [org.mycontroller.standalone.db.migration.V1_03_06__2017_Mar_03:66] Migration completed successfully.
    2017-10-01 14:44:40,715 INFO [main] [org.mycontroller.standalone.db.DataBaseUtils:161] Number of migrations done:22
    2017-10-01 14:44:40,718 INFO [main] [org.mycontroller.standalone.db.DataBaseUtils:167] Application information: [Version:1.0.0.Final, Database(type:H2 database embedded, version:1.4.194 (2017-03-10), schema version:1.03.06 - 2017 Mar 03), Built on:2017-09-25T11:00:11+0530, Git commit:07c3a228b9c861280fe2f560ed4d1097349d08bb:master]
    2017-10-01 14:44:41,017 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/conf/persistent_stores/mc]
    2017-10-01 14:44:41,676 INFO [Thread-8] [org.mycontroller.standalone.message.RawMessageQueue:54] Cleared offline messages[0] from the queue.
    2017-10-01 14:44:42,666 INFO [main] [org.mycontroller.standalone.mqttbroker.MoquetteMqttBroker:52] MQTT Broker started successfully. MqttBrokerSettings(enabled=true, bindAddress=0.0.0.0, httpPort=1883, websocketPort=7080, allowAnonymous=false)
    2017-10-01 14:44:45,177 INFO [main] [org.mycontroller.standalone.StartApp:214] TJWS server started successfully, HTTPS Enabled?:true, HTTP(S) Port: [8443]
    2017-10-01 14:44:45,178 INFO [main] [org.mycontroller.standalone.StartApp:112] MyController.org server started in [14529] ms
    [Sun Oct 01 14:44:45 BST 2017] IO error: javax.net.ssl.SSLException: Connection has been shutdown: javax.net.ssl.SSLHandshakeException: Received fatal alert: unknown_ca in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    2017-10-01 14:46:44,600 INFO [Acme.Utils.ThreadPool(4)-PooledThread: Acme.Serve.Serve$ServeConnection@39240b] [org.mycontroller.standalone.api.BackupApi:219] Restore triggered.
    2017-10-01 14:46:47,602 INFO [Thread-16] [org.mycontroller.standalone.backup.Restore:69] About to restore a backup, BackupFile(name=on-demand_mc_backup_h2db_embedded-2017_10_01-14_14_53.zip, canonicalPath=/home/myvbackup/on-demand_mc_backup_h2db_embedded-2017_10_01-14_14_53.zip, timestamp=1506863694000, size=316013)
    [Sun Oct 01 14:46:47 BST 2017] Accept: java.net.SocketException: Socket closed
    2017-10-01 14:46:47,794 INFO [Thread-16] [org.mycontroller.standalone.mqttbroker.MoquetteMqttBroker:70] MQTT Broker has been stopped successfully
    2017-10-01 14:46:52,994 INFO [Thread-16] [org.mycontroller.standalone.db.DataBaseUtils:288] Database restore completed. Database url:jdbc:h2:file:../conf/mycontroller;MVCC=TRUE, Restored file name:/home/mycontroller/bin/tmp/on-demand_mc_backup_h2db_embedded-2017_10_01-14_14_53/database_backup.zip
    2017-10-01 14:46:53,010 INFO [Thread-16] [org.mycontroller.standalone.backup.Restore:153] Restore completed successfully. Start 'MyController.org' server manually
    2017-10-01 14:46:53,015 WARN [MyController.org Shutdown-Hook] [org.knowm.sundial.SundialJobScheduler:140] Scheduler has not yet been created!!! Call "createScheduler" first.
    2017-10-01 14:46:53,016 INFO [MyController.org Shutdown-Hook] [org.mycontroller.standalone.AppShutdownHook:36] Bye, Have a nice day! See you soon
    2017-10-01 14:48:57,300 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/conf/resources/scripts]
    2017-10-01 14:48:57,334 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/conf/resources/scripts/conditions]
    2017-10-01 14:48:57,336 INFO [main] [org.mycontroller.standalone.AppProperties:497] Created directory location: [/home/mycontroller/conf/resources/scripts/operations]
    2017-10-01 14:48:57,883 INFO [main] [org.mycontroller.standalone.db.DataBaseUtils:116] Checking migration...
    2017-10-01 14:49:02,677 INFO [main] [org.mycontroller.standalone.db.DataBaseUtils:167] Application information: [Version:1.0.0.Final, Database(type:H2 database embedded, version:1.4.194 (2017-03-10), schema version:1.03.06 - 2017 Mar 03), Built on:2017-09-25T11:00:11+0530, Git commit:07c3a228b9c861280fe2f560ed4d1097349d08bb:master]
    2017-10-01 14:49:04,067 INFO [Thread-6] [org.mycontroller.standalone.message.RawMessageQueue:54] Cleared offline messages[0] from the queue.
    2017-10-01 14:49:04,993 INFO [main] [org.mycontroller.standalone.mqttbroker.MoquetteMqttBroker:52] MQTT Broker started successfully. MqttBrokerSettings(enabled=true, bindAddress=0.0.0.0, httpPort=1883, websocketPort=7080, allowAnonymous=true)
    2017-10-01 14:49:05,754 INFO [main] [org.mycontroller.standalone.gateway.mqtt.MqttGatewayImpl:67] MQTT Gateway[name:Raspberry PI, URI:tcp://localhost:1883, NetworkType:MyController] connected successfully..
    2017-10-01 14:49:09,893 INFO [main] [org.mycontroller.standalone.StartApp:214] TJWS server started successfully, HTTPS Enabled?:true, HTTP(S) Port: [8443]
    2017-10-01 14:49:09,894 INFO [main] [org.mycontroller.standalone.StartApp:112] MyController.org server started in [12683] ms
    [Sun Oct 01 14:51:31 BST 2017] IO error: javax.net.ssl.SSLHandshakeException: Received fatal alert: unknown_ca in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    [Mon Oct 02 07:53:03 BST 2017] IO error: javax.net.ssl.SSLHandshakeException: Received fatal alert: unknown_ca in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    [Tue Oct 03 07:18:29 BST 2017] IO error: javax.net.ssl.SSLHandshakeException: Received fatal alert: unknown_ca in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    [Wed Oct 04 09:20:10 BST 2017] IO error: javax.net.ssl.SSLHandshakeException: Received fatal alert: unknown_ca in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    [Wed Oct 04 14:50:38 BST 2017] IO error: javax.net.ssl.SSLHandshakeException: Received fatal alert: unknown_ca in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    [Wed Oct 04 21:17:40 BST 2017] IO error: javax.net.ssl.SSLHandshakeException: Received fatal alert: unknown_ca in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    2017-10-04 21:22:37,318 ERROR [Thread-8] [org.mycontroller.standalone.gateway.serialport.SerialDataListenerjSerialComm:94] Exception, 
    java.lang.NegativeArraySizeException: null
    	at org.mycontroller.standalone.gateway.serialport.SerialDataListenerjSerialComm.serialEvent(SerialDataListenerjSerialComm.java:59)
    	at com.fazecast.jSerialComm.SerialPort$SerialPortEventListener.waitForSerialEvent(SerialPort.java:937)
    	at com.fazecast.jSerialComm.SerialPort$SerialPortEventListener$1.run(SerialPort.java:885)
    	at java.lang.Thread.run(Thread.java:745)
    2017-10-04 21:23:11,304 INFO [Thread-9] [org.mycontroller.standalone.gateway.serialport.SerialPortMonitoringThread:112] Serial GatewayTable[GatewaySerial(super=Gateway(id=2, enabled=true, name=MYSGW, type=SERIAL, networkType=MY_SENSORS, timestamp=1505319425589, state=DOWN, statusMessage=ERROR: null, statusSince=1507148557303, txDelay=0), driver=AUTO, portName=/dev/ttyMySensorsGateway, baudRate=115200, retryFrequency=60, runningDriver=JSERIALCOMM)] not connected, Reconnect initiated...
    2017-10-04 21:23:11,832 ERROR [Thread-9] [org.mycontroller.standalone.gateway.serialport.SerialPortjSerialCommImpl:74] Unable to open serial port:[/dev/ttyMySensorsGateway]
    2017-10-04 21:23:11,842 INFO [Thread-9] [org.mycontroller.standalone.gateway.serialport.SerialPortMonitoringThread:93] Serial GatewayTable[GatewaySerial(super=Gateway(id=2, enabled=true, name=MYSGW, type=SERIAL, networkType=MY_SENSORS, timestamp=1505319425589, state=DOWN, statusMessage=ERROR: Unable to open!, statusSince=1507148557303, txDelay=0), driver=AUTO, portName=/dev/ttyMySensorsGateway, baudRate=115200, retryFrequency=60, runningDriver=JSERIALCOMM)], Unable to reconnected! Will do next try after 60 second(s)
    [Wed Oct 04 21:24:08 BST 2017] Accept: java.net.SocketException: Socket closed
    2017-10-04 21:24:09,469 INFO [MyController.org Shutdown-Hook] [org.mycontroller.standalone.mqttbroker.MoquetteMqttBroker:70] MQTT Broker has been stopped successfully
    2017-10-04 21:24:09,486 INFO [MyController.org Shutdown-Hook] [org.mycontroller.standalone.AppShutdownHook:36] Bye, Have a nice day! See you soon
    2017-10-04 21:24:29,288 INFO [main] [org.mycontroller.standalone.db.DataBaseUtils:116] Checking migration...
    2017-10-04 21:24:34,266 INFO [main] [org.mycontroller.standalone.db.DataBaseUtils:167] Application information: [Version:1.0.0.Final, Database(type:H2 database embedded, version:1.4.194 (2017-03-10), schema version:1.03.06 - 2017 Mar 03), Built on:2017-09-25T11:00:11+0530, Git commit:07c3a228b9c861280fe2f560ed4d1097349d08bb:master]
    2017-10-04 21:24:35,659 INFO [Thread-6] [org.mycontroller.standalone.message.RawMessageQueue:54] Cleared offline messages[0] from the queue.
    2017-10-04 21:24:36,731 INFO [main] [org.mycontroller.standalone.mqttbroker.MoquetteMqttBroker:52] MQTT Broker started successfully. MqttBrokerSettings(enabled=true, bindAddress=0.0.0.0, httpPort=1883, websocketPort=7080, allowAnonymous=true)
    2017-10-04 21:24:37,491 INFO [main] [org.mycontroller.standalone.gateway.mqtt.MqttGatewayImpl:67] MQTT Gateway[name:Raspberry PI, URI:tcp://localhost:1883, NetworkType:MyController] connected successfully..
    2017-10-04 21:24:42,259 INFO [main] [org.mycontroller.standalone.StartApp:214] TJWS server started successfully, HTTPS Enabled?:true, HTTP(S) Port: [8443]
    2017-10-04 21:24:42,260 INFO [main] [org.mycontroller.standalone.StartApp:112] MyController.org server started in [13531] ms
    [Wed Oct 04 21:24:48 BST 2017] Unexpected problem running servlet
    org.jboss.resteasy.spi.UnhandledException: RESTEASY003770: Response is committed, can't handle exception
    	at org.jboss.resteasy.core.SynchronousDispatcher.writeException(SynchronousDispatcher.java:167)
    	at org.jboss.resteasy.core.SynchronousDispatcher.writeResponse(SynchronousDispatcher.java:471)
    	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:415)
    	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:202)
    	at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:221)
    	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56)
    	at org.jboss.resteasy.plugins.server.tjws.TJWSServletDispatcher.service(TJWSServletDispatcher.java:40)
    	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51)
    	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
    	at Acme.Serve.Serve$ServeConnection.runServlet(Serve.java:2328)
    	at Acme.Serve.Serve$ServeConnection.parseRequest(Serve.java:2282)
    	at Acme.Serve.Serve$ServeConnection.run(Serve.java:2054)
    	at Acme.Utils$ThreadPool$PooledThread.run(Utils.java:1402)
    	at java.lang.Thread.run(Thread.java:745)
    Caused by: javax.net.ssl.SSLException: Connection has been shutdown: javax.net.ssl.SSLException: java.net.SocketException: Broken pipe
    	at sun.security.ssl.SSLSocketImpl.checkEOF(SSLSocketImpl.java:1541)
    	at sun.security.ssl.SSLSocketImpl.checkWrite(SSLSocketImpl.java:1553)
    	at sun.security.ssl.AppOutputStream.write(AppOutputStream.java:71)
    	at java.io.OutputStream.write(OutputStream.java:75)
    	at Acme.Serve.Serve$ServeOutputStream.flush(Serve.java:4889)
    	at Acme.Serve.Serve$ServeOutputStream.close(Serve.java:4923)
    	at org.jboss.resteasy.plugins.server.servlet.HttpServletResponseWrapper$DeferredOutputStream.close(HttpServletResponseWrapper.java:58)
    	at org.jboss.resteasy.util.CommitHeaderOutputStream.close(CommitHeaderOutputStream.java:87)
    	at org.jboss.resteasy.util.DelegatingOutputStream.close(DelegatingOutputStream.java:60)
    	at com.fasterxml.jackson.core.json.UTF8JsonGenerator.close(UTF8JsonGenerator.java:1060)
    	at org.jboss.resteasy.plugins.providers.jackson.ResteasyJackson2Provider.writeTo(ResteasyJackson2Provider.java:209)
    	at org.mycontroller.standalone.api.jaxrs.mixins.McJacksonJson2Provider.writeTo(McJacksonJson2Provider.java:120)
    	at org.jboss.resteasy.core.interception.AbstractWriterInterceptorContext.writeTo(AbstractWriterInterceptorContext.java:131)
    	at org.jboss.resteasy.core.interception.ServerWriterInterceptorContext.writeTo(ServerWriterInterceptorContext.java:60)
    	at org.jboss.resteasy.core.interception.AbstractWriterInterceptorContext.proceed(AbstractWriterInterceptorContext.java:120)
    	at org.jboss.resteasy.plugins.interceptors.encoding.GZIPEncodingInterceptor.aroundWriteTo(GZIPEncodingInterceptor.java:100)
    	at org.jboss.resteasy.core.interception.AbstractWriterInterceptorContext.proceed(AbstractWriterInterceptorContext.java:124)
    	at org.jboss.resteasy.core.ServerResponseWriter.writeNomapResponse(ServerResponseWriter.java:98)
    	at org.jboss.resteasy.core.SynchronousDispatcher.writeResponse(SynchronousDispatcher.java:466)
    	... 12 more
    Caused by: javax.net.ssl.SSLException: java.net.SocketException: Broken pipe
    	at sun.security.ssl.Alerts.getSSLException(Alerts.java:208)
    	at sun.security.ssl.SSLSocketImpl.fatal(SSLSocketImpl.java:1949)
    	at sun.security.ssl.SSLSocketImpl.fatal(SSLSocketImpl.java:1906)
    	at sun.security.ssl.SSLSocketImpl.handleException(SSLSocketImpl.java:1870)
    	at sun.security.ssl.SSLSocketImpl.handleException(SSLSocketImpl.java:1815)
    	at sun.security.ssl.AppOutputStream.write(AppOutputStream.java:128)
    	at java.io.OutputStream.write(OutputStream.java:75)
    	at Acme.Serve.Serve$ServeOutputStream.write(Serve.java:4854)
    	at org.jboss.resteasy.plugins.server.servlet.HttpServletResponseWrapper$DeferredOutputStream.write(HttpServletResponseWrapper.java:46)
    	at org.jboss.resteasy.util.CommitHeaderOutputStream.write(CommitHeaderOutputStream.java:71)
    	at org.jboss.resteasy.util.DelegatingOutputStream.write(DelegatingOutputStream.java:48)
    	at com.fasterxml.jackson.core.json.UTF8JsonGenerator._flushBuffer(UTF8JsonGenerator.java:2003)
    	at com.fasterxml.jackson.core.json.UTF8JsonGenerator.flush(UTF8JsonGenerator.java:1019)
    	at com.fasterxml.jackson.databind.ObjectWriter.writeValue(ObjectWriter.java:891)
    	at org.jboss.resteasy.plugins.providers.jackson.ResteasyJackson2Provider.writeTo(ResteasyJackson2Provider.java:207)
    	... 20 more
    Caused by: java.net.SocketException: Broken pipe
    	at java.net.SocketOutputStream.socketWrite0(Native Method)
    	at java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:109)
    	at java.net.SocketOutputStream.write(SocketOutputStream.java:153)
    	at sun.security.ssl.OutputRecord.writeBuffer(OutputRecord.java:431)
    	at sun.security.ssl.OutputRecord.write(OutputRecord.java:417)
    	at sun.security.ssl.SSLSocketImpl.writeRecordInternal(SSLSocketImpl.java:876)
    	at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:847)
    	at sun.security.ssl.AppOutputStream.write(AppOutputStream.java:123)
    	... 29 more
    
    [Wed Oct 04 21:24:48 BST 2017] Unexpected problem running servlet
    org.jboss.resteasy.spi.UnhandledException: RESTEASY003770: Response is committed, can't handle exception
    	at org.jboss.resteasy.core.SynchronousDispatcher.writeException(SynchronousDispatcher.java:167)
    	at org.jboss.resteasy.core.SynchronousDispatcher.writeResponse(SynchronousDispatcher.java:471)
    	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:415)
    	at org.jboss.resteasy.core.SynchronousDispatcher.invoke(SynchronousDispatcher.java:202)
    	at org.jboss.resteasy.plugins.server.servlet.ServletContainerDispatcher.service(ServletContainerDispatcher.java:221)
    	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:56)
    	at org.jboss.resteasy.plugins.server.tjws.TJWSServletDispatcher.service(TJWSServletDispatcher.java:40)
    	at org.jboss.resteasy.plugins.server.servlet.HttpServletDispatcher.service(HttpServletDispatcher.java:51)
    	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
    	at Acme.Serve.Serve$ServeConnection.runServlet(Serve.java:2328)
    	at Acme.Serve.Serve$ServeConnection.parseRequest(Serve.java:2282)
    	at Acme.Serve.Serve$ServeConnection.run(Serve.java:2054)
    	at Acme.Utils$ThreadPool$PooledThread.run(Utils.java:1402)
    	at java.lang.Thread.run(Thread.java:745)
    Caused by: javax.net.ssl.SSLException: Connection has been shutdown: javax.net.ssl.SSLException: java.net.SocketException: Broken pipe
    	at sun.security.ssl.SSLSocketImpl.checkEOF(SSLSocketImpl.java:1541)
    	at sun.security.ssl.SSLSocketImpl.checkWrite(SSLSocketImpl.java:1553)
    	at sun.security.ssl.AppOutputStream.write(AppOutputStream.java:71)
    	at java.io.OutputStream.write(OutputStream.java:75)
    	at Acme.Serve.Serve$ServeOutputStream.flush(Serve.java:4889)
    	at Acme.Serve.Serve$ServeOutputStream.close(Serve.java:4923)
    	at org.jboss.resteasy.plugins.server.servlet.HttpServletResponseWrapper$DeferredOutputStream.close(HttpServletResponseWrapper.java:58)
    	at org.jboss.resteasy.util.CommitHeaderOutputStream.close(CommitHeaderOutputStream.java:87)
    	at org.jboss.resteasy.util.DelegatingOutputStream.close(DelegatingOutputStream.java:60)
    	at com.fasterxml.jackson.core.json.UTF8JsonGenerator.close(UTF8JsonGenerator.java:1060)
    	at org.jboss.resteasy.plugins.providers.jackson.ResteasyJackson2Provider.writeTo(ResteasyJackson2Provider.java:209)
    	at org.mycontroller.standalone.api.jaxrs.mixins.McJacksonJson2Provider.writeTo(McJacksonJson2Provider.java:120)
    	at org.jboss.resteasy.core.interception.AbstractWriterInterceptorContext.writeTo(AbstractWriterInterceptorContext.java:131)
    	at org.jboss.resteasy.core.interception.ServerWriterInterceptorContext.writeTo(ServerWriterInterceptorContext.java:60)
    	at org.jboss.resteasy.core.interception.AbstractWriterInterceptorContext.proceed(AbstractWriterInterceptorContext.java:120)
    	at org.jboss.resteasy.plugins.interceptors.encoding.GZIPEncodingInterceptor.aroundWriteTo(GZIPEncodingInterceptor.java:100)
    	at org.jboss.resteasy.core.interception.AbstractWriterInterceptorContext.proceed(AbstractWriterInterceptorContext.java:124)
    	at org.jboss.resteasy.core.ServerResponseWriter.writeNomapResponse(ServerResponseWriter.java:98)
    	at org.jboss.resteasy.core.SynchronousDispatcher.writeResponse(SynchronousDispatcher.java:466)
    	... 12 more
    Caused by: javax.net.ssl.SSLException: java.net.SocketException: Broken pipe
    	at sun.security.ssl.Alerts.getSSLException(Alerts.java:208)
    	at sun.security.ssl.SSLSocketImpl.fatal(SSLSocketImpl.java:1949)
    	at sun.security.ssl.SSLSocketImpl.fatal(SSLSocketImpl.java:1906)
    	at sun.security.ssl.SSLSocketImpl.handleException(SSLSocketImpl.java:1870)
    	at sun.security.ssl.SSLSocketImpl.handleException(SSLSocketImpl.java:1815)
    	at sun.security.ssl.AppOutputStream.write(AppOutputStream.java:128)
    	at java.io.OutputStream.write(OutputStream.java:75)
    	at Acme.Serve.Serve$ServeOutputStream.write(Serve.java:4854)
    	at org.jboss.resteasy.plugins.server.servlet.HttpServletResponseWrapper$DeferredOutputStream.write(HttpServletResponseWrapper.java:46)
    	at org.jboss.resteasy.util.CommitHeaderOutputStream.write(CommitHeaderOutputStream.java:71)
    	at org.jboss.resteasy.util.DelegatingOutputStream.write(DelegatingOutputStream.java:48)
    	at com.fasterxml.jackson.core.json.UTF8JsonGenerator._flushBuffer(UTF8JsonGenerator.java:2003)
    	at com.fasterxml.jackson.core.json.UTF8JsonGenerator.flush(UTF8JsonGenerator.java:1019)
    	at com.fasterxml.jackson.databind.ObjectWriter.writeValue(ObjectWriter.java:891)
    	at org.jboss.resteasy.plugins.providers.jackson.ResteasyJackson2Provider.writeTo(ResteasyJackson2Provider.java:207)
    	... 20 more
    Caused by: java.net.SocketException: Broken pipe
    	at java.net.SocketOutputStream.socketWrite0(Native Method)
    	at java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:109)
    	at java.net.SocketOutputStream.write(SocketOutputStream.java:153)
    	at sun.security.ssl.OutputRecord.writeBuffer(OutputRecord.java:431)
    	at sun.security.ssl.OutputRecord.write(OutputRecord.java:417)
    	at sun.security.ssl.SSLSocketImpl.writeRecordInternal(SSLSocketImpl.java:876)
    	at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:847)
    	at sun.security.ssl.AppOutputStream.write(AppOutputStream.java:123)
    	... 29 more
    
    [Wed Oct 04 21:24:48 BST 2017] Unexpected problem running servlet: org.jboss.resteasy.spi.UnhandledException: RESTEASY003770: Response is committed, can't handle exception
    [Wed Oct 04 21:24:48 BST 2017] Unexpected problem running servlet: org.jboss.resteasy.spi.UnhandledException: RESTEASY003770: Response is committed, can't handle exception
    [Wed Oct 04 21:24:48 BST 2017] IO error: javax.net.ssl.SSLException: Connection has been shutdown: javax.net.ssl.SSLException: java.net.SocketException: Broken pipe in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    [Wed Oct 04 21:24:48 BST 2017] IO error: javax.net.ssl.SSLException: Connection has been shutdown: javax.net.ssl.SSLException: java.net.SocketException: Broken pipe in processing a request from /192.168.1.6:8443 / sun.security.ssl.SSLSocketImpl
    

    Hope this helps to improve stability..... 😉


  • ADMIN

    @skywatch Your gateway works after this issue? Are you receiving data from sensors?



  • After this error all data from nodes stops being displayed on the graphs etc, so guess it affects the GW somehow. I believe that all data from mcagent was still working.

    A reboot didn't cure it for more than a few minutes (all nodes seem to work but then after 1 or 2 data packets stop functioning again). - I will try a reinstall from scratch again tonight or tomorrow.

    Thanks.


  • ADMIN

    @skywatch I guess you are using NRF24L01 directly with PI?

    @Tag Are you using NRF24L01 directly with PI? Do you see any issue?



  • I ran tail -f /var/log/syslog and no data is getting through the gateway, hope this helps.

    Yes NRF attached directly to the pi as shown in the mysensors build page.



  • What really puzzles me is how it worked for over a week without issue and then suddenly this.

    Any idea what triggers this to happen?



  • I use mycontroller with HTTP and not HTTP and with esp8266 mqtt-gateway .. no problem so far with Final 1.0.0


  • MOD

    @jkandasa

    Using the OrangePI Zero, nrf24l01 is directly attached to GPIO for a couple of months now. I have not seen any of these issues.

    @skywatch, are you using the latest version of mysgw?
    if so, what is the output of

    mysgw -d
    

    if the above command does not provide any output that shows it connected the radio successfully, check the wiring, another thing i can imagine is that your radio is dead...


  • MOD

    I realized that i was still using the previous release.... just upgraded to Final-1.0.0.. will keep you posted



  • @jkandasa

    pi@HAMASS:~ $ mysgw -d
    mysgw: Starting gateway...
    mysgw: Protocol version - 2.2.0-beta
    mysgw: Couldn't create a symlink '/dev/ttyMySensorsGateway' to PTY! (17) File exists
    mysgw: Failed to open serial port.
    

    Yet it worked for more than a week until the crash....Replaced radio today, still the same....


  • MOD

    @skywatch

    Strange can you post the output of

    ls -la /dev/ttyMySensorsGateway
    

    It should show something like this:

    
    root@orangepizero:~# ls -la /dev/ttyMySensorsGateway
    lrwxrwxrwx 1 root root 10 Oct  7 13:11 /dev/ttyMySensorsGateway -> /dev/pts/0
    

    if not just stop mysgw, and delete the file. mysgw will create a new once mysgw starts.



  • @Tag

    here it is....

     ls -la /dev/ttyMySensorsGateway
    lrwxrwxrwx 1 root root 10 Oct  9 21:19 /dev/ttyMySensorsGateway -> /dev/pts/1
    

    I changed the radio module this evening and rebooted, no change at all.....Puzzled am I.....


  • ADMIN

    @skywatch I believe you might have done these steps already. If not, kindly check it.

    Have you attached capacitor for your NRF24L01+ radio? It works on 3.3 Volts. Kindly check all the details once again from https://www.mysensors.org/build/raspberry Seems the original repo deprecated https://github.com/mysensors/Raspberry


  • MOD

    @skywatch

    Weird, if you kill mysgw, is the device file removed?
    (will dig into this a little later today)



  • So yes capacitor on nrf and 3.28v seen across it, so no problem there. The radio has a single 2x4 connector so all leads stay in position (much quicker) 🙂

    Anyway, today brings a new mystery for me as I did the following.....

    sudo systemctl daemon-reload
    sudo systemctl restart mysgw.service
    sudo systemctl stop mysgw.service
    sudo systemctl start mysgw.service

    Then to see what was going on....
    tail -f /var/log/syslog

    This showed data, so I connected to the web server on the pi and graphs were showing of data received since last night.... It looks like it's all back to normal, except it isn't as I still get exactly the same error message from mysgw -d.

    Weirder still!


  • MOD

    @skywatch

    I have tried your commands:

    sudo systemctl restart mysgw.service
    sudo systemctl stop mysgw.service
    sudo systemctl start mysgw.service
    

    This is my output:

    root@orangepizero:/var/log# tail -f syslog
    Oct 10 22:25:09 localhost systemd[1]: Started MySensors Gateway daemon.
    Oct 10 22:25:09 localhost mysgw: Starting gateway...
    Oct 10 22:25:09 localhost mysgw: Protocol version - 2.2.0-beta
    Oct 10 22:25:39 localhost systemd[1]: Stopping MySensors Gateway daemon...
    Oct 10 22:25:39 localhost mysgw: Received SIGTERM
    Oct 10 22:25:39 localhost systemd[1]: Stopped MySensors Gateway daemon.
    Oct 10 22:25:56 localhost systemd[1]: Starting MySensors Gateway daemon...
    Oct 10 22:25:56 localhost systemd[1]: Started MySensors Gateway daemon.
    Oct 10 22:25:56 localhost mysgw: Starting gateway...
    Oct 10 22:25:56 localhost mysgw: Protocol version - 2.2.0-beta
    

    Does this match your output?

    looking at the /dev/ device directory, the device file /dev/ttyMySensorsGateway is gone once stopped. and recreated when the mysgw daemon started again...

    (i also had to re-enable the GW in mycontroller...since it got disabled...)


  • MOD

    @skywatch

    the link seems okay. now i am wondering what is behind the link...

    root@orangepizero:~/MySensors/bin# ls -l  /dev/ttyMySensorsGateway 
    lrwxrwxrwx 1 root root 10 Oct 12 18:45 /dev/ttyMySensorsGateway -> /dev/pts/2
    root@orangepizero:~/MySensors/bin# ll /dev/pts/2
    crw--w---- 1 root tty 136, 2 Oct 12 18:46 /dev/pts/2
    

    if you do an

    ls -l /dev/pts/1
    

    what does that look like?

    did you use the correct flags to build mysgw? (as described here)



  • @Tag
    thanks for the support but the mystery is solved (at least this bit) - I rebooted the pi before giving the mysgw -d and of course mysgw was already started at boot and so was trying to start a second session and that is why the strange messages happened.

    I have the system working again now and hope that it will stay that way for many weeks! ......


  • MOD

    @skywatch said in Final 1.0.0 errors and crash report....:

    but the mystery is solved (at least this

    ah okay!! good!,
    It will stay running 😉

    good luck!



  • It didn't stay running - It crashed again.

    Nothing in the myc log.
    The MYSGW log shows data still being received from the sensor nodes.

    Now I am stumped.....really stumped, as to how to get this sorted out......


 

Suggested Topics

10
Online

363
Users

348
Topics

2.1k
Posts