search

IOT-DSA / dslink-java-opc

OPC DSLink
GNU General Public License v3.0
3 stars 3 forks source link

Server Crashing #2

Closed xof1986 closed 8 years ago

xof1986 commented 8 years ago

When adding a connection I enter... name: OPC Server host: nameOfHost domain: localhost user: nameOfUser password: passwordForUser

The OPC Server application throws an error saying it has lost communication with the OPC Server ( which is hosted locally on the machine) and the server reboots.

I see no information in the logs generated by Windows, the OPC Server, or the DGLux Server.

dglogik commented 8 years ago

Which OPC server are you using? Have you verified all the proper DCOM security configuration?

xof1986 commented 8 years ago

We are using KEPDirect v5 which is, I believe, the predecessor or KEPWare Server.

I have not messed with DCOM at all, I am very new to all of this. I will look in to it.

Thank You!

dglogik commented 8 years ago

The dslink currently supports OPC DA 2.0. I would recommend that you first try to use this tool to verify that everything is properly setup and working. http://www.matrikonopc.com/products/opc-desktop-tools/opc-explorer.aspx

xof1986 commented 8 years ago

I don't feel comfortable changing any of the current DCOM settings since this is a live production server so if that is necessary then I will need to wait on that.

The OPC-Explorer software is able to connect and it shows it as supporting OPC DA however it fails the security check and reports potential security risks.

dglogik commented 8 years ago

Can you tell me what is crashing specifically? If you get the log for the dslink sys->links->opc (right-click) get log

xof1986 commented 8 years ago

The server stops responding and reboots.

Here is the log up until the crash. This is for the second crash. The first looks similar.

[2016-01-05 15:25:11.837] == Executing E:\DSA\dglux-server\dslinks\dslink-java-opc\bin\dslink-java-opc.bat with arguments [--name, OPC, --nodes, nodes.json, --key, .key, --log, info, --broker, http://127.0.0.1:1317/conn, --token, X3zZNshYtUM3I2B9trdrSbxAGbxMtmJgO2H9FsZUXQ4164bc](pid: 5996) == [2016-01-05 15:25:14.868] 2016-01-05 15:25:14.865 [nioEventLoopGroup-0-0] INFO opc.Main - Connected [2016-01-05 15:25:14.946] Jan 05, 2016 3:25:14 PM org.jinterop.dcom.common.JISystem logSystemPropertiesAndVersion [2016-01-05 15:25:14.946] INFO: j-Interop Version = null [2016-01-05 15:25:14.946] [2016-01-05 15:25:14.949] Jan 05, 2016 3:25:14 PM org.jinterop.dcom.common.JISystem logSystemPropertiesAndVersion [2016-01-05 15:25:14.949] INFO: java.runtime.name = Java(TM) SE Runtime Environment [2016-01-05 15:25:14.949] sun.boot.library.path = C:\Program Files\Java\jre1.8.0_51\bin [2016-01-05 15:25:14.950] java.vm.version = 25.51-b03 [2016-01-05 15:25:14.950] java.vm.vendor = Oracle Corporation [2016-01-05 15:25:14.950] java.vendor.url = http://java.oracle.com/ [2016-01-05 15:25:14.950] path.separator = ; [2016-01-05 15:25:14.950] java.vm.name = Java HotSpot(TM) Client VM [2016-01-05 15:25:14.950] file.encoding.pkg = sun.io [2016-01-05 15:25:14.951] user.country = US [2016-01-05 15:25:14.951] user.script = [2016-01-05 15:25:14.951] sun.java.launcher = SUN_STANDARD [2016-01-05 15:25:14.951] sun.os.patch.level = Service Pack 2 [2016-01-05 15:25:14.951] java.vm.specification.name = Java Virtual Machine Specification [2016-01-05 15:25:14.952] user.dir = E:\DSA\dglux-server\dslinks\dslink-java-opc [2016-01-05 15:25:14.952] java.runtime.version = 1.8.0_51-b16 [2016-01-05 15:25:14.952] java.awt.graphicsenv = sun.awt.Win32GraphicsEnvironment [2016-01-05 15:25:14.952] java.endorsed.dirs = C:\Program Files\Java\jre1.8.0_51\lib\endorsed [2016-01-05 15:25:14.959] os.arch = x86 [2016-01-05 15:25:14.959] java.io.tmpdir = C:\Users\ERMSAD~1\AppData\Local\Temp\ [2016-01-05 15:25:14.959] line.separator = [2016-01-05 15:25:14.959] [2016-01-05 15:25:14.959] java.vm.specification.vendor = Oracle Corporation [2016-01-05 15:25:14.960] user.variant = [2016-01-05 15:25:14.960] os.name = Windows Server 2008 [2016-01-05 15:25:14.960] sun.jnu.encoding = Cp1252 [2016-01-05 15:25:14.960] java.library.path = C:\ProgramData\Oracle\Java\javapath;C:\Windows\Sun\Java\bin;C:\Windows\system32;C:\Windows;C:\ProgramData\Oracle\Java\javapath;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files\Microsoft SQL Server\90\Tools\binn\;C:\Program Files\Dell\SysMgt\oma\bin;C:\Program Files\Dell\SysMgt\shared\bin;C:\Program Files\Dell\SysMgt\idrac;. [2016-01-05 15:25:14.960] sun.nio.ch.bugLevel = [2016-01-05 15:25:14.960] java.specification.name = Java Platform API Specification [2016-01-05 15:25:14.960] java.class.version = 52.0 [2016-01-05 15:25:14.961] sun.management.compiler = HotSpot Client Compiler [2016-01-05 15:25:14.961] os.version = 6.0 [2016-01-05 15:25:14.961] user.home = C:\Users\ermsadmin [2016-01-05 15:25:14.961] user.timezone = America/New_York [2016-01-05 15:25:14.961] java.awt.printerjob = sun.awt.windows.WPrinterJob [2016-01-05 15:25:14.961] file.encoding = Cp1252 [2016-01-05 15:25:14.961] java.specification.version = 1.8 [2016-01-05 15:25:14.961] java.class.path = E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\dslink-java-opc-0.2.7-SNAPSHOT.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.external.sdk_1.4.0.v20150417-0947.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.utgard_1.4.0.v20150424-1204.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.jinterop_1.4.0.v20150417-0949.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.external.jcifs_1.2.25.201407161156.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.jinterop.sdk_1.4.0.v20150417-0949.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.opc.xmlda_1.4.0.v20150424-1204.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.opc.lib_1.3.0.v20141118-1249.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.jinterop.deps_1.3.0.v20141013-0754.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.external_1.4.0.v20150417-0947.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.opc.dcom_1.2.0.v20141105-1322.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.jinterop.core_2.1.8.v20140625-1417.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.openscada.utgard.sdk_1.4.0.v20150424-1204.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\dslink-0.12.0.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\commons-logging-1.1.1.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\commons-lang3-3.4.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\org.eclipse.scada.utils-0.3.0-SNAPSHOT.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\runtime_shared-0.12.0.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\logging-0.12.0.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\commons-beanutils-1.9.2.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\jackson-core-2.6.2.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\jcommander-1.48.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\bcprov-jdk15on-1.51.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\netty-all-5.0.0.Alpha2.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\commons-collections-3.2.1.jar;E:\DSA\dglux-server\dslinks\dslink-java-opc\bin..\lib\slf4j-api-1.7.12.jar [2016-01-05 15:25:14.962] user.name = ermsadmin [2016-01-05 15:25:14.962] java.vm.specification.version = 1.8 [2016-01-05 15:25:14.962] sun.java.command = opc.Main --name OPC --nodes nodes.json --key .key --log info --broker http://127.0.0.1:1317/conn --token X3zZNshYtUM3I2B9trdrSbxAGbxMtmJgO2H9FsZUXQ4164bc [2016-01-05 15:25:14.962] java.home = C:\Program Files\Java\jre1.8.0_51 [2016-01-05 15:25:14.962] sun.arch.data.model = 32 [2016-01-05 15:25:14.962] user.language = en [2016-01-05 15:25:14.963] java.specification.vendor = Oracle Corporation [2016-01-05 15:25:14.963] awt.toolkit = sun.awt.windows.WToolkit [2016-01-05 15:25:14.963] java.vm.info = mixed mode [2016-01-05 15:25:14.963] java.version = 1.8.0_51 [2016-01-05 15:25:14.963] java.ext.dirs = C:\Program Files\Java\jre1.8.0_51\lib\ext;C:\Windows\Sun\Java\lib\ext [2016-01-05 15:25:14.963] sun.boot.class.path = C:\Program Files\Java\jre1.8.0_51\lib\resources.jar;C:\Program Files\Java\jre1.8.0_51\lib\rt.jar;C:\Program Files\Java\jre1.8.0_51\lib\sunrsasign.jar;C:\Program Files\Java\jre1.8.0_51\lib\jsse.jar;C:\Program Files\Java\jre1.8.0_51\lib\jce.jar;C:\Program Files\Java\jre1.8.0_51\lib\charsets.jar;C:\Program Files\Java\jre1.8.0_51\lib\jfr.jar;C:\Program Files\Java\jre1.8.0_51\classes [2016-01-05 15:25:14.963] java.vendor = Oracle Corporation [2016-01-05 15:25:14.964] file.separator = \ [2016-01-05 15:25:14.964] java.vendor.url.bug = http://bugreport.sun.com/bugreport/ [2016-01-05 15:25:14.964] sun.io.unicode.encoding = UnicodeLittle [2016-01-05 15:25:14.964] sun.cpu.endian = little [2016-01-05 15:25:14.964] sun.desktop = windows [2016-01-05 15:25:14.964] sun.cpu.isalist = [2016-01-05 15:25:14.964] [2016-01-05 15:25:14.966] 2016-01-05 15:25:14.955 [Timer-2] INFO org.jinterop.dcom.core.JIComOxidRuntime - Running ServerPingTimerTask ! [2016-01-05 15:25:14.966] 2016-01-05 15:25:14.955 [Timer-1] INFO org.jinterop.dcom.core.JIComOxidRuntime - Running ClientPingTimerTask ! [2016-01-05 15:25:14.966] 2016-01-05 15:25:14.956 [nioEventLoopGroup-0-0] INFO org.jinterop.dcom.core.JISession - Created Session: 1873370910 [2016-01-05 15:25:14.982] Jan 05, 2016 3:25:14 PM org.jinterop.dcom.common.JISystem internal_dumpMap [2016-01-05 15:25:14.983] INFO: mapOfHostnamesVsIPs: {} [2016-01-05 15:25:15.043] Jan 05, 2016 3:25:15 PM rpc.DefaultConnection processOutgoing [2016-01-05 15:25:15.044] INFO: [2016-01-05 15:25:15.044] Sending BIND [2016-01-05 15:25:15.061] Jan 05, 2016 3:25:15 PM rpc.DefaultConnection processIncoming [2016-01-05 15:25:15.061] INFO: [2016-01-05 15:25:15.062] Recieved BIND_ACK [2016-01-05 15:25:15.067] Jan 05, 2016 3:25:15 PM rpc.DefaultConnection processOutgoing [2016-01-05 15:25:15.067] INFO: [2016-01-05 15:25:15.067] Sending AUTH3 [2016-01-05 15:25:15.339] Jan 05, 2016 3:25:15 PM rpc.DefaultConnection processOutgoing [2016-01-05 15:25:15.339] INFO: [2016-01-05 15:25:15.339] Sending ALTER_CTX [2016-01-05 15:25:15.344] Jan 05, 2016 3:25:15 PM rpc.DefaultConnection processIncoming [2016-01-05 15:25:15.344] INFO: [2016-01-05 15:25:15.344] Recieved ALTER_CTX_RESP [2016-01-05 15:25:15.537] Jan 05, 2016 3:25:15 PM rpc.DefaultConnection processOutgoing [2016-01-05 15:25:15.537] INFO: [2016-01-05 15:25:15.537] Sending REQUEST [2016-01-05 15:25:18.721] 2016-01-05 15:25:18.720 [nioEventLoopGroup-0-0] INFO org.jinterop.dcom.core.JISession - Created Session: 1780120132 [2016-01-05 15:25:18.722] Jan 05, 2016 3:25:18 PM org.jinterop.dcom.common.JISystem internal_dumpMap [2016-01-05 15:25:18.723] INFO: mapOfHostnamesVsIPs: {} [2016-01-05 15:25:19.727] 2016-01-05 15:25:19.726 [nioEventLoopGroup-0-0] INFO org.jinterop.dcom.core.JISession - Created Session: 796075129 [2016-01-05 15:25:19.728] Jan 05, 2016 3:25:19 PM org.jinterop.dcom.common.JISystem internal_dumpMap [2016-01-05 15:25:19.728] INFO: mapOfHostnamesVsIPs: {} [2016-01-05 15:25:20.844] 2016-01-05 15:25:20.843 [nioEventLoopGroup-0-0] INFO org.openscada.opc.lib.da.Server - Socket timeout: 0 [2016-01-05 15:25:20.845] 2016-01-05 15:25:20.844 [nioEventLoopGroup-0-0] INFO org.jinterop.dcom.core.JISession - Created Session: -1614392772 [2016-01-05 15:25:20.849] Jan 05, 2016 3:25:20 PM org.jinterop.dcom.common.JISystem saveDBPathAndLoadFile [2016-01-05 15:25:20.849] INFO: progIdVsClsidDB file located at: jar:file:/E:/DSA/dglux-server/dslinks/dslink-java-opc/lib/org.openscada.opc.dcom_1.2.0.v20141105-1322.jar!/progIdVsClsidDB.properties [2016-01-05 15:25:20.851] Jan 05, 2016 3:25:20 PM org.jinterop.dcom.common.JISystem saveDBPathAndLoadFile [2016-01-05 15:25:20.852] INFO: progIdVsClsidDB: {Word.Application=000209ff-0000-0000-c000-000000000046, TestCOM123.TestServer2=92a065a9-106a-4cc3-8d67-43e3a1e73df3, SYSINFO.SysInfo=6fba474b-43ac-11ce-9a0e-00aa0062bb4c, ADODB.Connection=00000514-0000-0010-8000-00aa006d2ea4, TestJavaServer.TestServer2=617d5a31-a3bf-440f-a58f-1f57f6ac7527, TestJavaServer.TestServer1=56bad610-0fcb-418a-b25e-174159a4adce, InternetExplorer.Application=0002df01-0000-0000-c000-000000000046, Excel.Application=00024500-0000-0000-c000-000000000046, StdCollection.VBCollection=4b738074-ea47-11d2-b25a-00105a022091, PowerPoint.Application=91493441-5a91-11cf-8700-00aa0060263b, WbemScripting.SWbemLocator=76a64158-cb41-11d1-8b02-00600806d9b6} [2016-01-05 15:25:21.072] Jan 05, 2016 3:25:21 PM rpc.DefaultConnection processOutgoing [2016-01-05 15:25:21.073] INFO: [2016-01-05 15:25:21.073] Sending BIND [2016-01-05 15:25:33.704] Jan 05, 2016 3:25:33 PM rpc.DefaultConnection processIncoming [2016-01-05 15:25:33.704] INFO: [2016-01-05 15:25:33.704] Recieved BIND_ACK [2016-01-05 15:25:33.706] Jan 05, 2016 3:25:33 PM rpc.DefaultConnection processOutgoing [2016-01-05 15:25:33.706] INFO: [2016-01-05 15:25:33.706] Sending REQUEST [2016-01-05 15:25:33.708] Jan 05, 2016 3:25:33 PM rpc.DefaultConnection processIncoming [2016-01-05 15:25:33.708] INFO: [2016-01-05 15:25:33.708] Recieved FAULT [2016-01-05 15:25:33.719] 2016-01-05 15:25:33.717 [nioEventLoopGroup-0-0] INFO org.openscada.opc.lib.da.Server - Failed to connect to server [2016-01-05 15:25:33.720] org.jinterop.dcom.common.JIException: Unable to access Windows Registry, please check whether the SERVER service is running on the Target Workstation. [0x00001031] [2016-01-05 15:25:33.720] at org.jinterop.winreg.smb.JIWinRegStub.winreg_OpenHKLM(JIWinRegStub.java:125) [2016-01-05 15:25:33.720] at org.jinterop.dcom.core.JIProgId.getIdFromWinReg(JIProgId.java:145) [2016-01-05 15:25:33.720] at org.jinterop.dcom.core.JIProgId.getCorrespondingCLSID(JIProgId.java:181) [2016-01-05 15:25:33.720] at org.jinterop.dcom.core.JIComServer.(JIComServer.java:483) [2016-01-05 15:25:33.720] at org.openscada.opc.lib.da.Server.connect(Server.java:114) [2016-01-05 15:25:33.720] at opc.ComServer.connect(ComServer.java:92) [2016-01-05 15:25:33.721] at opc.OpcServer.init(OpcServer.java:59) [2016-01-05 15:25:33.721] at opc.OpcServer.restoreLastSession(OpcServer.java:165) [2016-01-05 15:25:33.721] at opc.OpcConn.restoreLastSession(OpcConn.java:197) [2016-01-05 15:25:33.721] at opc.OpcLink.restoreLastSession(OpcLink.java:55) [2016-01-05 15:25:33.721] at opc.OpcLink.init(OpcLink.java:34) [2016-01-05 15:25:33.721] at opc.OpcLink.start(OpcLink.java:30) [2016-01-05 15:25:33.721] at opc.Main.onResponderConnected(Main.java:37) [2016-01-05 15:25:33.722] at org.dsa.iot.dslink.DSLinkProvider$1$2$1.handle(DSLinkProvider.java:121) [2016-01-05 15:25:33.722] at org.dsa.iot.dslink.DSLinkProvider$1$2$1.handle(DSLinkProvider.java:118) [2016-01-05 15:25:33.722] at org.dsa.iot.dslink.connection.ConnectionManager$ClientConnected.connected(ConnectionManager.java:255) [2016-01-05 15:25:33.722] at org.dsa.iot.dslink.connection.ConnectionManager$1$2.handle(ConnectionManager.java:105) [2016-01-05 15:25:33.722] at org.dsa.iot.dslink.connection.ConnectionManager$1$2.handle(ConnectionManager.java:99) [2016-01-05 15:25:33.722] at org.dsa.iot.dslink.connection.connector.WebSocketConnector$WsHandler.onConnected(WebSocketConnector.java:127) [2016-01-05 15:25:33.722] at org.dsa.iot.dslink.provider.netty.DefaultWsProvider$WebSocketHandler.messageReceived(DefaultWsProvider.java:116) [2016-01-05 15:25:33.723] at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105) [2016-01-05 15:25:33.723] at io.netty.channel.ChannelHandlerInvokerUtil.invokeChannelReadNow(ChannelHandlerInvokerUtil.java:84) [2016-01-05 15:25:33.723] at io.netty.channel.DefaultChannelHandlerInvoker.invokeChannelRead(DefaultChannelHandlerInvoker.java:153) [2016-01-05 15:25:33.723] at io.netty.channel.PausableChannelEventExecutor.invokeChannelRead(PausableChannelEventExecutor.java:86) [2016-01-05 15:25:33.727] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:389) [2016-01-05 15:25:33.727] at io.netty.channel.ChannelHandlerAdapter.channelRead(ChannelHandlerAdapter.java:143) [2016-01-05 15:25:33.728] at io.netty.handler.codec.http.websocketx.extensions.WebSocketClientExtensionHandler.channelRead(WebSocketClientExtensionHandler.java:128) [2016-01-05 15:25:33.728] at io.netty.channel.ChannelHandlerInvokerUtil.invokeChannelReadNow(ChannelHandlerInvokerUtil.java:84) [2016-01-05 15:25:33.728] at io.netty.channel.DefaultChannelHandlerInvoker.invokeChannelRead(DefaultChannelHandlerInvoker.java:153) [2016-01-05 15:25:33.728] at io.netty.channel.PausableChannelEventExecutor.invokeChannelRead(PausableChannelEventExecutor.java:86) [2016-01-05 15:25:33.728] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:389) [2016-01-05 15:25:33.728] at io.netty.handler.codec.MessageToMessageDecoder.channelRead(MessageToMessageDecoder.java:103) [2016-01-05 15:25:33.728] at io.netty.channel.ChannelHandlerInvokerUtil.invokeChannelReadNow(ChannelHandlerInvokerUtil.java:84) [2016-01-05 15:25:33.729] at io.netty.channel.DefaultChannelHandlerInvoker.invokeChannelRead(DefaultChannelHandlerInvoker.java:153) [2016-01-05 15:25:33.729] at io.netty.channel.PausableChannelEventExecutor.invokeChannelRead(PausableChannelEventExecutor.java:86) [2016-01-05 15:25:33.729] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:389) [2016-01-05 15:25:33.729] at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:243) [2016-01-05 15:25:33.729] at io.netty.channel.ChannelHandlerInvokerUtil.invokeChannelReadNow(ChannelHandlerInvokerUtil.java:84) [2016-01-05 15:25:33.729] at io.netty.channel.DefaultChannelHandlerInvoker.invokeChannelRead(DefaultChannelHandlerInvoker.java:153) [2016-01-05 15:25:33.729] at io.netty.channel.PausableChannelEventExecutor.invokeChannelRead(PausableChannelEventExecutor.java:86) [2016-01-05 15:25:33.729] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:389) [2016-01-05 15:25:33.730] at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:956) [2016-01-05 15:25:33.730] at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:127) [2016-01-05 15:25:33.730] at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:514) [2016-01-05 15:25:33.730] at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:471) [2016-01-05 15:25:33.730] at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:385) [2016-01-05 15:25:33.730] at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:351) [2016-01-05 15:25:33.730] at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:116) [2016-01-05 15:25:33.731] at io.netty.util.internal.chmv8.ForkJoinTask$RunnableExecuteAction.exec(ForkJoinTask.java:1412) [2016-01-05 15:25:33.731] at io.netty.util.internal.chmv8.ForkJoinTask.doExec(ForkJoinTask.java:280) [2016-01-05 15:25:33.731] at io.netty.util.internal.chmv8.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:877) [2016-01-05 15:25:33.731] at io.netty.util.internal.chmv8.ForkJoinPool.scan(ForkJoinPool.java:1706) [2016-01-05 15:25:33.731] at io.netty.util.internal.chmv8.ForkJoinPool.runWorker(ForkJoinPool.java:1661) [2016-01-05 15:25:33.731] at io.netty.util.internal.chmv8.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:126) [2016-01-05 15:25:33.731] Caused by: rpc.FaultException: Received fault. (unknown) [2016-01-05 15:25:33.731] at rpc.ConnectionOrientedEndpoint.call(ConnectionOrientedEndpoint.java:147) [2016-01-05 15:25:33.731] at rpc.Stub.call(Stub.java:134) [2016-01-05 15:25:33.732] at org.jinterop.winreg.smb.JIWinRegStub.winreg_OpenHKLM(JIWinRegStub.java:117) [2016-01-05 15:25:33.732] ... 53 more [2016-01-05 15:25:33.734] [2016-01-05 15:25:33.735] Jan 05, 2016 3:25:33 PM rpc.DefaultConnection processOutgoing [2016-01-05 15:25:33.735] INFO: [2016-01-05 15:25:33.735] Sending BIND [2016-01-05 15:25:33.737] 2016-01-05 15:25:33.717 [nioEventLoopGroup-0-0] INFO org.openscada.opc.lib.da.Server - Destroying DCOM session... [2016-01-05 15:25:33.737] 2016-01-05 15:25:33.719 [nioEventLoopGroup-0-0] INFO org.openscada.opc.lib.da.Server - Destroying DCOM session... forked [2016-01-05 15:25:33.737] 2016-01-05 15:25:33.720 [nioEventLoopGroup-0-0] INFO org.openscada.opc.lib.da.Server - Socket timeout: 0 [2016-01-05 15:25:33.737] 2016-01-05 15:25:33.720 [OPCSessionDestructor] INFO org.jinterop.dcom.core.JISession - About to destroy 0 sessesion which are linked to this session: -1614392772 [2016-01-05 15:25:33.737] 2016-01-05 15:25:33.720 [nioEventLoopGroup-0-0] INFO org.jinterop.dcom.core.JISession - Created Session: 1082511902 [2016-01-05 15:25:33.737] 2016-01-05 15:25:33.720 [OPCSessionDestructor] INFO org.jinterop.dcom.core.JIComOxidRuntime - destroySessionOIDs for session: -1614392772 [2016-01-05 15:25:33.737] 2016-01-05 15:25:33.721 [OPCSessionDestructor] INFO org.openscada.opc.lib.da.Server - Destructed DCOM session [2016-01-05 15:25:33.737] 2016-01-05 15:25:33.721 [OPCSessionDestructor] INFO org.openscada.opc.lib.da.Server - Session destruction took 2 ms [2016-01-05 15:25:33.738] 2016-01-05 15:25:33.731 [nioEventLoopGroup-0-0] INFO org.openscada.opc.lib.da.Server - Failed to connect to server [2016-01-05 15:25:33.738] org.jinterop.dcom.common.JIException: Unable to access Windows Registry, please check whether the SERVER service is running on the Target Workstation. [0x00001031] [2016-01-05 15:25:33.738] at org.jinterop.winreg.smb.JIWinRegStub.winreg_OpenHKLM(JIWinRegStub.java:125) [2016-01-05 15:25:33.738] at org.jinterop.dcom.core.JIProgId.getIdFromWinReg(JIProgId.java:145) [2016-01-05 15:25:33.738] at org.jinterop.dcom.core.JIProgId.getCorrespondingCLSID(JIProgId.java:181) [2016-01-05 15:25:33.738] at org.jinterop.dcom.core.JIComServer.(JIComServer.java:483) [2016-01-05 15:25:33.738] at org.openscada.opc.lib.da.Server.connect(Server.java:114) [2016-01-05 15:25:33.738] at opc.ComServer.connect(ComServer.java:120) [2016-01-05 15:25:33.739] at opc.OpcServer.init(OpcServer.java:59) [2016-01-05 15:25:33.739] at opc.OpcServer.restoreLastSession(OpcServer.java:165) [2016-01-05 15:25:33.739] at opc.OpcConn.restoreLastSession(OpcConn.java:197) [2016-01-05 15:25:33.739] at opc.OpcLink.restoreLastSession(OpcLink.java:55) [2016-01-05 15:25:33.739] at opc.OpcLink.init(OpcLink.java:34) [2016-01-05 15:25:33.739] at opc.OpcLink.start(OpcLink.java:30) [2016-01-05 15:25:33.739] at opc.Main.onResponderConnected(Main.java:37) [2016-01-05 15:25:33.739] at org.dsa.iot.dslink.DSLinkProvider$1$2$1.handle(DSLinkProvider.java:121) [2016-01-05 15:25:33.739] at org.dsa.iot.dslink.DSLinkProvider$1$2$1.handle(DSLinkProvider.java:118) [2016-01-05 15:25:33.740] at org.dsa.iot.dslink.connection.ConnectionManager$ClientConnected.connected(ConnectionManager.java:255) [2016-01-05 15:25:33.740] at org.dsa.iot.dslink.connection.ConnectionManager$1$2.handle(ConnectionManager.java:105) [2016-01-05 15:25:33.740] at org.dsa.iot.dslink.connection.ConnectionManager$1$2.handle(ConnectionManager.java:99) [2016-01-05 15:25:33.740] at org.dsa.iot.dslink.connection.connector.WebSocketConnector$WsHandler.onConnected(WebSocketConnector.java:127) [2016-01-05 15:25:33.740] at org.dsa.iot.dslink.provider.netty.DefaultWsProvider$WebSocketHandler.messageReceived(DefaultWsProvider.java:116) [2016-01-05 15:25:33.740] at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105) [2016-01-05 15:25:33.740] at io.netty.channel.ChannelHandlerInvokerUtil.invokeChannelReadNow(ChannelHandlerInvokerUtil.java:84) [2016-01-05 15:25:33.740] at io.netty.channel.DefaultChannelHandlerInvoker.invokeChannelRead(DefaultChannelHandlerInvoker.java:153) [2016-01-05 15:25:33.741] at io.netty.channel.PausableChannelEventExecutor.invokeChannelRead(PausableChannelEventExecutor.java:86) [2016-01-05 15:25:33.741] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:389) [2016-01-05 15:25:33.741] at io.netty.channel.ChannelHandlerAdapter.channelRead(ChannelHandlerAdapter.java:143) [2016-01-05 15:25:33.741] at io.netty.handler.codec.http.websocketx.extensions.WebSocketClientExtensionHandler.channelRead(WebSocketClientExtensionHandler.java:128) [2016-01-05 15:25:33.741] at io.netty.channel.ChannelHandlerInvokerUtil.invokeChannelReadNow(ChannelHandlerInvokerUtil.java:84) [2016-01-05 15:25:33.741] at io.netty.channel.DefaultChannelHandlerInvoker.invokeChannelRead(DefaultChannelHandlerInvoker.java:153) [2016-01-05 15:25:33.741] at io.netty.channel.PausableChannelEventExecutor.invokeChannelRead(PausableChannelEventExecutor.java:86) [2016-01-05 15:25:33.741] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:389) [2016-01-05 15:25:33.742] at io.netty.handler.codec.MessageToMessageDecoder.channelRead(MessageToMessageDecoder.java:103) [2016-01-05 15:25:33.742] at io.netty.channel.ChannelHandlerInvokerUtil.invokeChannelReadNow(ChannelHandlerInvokerUtil.java:84) [2016-01-05 15:25:33.742] at io.netty.channel.DefaultChannelHandlerInvoker.invokeChannelRead(DefaultChannelHandlerInvoker.java:153) [2016-01-05 15:25:33.742] at io.netty.channel.PausableChannelEventExecutor.invokeChannelRead(PausableChannelEventExecutor.java:86) [2016-01-05 15:25:33.742] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:389) [2016-01-05 15:25:33.742] at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:243) [2016-01-05 15:25:33.742] at io.netty.channel.ChannelHandlerInvokerUtil.invokeChannelReadNow(ChannelHandlerInvokerUtil.java:84) [2016-01-05 15:25:33.742] at io.netty.channel.DefaultChannelHandlerInvoker.invokeChannelRead(DefaultChannelHandlerInvoker.java:153) [2016-01-05 15:25:33.742] at io.netty.channel.PausableChannelEventExecutor.invokeChannelRead(PausableChannelEventExecutor.java:86) [2016-01-05 15:25:33.743] at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:389) [2016-01-05 15:25:33.743] at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:956) [2016-01-05 15:25:33.743] at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:127) [2016-01-05 15:25:33.743] at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:514) [2016-01-05 15:25:33.743] at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:471) [2016-01-05 15:25:33.743] at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:385) [2016-01-05 15:25:33.743] at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:351) [2016-01-05 15:25:33.743] at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:116) [2016-01-05 15:25:33.744] at io.netty.util.internal.chmv8.ForkJoinTask$RunnableExecuteAction.exec(ForkJoinTask.java:1412) [2016-01-05 15:25:33.744] at io.netty.util.internal.chmv8.ForkJoinTask.doExec(ForkJoinTask.java:280) [2016-01-05 15:25:33.744] at io.netty.util.internal.chmv8.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:877) [2016-01-05 15:25:33.744] at io.netty.util.internal.chmv8.ForkJoinPool.scan(ForkJoinPool.java:1706) [2016-01-05 15:25:33.744] at io.netty.util.internal.chmv8.ForkJoinPool.runWorker(ForkJoinPool.java:1661) [2016-01-05 15:25:33.744] at io.netty.util.internal.chmv8.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:126) [2016-01-05 15:25:33.744] Caused by: rpc.FaultException: Received fault. (unknown) [2016-01-05 15:25:33.744] at rpc.ConnectionOrientedEndpoint.call(ConnectionOrientedEndpoint.java:147) [2016-01-05 15:25:33.745] at rpc.Stub.call(Stub.java:134) [2016-01-05 15:25:33.745] at org.jinterop.winreg.smb.JIWinRegStub.winreg_OpenHKLM(JIWinRegStub.java:117) [2016-01-05 15:25:33.745] ... 53 more [2016-01-05 15:25:33.746] Jan 05, 2016 3:25:33 PM rpc.DefaultConnection processIncoming [2016-01-05 15:25:33.746] INFO: [2016-01-05 15:25:33.746] Recieved BIND_ACK [2016-01-05 15:25:33.746] Jan 05, 2016 3:25:33 PM rpc.DefaultConnection processOutgoing [2016-01-05 15:25:33.747] INFO: [2016-01-05 15:25:33.747] Sending REQUEST [2016-01-05 15:25:33.747] Jan 05, 2016 3:25:33 PM rpc.DefaultConnection processIncoming [2016-01-05 15:25:33.747] INFO: [2016-01-05 15:25:33.747] Recieved FAULT [2016-01-05 15:25:33.747] [2016-01-05 15:25:33.748] 2016-01-05 15:25:33.733 [nioEventLoopGroup-0-0] INFO org.openscada.opc.lib.da.Server - Destroying DCOM session... [2016-01-05 15:25:33.748] 2016-01-05 15:25:33.733 [nioEventLoopGroup-0-0] INFO org.openscada.opc.lib.da.Server - Destroying DCOM session... forked [2016-01-05 15:25:33.748] 2016-01-05 15:25:33.734 [OPCSessionDestructor] INFO org.jinterop.dcom.core.JISession - About to destroy 0 sessesion which are linked to this session: 1082511902 [2016-01-05 15:25:33.748] 2016-01-05 15:25:33.734 [OPCSessionDestructor] INFO org.jinterop.dcom.core.JIComOxidRuntime - destroySessionOIDs for session: 1082511902 [2016-01-05 15:25:33.748] 2016-01-05 15:25:33.734 [OPCSessionDestructor] INFO org.openscada.opc.lib.da.Server - Destructed DCOM session [2016-01-05 15:25:33.748] 2016-01-05 15:25:33.734 [OPCSessionDestructor] INFO org.openscada.opc.lib.da.Server - Session destruction took 1 ms [2016-01-05 15:26:22.661] 2016-01-05 15:26:22.660 [Thread-12] INFO org.jinterop.dcom.core.JISession - Created Session: 800103946 [2016-01-05 15:26:22.664] Jan 05, 2016 3:26:22 PM org.jinterop.dcom.common.JISystem internal_dumpMap [2016-01-05 15:26:22.664] INFO: mapOfHostnamesVsIPs: {}

dglogik commented 8 years ago

Are the Matrikon client and the dslink being run on same machine?

xof1986 commented 8 years ago

Yes, they are both on the same machine.

xof1986 commented 8 years ago

I created a new server to start fresh for testing. This is no longer an issue to me.