Hello,
I have got a problem with the OPC-UA Client in 7.6.1-rc when a remote server is connected. I’m not sure if this is new to 7.6 as i never used such a configuration before.
To prepare the migration from 7.5 to 7.6 i added a OPC-UA connection from the 7.6 test system to the 7.5.6 production system. After that, i see all OPC-UA items on the 7.6 system stale for some minutes after a gateway restart. The problem is not reproduceable on every getway restart, but the chance to trigger it increases with the waiting time between stop an restart.
I added a log file of the intersting time span, here is a short summary:
INFO | jvm 1 | 2013/05/17 11:54:23 | ERROR [LocalDBManagerImpl ] [11:54:23,659]: Error updating features for module: modbusdriver2
INFO | jvm 1 | 2013/05/17 11:54:23 | java.sql.SQLSyntaxErrorException: user lacks privilege or object not found: PUBLIC.MODBUSRTUDRIVERSETTINGS
This happened already before adding the remote connection and seems to cause no problems.
INFO | jvm 1 | 2013/05/17 11:54:32 | ERROR [OpcUaConnection:Ignition OPC-UA Server] [11:54:32,151]: Reading server time and state timed out, disconnecting...
...
The connected Modbus devices close the connection here, because they have seen no activity afetr the initial connect.
INFO | jvm 1 | 2013/05/17 11:55:25 | ERROR [SocketIODelegate ] [11:55:25,818]: [hostname=10.224.62.80,port=502] Socket connection closed, DriverState was Connected.
INFO | jvm 1 | 2013/05/17 11:55:25 | java.io.IOException: End of stream reached.
...
INFO | jvm 1 | 2013/05/17 11:56:27 | ERROR [SubscriptionManager ] [11:56:27,026]: Error adding 1 nodes to subscription 'Scanclass 'emErwZustand[default]'' @ 1 seconds.
INFO | jvm 1 | 2013/05/17 11:56:27 | StatusCode[Severity=Bad, Subcode=Bad_Timeout]: Request timed out after 120000 milliseconds.
INFO | jvm 1 | 2013/05/17 11:56:27 | ERROR [SubscriptionManager ] [11:56:27,136]: Error adding 1 nodes to subscription 'Scanclass 'emErwZustand[default]'' @ 1 seconds.
INFO | jvm 1 | 2013/05/17 11:56:27 | StatusCode[Severity=Bad, Subcode=Bad_Timeout]: Request timed out after 120000 milliseconds.
...
INFO | jvm 1 | 2013/05/17 11:56:33 | WARN [TCPServerChannel ] [11:56:33,355]: Connection lost due to IOException.
INFO | jvm 1 | 2013/05/17 11:56:33 | java.io.IOException: End of stream reached.
INFO | jvm 1 | 2013/05/17 11:56:33 | at com.inductiveautomation.iosession.socket.AsyncSocketIOSession.run(AsyncSocketIOSession.java:74)
INFO | jvm 1 | 2013/05/17 11:56:33 | at java.lang.Thread.run(Unknown Source)
INFO | jvm 1 | 2013/05/17 11:56:33 | ERROR [SubscriptionManager ] [11:56:33,355]: Error adding 1 nodes to subscription 'Scanclass 'emErwZustand[default]'' @ 1 seconds.
INFO | jvm 1 | 2013/05/17 11:56:33 | StatusCode[Severity=Bad, Subcode=Bad_NotConnected]: Bad_NotConnected
...
This message applies to the remote connection
INFO | jvm 1 | 2013/05/17 11:56:43 | ERROR [OpcUaConnection:OPC-UA Prod-Server] [11:56:43,810]: Reading server time and state timed out, disconnecting...
...
INFO | jvm 1 | 2013/05/17 11:58:31 | ERROR [SubscriptionManager ] [11:58:31,195]: Error adding 10 nodes to subscription 'Scanclass 'emZaehlerLesen[default]'' @ 10 seconds.
INFO | jvm 1 | 2013/05/17 11:58:31 | StatusCode[Severity=Bad, Subcode=Bad_SessionIdInvalid]: ServiceFault: StatusCode[Severity=Bad, Subcode=Bad_SessionIdInvalid]
INFO | jvm 1 | 2013/05/17 11:58:31 | INFO [ActivateSessionService ] [11:58:31,285]: User "{schedule=Always, username=opcuauser, lastname=, language=null, firstname=, notes=}" connected.
At this point all OPC-UA tags are ok, except for on tag on the remote server.
When this problem occurs, one tag from the remote server stays stale. After a normal restart, this tag is ok (but becomes tale sometimes for a short period). On the remote 7.5.6 system, the tag has no problems.
thread-dump.txt (45.8 KB)
wrapper.log (85.1 KB)