Topic RSS11:29, EET
March 31, 2022
OfflineHi,
After switching to 5.5.0-212, my test stopped working with the following exception:
com.prosysopc.ua.ServiceException: GetEndpointsResponse, endpoint list received from the server is empty.
The test setup is fairly easy:
***
var server = new UaServer();
server.setPort(4840);
server.setServerName(“OPCUA/Test”);
server.getSecurityModes().add(SecurityMode.BASIC256SHA256_SIGN_ENCRYPT);
server.setUserTokenPolicies(UserTokenPolicies.SECURE_USERNAME_PASSWORD_BASIC256SHA256);
server.setCertificateValidator(CertificateValidator.ALLOW_ALL);
var appDescription = new ApplicationDescription();
appDescription.setApplicationName(new LocalizedText(“TestServer”));
appDescription.setApplicationUri(“urn:test:opcua”);
appDescription.setProductUri(“https://example.org/opcua”);
appDescription.setApplicationType(ApplicationType.Server);
server.setApplicationIdentity(ApplicationIdentity.createCertificate(appDescription, “Test”, 512));
server.start();
client = new UaClient(“opc.tcp://127.0.0.1:14840/OPCUA/Test”);
var appDescriptionC = new ApplicationDescription();
appDescriptionC.setApplicationName(new LocalizedText(“TestClient”));
appDescriptionC.setApplicationUri(“urn:localhost:UA:TestClient”);
appDescriptionC.setProductUri(“urn:prosysopc.com:UA:TestClient”);
appDescriptionC.setApplicationType(ApplicationType.Client);
client.setApplicationIdentity(ApplicationIdentity.createCertificate(appDescriptionC, “TestClient”, 512));
client.setSecurityMode(SecurityMode.BASIC256SHA256_SIGN_ENCRYPT);
client.setUserIdentity(new UserIdentity(“User1”, “Pass1”));
client.connect();
***
While the client is connecting, an exception is thrown:
***
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – java.vm.specification.vendor=Oracle Corporation
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – java.specification.name=Java Platform API Specification
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – intellij.debug.agent=true
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – user.script=
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – sun.management.compiler=HotSpot 64-Bit Tiered Compilers
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – java.runtime.version=17.0.1+12-LTS-39
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – file.encoding=UTF-8
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – java.version=17.0.1
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – java.vm.specification.name=Java Virtual Machine Specification
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – sun.os.patch.level=
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – native.encoding=Cp1252
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – kotlinx.coroutines.debug.enable.flows.stack.trace=true
10:20:00.802 [main] DEBUG com.prosysopc.ua.UaApplication – java.vm.specification.version=17
10:20:00.803 [main] DEBUG com.prosysopc.ua.UaApplication – os.version=10.0
10:20:00.803 [main] DEBUG com.prosysopc.ua.UaApplication – java.runtime.name=Java(TM) SE Runtime Environment
10:20:00.803 [main] DEBUG com.prosysopc.ua.UaApplication – java.vm.name=Java HotSpot(TM) 64-Bit Server VM
10:20:00.803 [main] DEBUG com.prosysopc.ua.UaApplication – os.arch=amd64
10:20:00.803 [main] DEBUG com.prosysopc.ua.UaApplication – user.language.format=de
10:20:00.803 [main] DEBUG com.prosysopc.ua.UaApplication – java.vm.info=mixed mode, sharing
10:20:00.803 [main] DEBUG com.prosysopc.ua.UaApplication – java.vm.version=17.0.1+12-LTS-39
10:20:00.803 [main] DEBUG com.prosysopc.ua.UaApplication – java.class.version=61.0
10:20:01.287 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: com.prosysopc.ua.stack.application.EndpointDiscoveryService@6a48a7f3
10:20:01.641 [main] DEBUG c.prosysopc.ua.ApplicationIdentity – Resolving local hostname..
10:20:01.641 [main] DEBUG c.prosysopc.ua.ApplicationIdentity – host address: NDELAN3195/192.168.2.39
10:20:01.641 [main] DEBUG c.prosysopc.ua.ApplicationIdentity – hostName=NDELAN3195
10:20:01.641 [main] DEBUG c.prosysopc.ua.ApplicationIdentity – ipAddress=192.168.2.39
10:20:01.641 [main] DEBUG c.prosysopc.ua.ApplicationIdentity – Resolving canonical hostname..
10:20:01.642 [main] DEBUG c.prosysopc.ua.ApplicationIdentity – canonicalHostName=localcomputer
10:20:02.010 [main] INFO c.p.ua.stack.utils.CryptoUtil – Using CryptoProvider com.prosysopc.ua.stack.transport.security.BcCryptoProvider
10:20:02.153 [main] INFO c.prosysopc.ua.ApplicationIdentity – Created a new Certificate: O=Test, CN=TestServer; ApplicationURI=urn:test:opcua KeySize=512
10:20:02.153 [main] DEBUG com.prosysopc.ua.server.UaServer – initEndpoints: SecurityModes=[[http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt]] httpsSecurityPolicies=null
10:20:02.154 [main] DEBUG com.prosysopc.ua.server.UaServer – uri: opc.tcp://localcomputer:14840/OPCUA/Test
10:20:02.154 [main] DEBUG com.prosysopc.ua.server.UaServer – Endpoint added: opc.tcp://localcomputer:14840/OPCUA/Test [http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt] [UserName]
10:20:02.173 [main] DEBUG com.prosysopc.ua.UaApplication – Discovering CodegenModels from the classpath
10:20:02.173 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: com.prosysopc.ua.stack.application.EndpointDiscoveryService@3b088163
10:20:02.173 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: Server urn:test:opcua
10:20:02.179 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: com.prosysopc.ua.stack.application.EndpointDiscoveryService@14de1901
10:20:02.179 [main] DEBUG c.p.u.s.t.tcp.nio.OpcTcpServer – Created (context: 1552767213
10:20:02.179 [main] DEBUG com.prosysopc.ua.server.UaServer – addServiceHandler Server urn:test:opcua: Server urn:test:opcua
10:20:02.179 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: Server urn:test:opcua
10:20:02.182 [main] DEBUG com.prosysopc.ua.server.UaServer – addServiceHandler Server urn:test:opcua: com.prosysopc.ua.server.SessionServiceHandler@6c0b51da
10:20:02.182 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: com.prosysopc.ua.server.SessionServiceHandler@6c0b51da
10:20:02.226 [main] DEBUG com.prosysopc.ua.server.UaServer – addServiceHandler Server urn:test:opcua: com.prosysopc.ua.server.NodeManagementServiceHandler@7a66c35a
10:20:02.226 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: com.prosysopc.ua.server.NodeManagementServiceHandler@7a66c35a
10:20:02.228 [main] DEBUG com.prosysopc.ua.server.UaServer – addServiceHandler Server urn:test:opcua: com.prosysopc.ua.server.AttributeServiceHandler@3dec3f87
10:20:02.228 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: com.prosysopc.ua.server.AttributeServiceHandler@3dec3f87
10:20:02.236 [main] DEBUG com.prosysopc.ua.server.UaServer – addServiceHandler Server urn:test:opcua: com.prosysopc.ua.server.SubscriptionServiceHandler@272778ae
10:20:02.236 [main] DEBUG c.p.ua.stack.application.Server – addServiceHandler: com.prosysopc.ua.server.SubscriptionServiceHandler@272778ae
10:20:02.237 [main] DEBUG c.p.ua.server.NodeManagerTable – Initializing NodeManager: class com.prosysopc.ua.server.NodeManagerRoot namespaceUri=http://opcfoundation.org/UA/ namespaceIndex=0
10:20:02.237 [main] DEBUG c.p.ua.server.NodeManagerRoot – init
10:20:02.240 [main] DEBUG com.prosysopc.ua.UaNodeSet – encoding=UTF8
10:20:02.240 [main] DEBUG com.prosysopc.ua.UaNodeSet – cbuf=003c 0000 bom=feff
10:20:02.390 [main] DEBUG com.prosysopc.ua.d – Model namespaces: [http://opcfoundation.org/UA/]
10:20:02.853 [main] DEBUG com.prosysopc.ua.UaNodeSet – Parsed UaNodeSet with 0 Infos, 0 Warnings, 0 Errors
10:20:03.478 [StandardOPCUANodeSetMemoryCompress] DEBUG c.p.ua.server.NodeManagerRoot – Memory compression of standard model completed
10:20:03.565 [main] INFO c.p.ua.server.NodeManagerRoot – Loaded: ModelInfo [namespace=http://opcfoundation.org/UA/, version=1.05.06, publicationDate=11/08/25 00:00:00.0000000 GMT, dependencies=[]]
10:20:03.578 [main] DEBUG c.p.ua.server.NodeManagerTable – Initializing NodeManager: class com.prosysopc.ua.server.UaServer$NodeManagerUaServer namespaceUri=urn:test:opcua namespaceIndex=1
10:20:03.580 [main] DEBUG com.prosysopc.ua.server.UaServer – updateApplicationDescription: applicationDescription=ApplicationDescription [ApplicationUri=”urn:test:opcua”, ProductUri=”https://test.org/opcua”, ApplicationName=”TestServer”, ApplicationType=”Server”, GatewayServerUri=”null”, DiscoveryProfileUri=”null”, DiscoveryUrls=”[opc.tcp://localcomputer:14840/OPCUA/Test]”]
10:20:03.581 [main] DEBUG com.prosysopc.ua.server.UaServer – toRegisteredServer: d=ApplicationDescription [ApplicationUri=”urn:test:opcua”, ProductUri=”https://test.org/opcua”, ApplicationName=”TestServer”, ApplicationType=”Server”, GatewayServerUri=”null”, DiscoveryProfileUri=”null”, DiscoveryUrls=”[opc.tcp://localcomputer:14840/OPCUA/Test]”]
10:20:03.581 [main] DEBUG c.p.u.s.UaServer$DiscoveryServer – registerServer: server=RegisteredServer [ServerUri=”urn:test:opcua”, ProductUri=”https://test.org/opcua”, ServerNames=”[TestServer]”, ServerType=”Server”, GatewayServerUri=”null”, DiscoveryUrls=”[opc.tcp://localcomputer:14840/OPCUA/Test]”, SemaphoreFilePath=”null”, IsOnline=”false”] isOnline=false
10:20:03.584 [main] DEBUG c.p.ua.server.DiagnosticsManager – start
10:20:03.586 [main] DEBUG c.prosysopc.ua.server.SessionManager – start
10:20:03.592 [main] DEBUG c.prosysopc.ua.server.SessionManager – sessionMonitorExecutor scheduled
10:20:03.593 [main] DEBUG c.p.ua.server.NodeManagerRoot – start
10:20:03.600 [main] DEBUG com.prosysopc.ua.server.UaServer – getBindAddresses, IPv6: true, using address: /0:0:0:0:0:0:0:0
10:20:03.603 [main] DEBUG c.p.u.s.t.tcp.nio.OpcTcpServer – onStateTransition, old: Closed, new: Open
10:20:03.627 [main] DEBUG c.p.u.s.u.a.ListenableServerSocketChannel – bind, address:/[0:0:0:0:0:0:0:0]:14840, backlog:0, socket:sun.nio.ch.ServerSocketChannelImpl[/[0:0:0:0:0:0:0:0]:14840]
10:20:03.627 [main] DEBUG c.p.u.s.t.tcp.nio.OpcTcpServer – For address: /[0:0:0:0:0:0:0:0]:14840, using bind address: /[0:0:0:0:0:0:0:0]:14840
10:20:03.627 [main] INFO c.p.u.s.t.tcp.nio.OpcTcpServer – TCP/IP Socket bound to /[0:0:0:0:0:0:0:0]:14840
10:20:03.629 [main] DEBUG com.prosysopc.ua.server.UaServer – bindDiscoveryEndpoint: discoveryUriString=opc.tcp://localcomputer:14840
10:20:03.629 [main] DEBUG com.prosysopc.ua.server.UaServer – bindDiscoveryEndpoint: discovery bindings=[]
10:20:03.629 [main] DEBUG com.prosysopc.ua.server.UaServer – bindDiscoveryEndpoint: server bindings=[OpcTcpServer(opc.tcp(/[0:0:0:0:0:0:0:0]:14840, (opc.tcp://localcomputer:14840/OPCUA/Test [[http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt]])))]
10:20:03.629 [main] DEBUG com.prosysopc.ua.server.UaServer – Discovery endpoint bound to opc.tcp://[0:0:0:0:0:0:0:0]:14840
10:20:03.629 [main] INFO com.prosysopc.ua.server.UaServer – Server endpoint: opc.tcp://localcomputer:14840/OPCUA/Test
10:20:03.629 [main] INFO com.prosysopc.ua.server.UaServer – * Endpoint bound to: [0:0:0:0:0:0:0:0:14840]
10:20:03.629 [main] INFO com.prosysopc.ua.server.UaServer – * Endpoint MessageSecurityModes: [SignAndEncrypt]
10:20:03.629 [main] INFO com.prosysopc.ua.server.UaServer – * Endpoint SecurityPolicies: [Basic256Sha256]
10:20:03.629 [main] DEBUG com.prosysopc.ua.server.UaServer – updateApplicationDescription: applicationDescription=ApplicationDescription [ApplicationUri=”urn:test:opcua”, ProductUri=”https://test.org/opcua”, ApplicationName=”TestServer”, ApplicationType=”Server”, GatewayServerUri=”null”, DiscoveryProfileUri=”null”, DiscoveryUrls=”[opc.tcp://localcomputer:14840/OPCUA/Test]”]
10:20:03.630 [main] DEBUG com.prosysopc.ua.server.UaServer – toRegisteredServer: d=ApplicationDescription [ApplicationUri=”urn:test:opcua”, ProductUri=”https://test.org/opcua”, ApplicationName=”TestServer”, ApplicationType=”Server”, GatewayServerUri=”null”, DiscoveryProfileUri=”null”, DiscoveryUrls=”[opc.tcp://localcomputer:14840/OPCUA/Test]”]
10:20:03.630 [main] DEBUG c.p.u.s.UaServer$DiscoveryServer – registerServer: server=RegisteredServer [ServerUri=”urn:test:opcua”, ProductUri=”https://test.org/opcua”, ServerNames=”[TestServer]”, ServerType=”Server”, GatewayServerUri=”null”, DiscoveryUrls=”[opc.tcp://localcomputer:14840/OPCUA/Test]”, SemaphoreFilePath=”null”, IsOnline=”true”] isOnline=true
10:20:03.640 [main] DEBUG i.m.c.u.i.l.InternalLoggerFactory – Using SLF4J as the default logging framework
10:20:03.725 [main] INFO c.prosysopc.ua.ApplicationIdentity – Created a new Certificate: O=TestClient, CN=TestClient; ApplicationURI=urn:localcomputer:UA:TestClient KeySize=512
Java HotSpot(TM) 64-Bit Server VM warning: Sharing is only supported for boot loader classes because bootstrap classpath has been appended
10:20:04.303 [main] DEBUG com.prosysopc.ua.client.UaClient – connect
10:20:04.501 [main] DEBUG com.prosysopc.ua.UaApplication – Discovering CodegenModels from the classpath
10:20:04.501 [main] DEBUG com.prosysopc.ua.client.UaClient – discoverEndpoints: connectUri=opc.tcp://127.0.0.1:14840/OPCUA/Test protocols=[opc.tcp]
10:20:04.504 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – initialize: url=opc.tcp://127.0.0.1:14840/OPCUA/Test, settings: TransportChannelSettings [description=EndpointDescription [EndpointUrl=”opc.tcp://127.0.0.1:14840/OPCUA/Test”, Server=”null”, ServerCertificate=”null”, SecurityMode=”None”, SecurityPolicyUri=”http://opcfoundation.org/UA/SecurityPolicy#None”, UserIdentityTokens=”null”, TransportProfileUri=”null”, SecurityLevel=”null”], configuration=EndpointConfiguration [OperationTimeout=”120000″, UseBinaryEncoding=”true”, MaxStringLength=”4194240″, MaxByteStringLength=”4194240″, MaxArrayLength=”4194240″, MaxMessageSize=”4194240″, MaxBufferSize=”65535″, ChannelLifetime=”120000″, SecurityTokenLifetime=”3600000″], namespaceUris=null, opctcpSettings=com.prosysopc.ua.stack.transport.tcp.io.OpcTcpSettings@3b4f1eb, httpsSettings=com.prosysopc.ua.stack.transport.https.HttpsSettings@6247c08c]
10:20:04.511 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – open
10:20:04.511 [main] INFO c.p.u.s.t.tcp.io.TcpConnection – /127.0.0.1:14840 Connecting
10:20:04.512 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – /127.0.0.1:14840 Socket connected
10:20:04.518 [OPC-UA-Stack-Blocking-Work-Executor-1] DEBUG c.p.u.s.u.a.ListenableSocketChannel – ListenableSocketChannel: channel=java.nio.channels.SocketChannel[connected local=/127.0.0.1:14840 remote=/127.0.0.1:64366]
10:20:04.521 [OPC-UA-Stack-Blocking-Work-Executor-2] INFO c.p.u.s.t.tcp.nio.OpcTcpServer – OpcTcpServer(opc.tcp(/[0:0:0:0:0:0:0:0]:14840, (opc.tcp://localcomputer:14840/OPCUA/Test [[http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt]])(opc.tcp://localcomputer:14840 [[http://opcfoundation.org/UA/SecurityPolicy#None,None]]))): /127.0.0.1:64366 connected
10:20:04.525 [OPC-UA-Stack-Blocking-Work-Executor-2] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – onStateTransition: Closed->Opening
10:20:04.525 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – Writing Hello: Hello [protocolVersion=0, receiveBufferSize=147456, sendBufferSize=147456, maxMessageSize=4194240, maxChunkCount=65535, endpointUrl=opc.tcp://127.0.0.1:14840/OPCUA/Test]
10:20:04.525 [OPC-UA-Stack-Blocking-Work-Executor-2] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – addConnectionListener: listener=com.prosysopc.ua.stack.transport.tcp.nio.OpcTcpServer$1$1@841eeb9
10:20:04.528 [OPC-UA-Stack-Blocking-Work-Executor-4] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – onHello: url=opc.tcp://127.0.0.1:14840/OPCUA/Test
10:20:04.529 [OPC-UA-Stack-Blocking-Work-Executor-4] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – endpoints=[opc.tcp://localcomputer:14840/OPCUA/Test [[http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt]], opc.tcp://localcomputer:14840 [[http://opcfoundation.org/UA/SecurityPolicy#None,None]]]
10:20:04.529 [OPC-UA-Stack-Blocking-Work-Executor-4] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – endpoint=opc.tcp://localcomputer:14840/OPCUA/Test [[http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt]]
10:20:04.530 [OPC-UA-Stack-Blocking-Work-Executor-4] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – onStateTransition: Opening->Open
10:20:04.530 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – Received Acknowledge: Acknowledge [protocolVersion=0, receiveBufferSize=65536, sendBufferSize=65536, maxMessageSize=4194240, maxChunkCount=0]
10:20:04.531 [main] INFO c.p.u.s.t.tcp.io.TcpConnection – Connected (non-reverse), handshake completed, local=/127.0.0.1:64366, remote=/127.0.0.1:14840
10:20:04.531 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – Creating ReadThread
10:20:04.533 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – createSecureChannel: renew=false channel=com.prosysopc.ua.stack.transport.tcp.io.TcpConnection@4b916cc2
10:20:04.533 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – createSecureChannel: requestId=1
10:20:04.533 [main] DEBUG c.p.ua.stack.utils.CryptoUtil – createNonce: bytes=0
10:20:04.533 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – tokenLifetime: 3600000
10:20:04.534 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: socket=com.prosysopc.ua.stack.transport.tcp.io.TcpConnection$DelegatingSocketWrapper@7affee54
10:20:04.534 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: 0 Sending Request rid:1
10:20:04.536 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: token=null
10:20:04.536 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: keySize=0
10:20:04.536 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – SecureChannelId=0 SequenceNumber=1, RequestId=1
10:20:04.537 [main] DEBUG c.p.u.s.t.t.i.ChunkAsymmEncryptSigner – SecurityMode in asymm enc: 1
10:20:04.538 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – secureChannelId=0
10:20:04.538 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – secureChannel=null
10:20:04.538 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – securityPolicyUri=http://opcfoundation.org/UA/SecurityPolicy#None
10:20:04.538 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – securityPolicy=http://opcfoundation.org/UA/SecurityPolicy#None
10:20:04.538 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – encodedRemoteCertificate=null
10:20:04.538 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – encodedLocalCertificateThumbprint=null
10:20:04.538 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.ua.stack.application.Application – getApplicationInstanceCertificate: expected=(null)
10:20:04.539 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – SecureInputMessageBuilder: expectedSequenceNumber=null
10:20:04.539 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – onAsymmSecureChunk: java.nio.HeapByteBuffer[pos=71 lim=132 cap=132]
10:20:04.539 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – addChunk: expectedSequenceNumber=null
10:20:04.539 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – token: com.prosysopc.ua.stack.transport.security.SecurityConfiguration@6083a003
10:20:04.540 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.i.ChunkAsymmDecryptVerifier – SecurityPolicy in use: http://opcfoundation.org/UA/SecurityPolicy#None
10:20:04.540 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.i.ChunkAsymmDecryptVerifier – SecurityMode in use: None
10:20:04.542 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – handleOpenSecureChannelRequest: endpointServer=OpcTcpServer(opc.tcp(/[0:0:0:0:0:0:0:0]:14840, (opc.tcp://localcomputer:14840/OPCUA/Test [[http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt]])(opc.tcp://localcomputer:14840 [[http://opcfoundation.org/UA/SecurityPolicy#None,None]]))) SecureChannelId=1
10:20:04.542 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.ua.stack.utils.CryptoUtil – createNonce: bytes=0
10:20:04.542 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.n.OpcTcpServerSecureChannel – tokenLifetime: 3600000
10:20:04.543 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.e.AbstractServerSecureChannel – Switching to new security token 1
10:20:04.543 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.e.AbstractServerSecureChannel – pruneInvalidTokens: tokens(1)=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000)]
10:20:04.544 [OPC-UA-Stack-Blocking-Work-Executor-6] DEBUG c.p.u.s.t.t.i.ChunkAsymmEncryptSigner – SecurityMode in asymm enc: 1
10:20:04.544 [OPC-UA-Stack-Blocking-Work-Executor-6] INFO c.p.u.s.t.t.n.OpcTcpServerSecureChannel – SecureChannel opened; SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000)
10:20:04.544 [TcpConnection/Read] DEBUG c.p.u.s.t.t.i.ChunkAsymmDecryptVerifier – SecurityPolicy in use: http://opcfoundation.org/UA/SecurityPolicy#None
10:20:04.544 [TcpConnection/Read] DEBUG c.p.u.s.t.t.i.ChunkAsymmDecryptVerifier – SecurityMode in use: None
10:20:04.545 [TcpConnection/Read] DEBUG c.p.u.s.t.tcp.io.TcpConnection – new token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.546 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – 1 Secure channel opened, SecureChannelId=1, TokenId=1
10:20:04.546 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – RevisedLifetime: 3600000
10:20:04.548 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – serviceRequest: requests.size=1
10:20:04.548 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: socket=com.prosysopc.ua.stack.transport.tcp.io.TcpConnection$DelegatingSocketWrapper@7affee54
10:20:04.548 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: 1 Sending Request rid:2
10:20:04.548 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – pruneInvalidTokens: tokens(1)=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)]
10:20:04.548 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – tokens=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)]
10:20:04.548 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – getSecurityTokenToUse=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.548 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.548 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: keySize=0
10:20:04.549 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – serviceRequest: Message sent, requestId=2 secureChannelId=1
10:20:04.550 [OPC-UA-Stack-Blocking-Work-Executor-8] DEBUG c.p.u.s.t.e.AbstractServerSecureChannel – tokens(1)=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000)]
10:20:04.550 [OPC-UA-Stack-Blocking-Work-Executor-8] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – handleSymmChunk: token=com.prosysopc.ua.stack.transport.security.SecurityConfiguration@6083a003, secureChannelId=0, more=false
10:20:04.550 [OPC-UA-Stack-Blocking-Work-Executor-8] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – SecureInputMessageBuilder: expectedSequenceNumber=2
10:20:04.550 [OPC-UA-Stack-Blocking-Work-Executor-8] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – handleSymmChunk: secureMessageBuilder=token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000), secureChannelId=null, more=true
10:20:04.550 [OPC-UA-Stack-Blocking-Work-Executor-8] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – addChunk: expectedSequenceNumber=2
10:20:04.550 [OPC-UA-Stack-Blocking-Work-Executor-8] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – token: SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000)
10:20:04.551 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – handleSecureMessage: secureChannelId=1msg=GetEndpointsRequest
10:20:04.551 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.t.t.n.OpcTcpServerSecureChannel – onSecureMessage: server=Server urn:test:opcua
10:20:04.551 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.t.t.n.OpcTcpServerSecureChannel – onSecureMessage: endpoint=opc.tcp://localcomputer:14840/OPCUA/Test [[http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt]]
10:20:04.551 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.ServiceHandlerComposition – serve: GetEndpointsRequest
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.ServiceHandlerComposition – serve: handlerMap=[class com.prosysopc.ua.stack.core.RegisterNodesRequest, class com.prosysopc.ua.stack.core.BrowseNextRequest, class com.prosysopc.ua.stack.core.CreateMonitoredItemsRequest, class com.prosysopc.ua.stack.core.BrowseRequest, class com.prosysopc.ua.stack.core.RepublishRequest, class com.prosysopc.ua.stack.core.DeleteReferencesRequest, class com.prosysopc.ua.stack.core.DeleteSubscriptionsRequest, class com.prosysopc.ua.stack.core.ReadRequest, class com.prosysopc.ua.stack.core.WriteRequest, class com.prosysopc.ua.stack.core.HistoryReadRequest, class com.prosysopc.ua.stack.core.AddNodesRequest, class com.prosysopc.ua.stack.core.SetTriggeringRequest, class com.prosysopc.ua.stack.core.DeleteMonitoredItemsRequest, class com.prosysopc.ua.stack.core.ActivateSessionRequest, class com.prosysopc.ua.stack.core.PublishRequest, class com.prosysopc.ua.stack.core.CancelRequest, class com.prosysopc.ua.stack.core.CreateSessionRequest, class com.prosysopc.ua.stack.core.CreateSubscriptionRequest, class com.prosysopc.ua.stack.core.SetPublishingModeRequest, class com.prosysopc.ua.stack.core.TransferSubscriptionsRequest, class com.prosysopc.ua.stack.core.SetMonitoringModeRequest, class com.prosysopc.ua.stack.core.DeleteNodesRequest, class com.prosysopc.ua.stack.core.FindServersRequest, class com.prosysopc.ua.stack.core.TranslateBrowsePathsToNodeIdsRequest, class com.prosysopc.ua.stack.core.CloseSessionRequest, class com.prosysopc.ua.stack.core.CallRequest, class com.prosysopc.ua.stack.core.GetEndpointsRequest, class com.prosysopc.ua.stack.core.AddReferencesRequest, class com.prosysopc.ua.stack.core.HistoryUpdateRequest, class com.prosysopc.ua.stack.core.ModifyMonitoredItemsRequest, class com.prosysopc.ua.stack.core.QueryFirstRequest, class com.prosysopc.ua.stack.core.QueryNextRequest, class com.prosysopc.ua.stack.core.UnregisterNodesRequest, class com.prosysopc.ua.stack.core.ModifySubscriptionRequest]
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.ServiceHandlerComposition – serve: handler=com.prosysopc.ua.stack.application.ServiceHandlerComposition$1@b885ae0
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: requestAddress=/127.0.0.1:14840
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: requestUrl=opc.tcp://127.0.0.1:14840/OPCUA/Test
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: host=127.0.0.1
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: serverName=OPCUA/Test
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: profileUris=[http://opcfoundation.org/UA-Profile/Transport/uatcp-uasc-uabinary]
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: no matching endpoints for requested hostname, checking all with the same serverName
10:20:04.552 [OPC-UA-Stack-Blocking-Work-Executor-9] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: no matching endpoints ignoring host, adding all
10:20:04.553 [TcpConnection/Read] DEBUG c.p.u.s.t.tcp.io.TcpConnection – tokens(1)=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)]
10:20:04.553 [TcpConnection/Read] DEBUG c.p.u.s.t.tcp.io.TcpConnection – token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – Response: GetEndpointsResponse
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – serviceRequest: requests.size=1
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: socket=com.prosysopc.ua.stack.transport.tcp.io.TcpConnection$DelegatingSocketWrapper@7affee54
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: 1 Sending Request rid:3
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – pruneInvalidTokens: tokens(1)=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)]
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – tokens=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)]
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – getSecurityTokenToUse=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: keySize=0
10:20:04.555 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – serviceRequest: Message sent, requestId=3 secureChannelId=1
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-12] DEBUG c.p.u.s.t.e.AbstractServerSecureChannel – tokens(1)=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000)]
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-12] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – handleSymmChunk: token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000), secureChannelId=1, more=false
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-12] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – SecureInputMessageBuilder: expectedSequenceNumber=3
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-12] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – handleSymmChunk: secureMessageBuilder=token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000), secureChannelId=null, more=true
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-12] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – addChunk: expectedSequenceNumber=3
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-12] DEBUG c.p.u.s.t.t.n.SecureInputMessageBuilder – token: SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000)
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – handleSecureMessage: secureChannelId=1msg=GetEndpointsRequest
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.t.t.n.OpcTcpServerSecureChannel – onSecureMessage: server=Server urn:test:opcua
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.t.t.n.OpcTcpServerSecureChannel – onSecureMessage: endpoint=opc.tcp://localcomputer:14840/OPCUA/Test [[http://opcfoundation.org/UA/SecurityPolicy#Basic256Sha256,SignAndEncrypt]]
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.ServiceHandlerComposition – serve: GetEndpointsRequest
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.ServiceHandlerComposition – serve: handlerMap=[class com.prosysopc.ua.stack.core.RegisterNodesRequest, class com.prosysopc.ua.stack.core.BrowseNextRequest, class com.prosysopc.ua.stack.core.CreateMonitoredItemsRequest, class com.prosysopc.ua.stack.core.BrowseRequest, class com.prosysopc.ua.stack.core.RepublishRequest, class com.prosysopc.ua.stack.core.DeleteReferencesRequest, class com.prosysopc.ua.stack.core.DeleteSubscriptionsRequest, class com.prosysopc.ua.stack.core.ReadRequest, class com.prosysopc.ua.stack.core.WriteRequest, class com.prosysopc.ua.stack.core.HistoryReadRequest, class com.prosysopc.ua.stack.core.AddNodesRequest, class com.prosysopc.ua.stack.core.SetTriggeringRequest, class com.prosysopc.ua.stack.core.DeleteMonitoredItemsRequest, class com.prosysopc.ua.stack.core.ActivateSessionRequest, class com.prosysopc.ua.stack.core.PublishRequest, class com.prosysopc.ua.stack.core.CancelRequest, class com.prosysopc.ua.stack.core.CreateSessionRequest, class com.prosysopc.ua.stack.core.CreateSubscriptionRequest, class com.prosysopc.ua.stack.core.SetPublishingModeRequest, class com.prosysopc.ua.stack.core.TransferSubscriptionsRequest, class com.prosysopc.ua.stack.core.SetMonitoringModeRequest, class com.prosysopc.ua.stack.core.DeleteNodesRequest, class com.prosysopc.ua.stack.core.FindServersRequest, class com.prosysopc.ua.stack.core.TranslateBrowsePathsToNodeIdsRequest, class com.prosysopc.ua.stack.core.CloseSessionRequest, class com.prosysopc.ua.stack.core.CallRequest, class com.prosysopc.ua.stack.core.GetEndpointsRequest, class com.prosysopc.ua.stack.core.AddReferencesRequest, class com.prosysopc.ua.stack.core.HistoryUpdateRequest, class com.prosysopc.ua.stack.core.ModifyMonitoredItemsRequest, class com.prosysopc.ua.stack.core.QueryFirstRequest, class com.prosysopc.ua.stack.core.QueryNextRequest, class com.prosysopc.ua.stack.core.UnregisterNodesRequest, class com.prosysopc.ua.stack.core.ModifySubscriptionRequest]
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.ServiceHandlerComposition – serve: handler=com.prosysopc.ua.stack.application.ServiceHandlerComposition$1@b885ae0
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: requestAddress=/127.0.0.1:14840
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: requestUrl=
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: host=
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: serverName=
10:20:04.556 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: profileUris=[]
10:20:04.557 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: no matching endpoints for requested hostname, checking all with the same serverName
10:20:04.557 [OPC-UA-Stack-Blocking-Work-Executor-13] DEBUG c.p.u.s.a.EndpointDiscoveryService – onGetEndpoints: no matching endpoints ignoring host, adding all
10:20:04.557 [TcpConnection/Read] DEBUG c.p.u.s.t.tcp.io.TcpConnection – tokens(1)=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)]
10:20:04.557 [TcpConnection/Read] DEBUG c.p.u.s.t.tcp.io.TcpConnection – token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.557 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – Response: GetEndpointsResponse
10:20:04.557 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – serviceRequest: requests.size=1
10:20:04.557 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: socket=com.prosysopc.ua.stack.transport.tcp.io.TcpConnection$DelegatingSocketWrapper@7affee54
10:20:04.557 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: 1 Sending Request rid:4
10:20:04.557 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – pruneInvalidTokens: tokens(1)=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)]
10:20:04.558 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – tokens=[SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)]
10:20:04.558 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – getSecurityTokenToUse=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.558 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.545Z, lifetime=3600000)
10:20:04.558 [main] DEBUG c.p.u.s.t.tcp.io.TcpConnection – sendRequest: keySize=0
10:20:04.558 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – serviceRequest: Message sent, requestId=4 secureChannelId=1
10:20:04.558 [main] INFO c.p.u.s.t.tcp.io.SecureChannelTcp – 1 Closed
10:20:04.558 [main] INFO c.p.u.s.t.tcp.io.TcpConnection – /127.0.0.1:14840 Closed
10:20:04.558 [OPC-UA-Stack-Async-Selector] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – onStateTransition: Open->Closing
10:20:04.558 [OPC-UA-Stack-Async-Selector] INFO c.p.u.s.t.t.n.OpcTcpServerSecureChannel – Secure Channel closed, token=SecurityToken(Id=1, secureChannelId=1, creationTime=2025-12-16T09:20:04.542Z, lifetime=3600000)
10:20:04.559 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – requests.clear()
10:20:04.559 [OPC-UA-Stack-Async-Selector] INFO c.p.u.s.t.e.AbstractServerSecureChannel – Channel closed: Id=1
10:20:04.559 [main] DEBUG c.p.u.s.t.tcp.io.SecureChannelTcp – requests.clear()
10:20:04.559 [OPC-UA-Stack-Async-Selector] DEBUG c.p.u.s.u.a.ListenableSocketChannel – close: channel.isRegistered()=true
10:20:04.559 [main] DEBUG com.prosysopc.ua.client.UaClient – endpoints:[]
10:20:04.559 [OPC-UA-Stack-Async-Selector] DEBUG c.p.u.s.u.a.ListenableSocketChannel – close: channel.isOpen()=true
10:20:04.559 [OPC-UA-Stack-Async-Selector] DEBUG c.p.u.s.u.a.ListenableSocketChannel – closed
10:20:04.559 [OPC-UA-Stack-Async-Selector] DEBUG c.p.u.s.u.a.ListenableSocketChannel – close: ownsSelector=false
10:20:04.559 [OPC-UA-Stack-Async-Selector] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – onStateTransition: Closing->Closed
10:20:04.559 [OPC-UA-Stack-Blocking-Work-Executor-16] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – onStateTransition: Closed->Closing
10:20:04.559 [OPC-UA-Stack-Blocking-Work-Executor-16] DEBUG c.p.u.s.u.a.ListenableSocketChannel – close: channel.isRegistered()=false
10:20:04.559 [OPC-UA-Stack-Blocking-Work-Executor-16] DEBUG c.p.u.s.u.a.ListenableSocketChannel – close: channel.isOpen()=false
10:20:04.559 [OPC-UA-Stack-Blocking-Work-Executor-16] DEBUG c.p.u.s.u.a.ListenableSocketChannel – close: ownsSelector=false
10:20:04.559 [OPC-UA-Stack-Blocking-Work-Executor-16] DEBUG c.p.u.s.t.t.n.OpcTcpServerConnection – onStateTransition: Closing->Closed
10:20:04.560 [TcpConnection/Read] INFO c.p.u.s.t.tcp.io.TcpConnection – /127.0.0.1:14840 Closed (expected)
com.prosysopc.ua.ServiceException: GetEndpointsResponse, endpoint list received from the server is empty.
ServiceResult=Bad_UnexpectedError (0x80010000) “An unexpected error occurred.” Diagnostics=Diagnostic Info:
at com.prosysopc.ua.client.UaClient.getEndpoints(SourceFile:6502)
at com.prosysopc.ua.client.UaClient.cwI(SourceFile:7133)
at com.prosysopc.ua.client.UaClient.connect(SourceFile:1133)
at org.example.prosys.ProsysServerITTest.connect(ProsysServerITTest.java:139)
***
Interestingly, changing security to anonymous, as follows, all works fine (but I need to test the user sessions, so no real solution for me):
…
server.getSecurityModes().add(SecurityMode.NONE);
server.setUserTokenPolicies(UserTokenPolicies.ANONYMOUS);
…
client.setSecurityMode(SecurityMode.NONE);
…
Thanks!
12:06, EET
Moderators
February 11, 2020
Offline13:50, EET
April 3, 2012
OfflineHi,
I’m assuming the SDK version from which was updated is quite old, because I do not remember recent changes regarding this.
Anyway, your ApplicationIdentity.createCertificate(…, 512) is wrong. No SecurityPolicy in OPC UA works with 512 cert. Valid certificate sizes are 1024, 2048 and 4096 (in theory 3072 as well), even the very first security policy required 1k cert at minimum. Depending on the policy it might require higher. For example, BASIC256SHA256 requires 2k-4k. The default certificate size is 2k, that works with all the policies the SDK supports, we recommend using that one.
It is possible there is something in an older SDK version where it would have incorrectly worked. There logic is, at least nowadays, that the server forms the endpoints based on inputs (one or more certificates, messagesecurity mode and security policy) and creates valid combinations from that (see SampleConsoleServer example). In this case since there is no valid certificate that would work for BASIC256SHA256 there wont be any endpoints.
In these areas SDK could maybe use some improvements (and some will, once we get our GDS i.e. GlobalDiscoveryServer support released).
In short if you just change your test to use 2048 as the cert keysize it should work (unless like your test was literally intended to test a failure in the connection or some other exceptional case).
1 Guest(s)

Log In
Register
