View Issue Details
| ID | Project | Category | View Status | Date Submitted | Last Update |
|---|---|---|---|---|---|
| 0008284 | CTT UA Scripts | 1 - Script Issue | public | 2022-09-06 09:44 | 2022-10-07 11:55 |
| Reporter | Martin Herberg | Assigned To | Yannik Klaass | ||
| Priority | normal | Severity | minor | Reproducibility | always |
| Status | closed | Resolution | fixed | ||
| Fixed in Version | 1.03.501 | ||||
| Summary | 0008284: Monitor Item 2 / Err-001: Script sends empty Delete Monotired items request | ||||
| Description | The value items3, which get the value of CreateMonitoredItemsHelper.Response.Results, is undefined. This leads to en empty Delete Monitored Items Request. CreateMonitoredItemsHelper.Response seems to be an array, and therefore it seems to be handled incorrectly. | ||||
| Steps To Reproduce | Start Err-001.js alternatively
| ||||
| Tags | No tags attached. | ||||
| Attached Files | MonitoreItem2Err001.log (3,120 bytes)
2022-09-02 12:04:25.381 Info - Project::startTest(): Debug test run has been started. 2022-09-02 12:04:25.724 Info - UaSession::UaSessionClass(): Session Constructor 10bc1c38 2022-09-02 12:04:25.724 Info - UaSession::UaSessionClass(): Session Constructor 10bc1698 2022-09-02 12:04:25.795 Info - UaSession::UaSessionClass(): Session Destructor 10bc1c38 2022-09-02 12:04:26.024 Info - UaSession::UaSessionClass(): Session Constructor 10a25520 2022-09-02 12:04:26.024 Info - UaSession::UaSessionClass(): Session Constructor 10a25570 2022-09-02 12:04:26.224 Warning - UaSession::browseWithContinuation(): Received BadEncodingLimitsExceeded (0x80080000) for the Browse of the Node "i=63" at index 17. 2022-09-02 12:04:26.224 Warning - UaSession::browseWithContinuation(): Received BadEncodingLimitsExceeded (0x80080000) for the Browse of the Node "i=68" at index 20. 2022-09-02 12:04:26.224 Error - UaSession::buildReferenceDescriptions(): Received a Bad OperationResult for the BrowseResults at index 17. We won't try to resolve the node (i=63) because it doesn't seem to be available in the server. Unable to build complete AddressSpace Cache but will continue without this node. 2022-09-02 12:04:26.224 Error - UaSession::buildReferenceDescriptions(): Received a Bad OperationResult for the BrowseResults at index 20. We won't try to resolve the node (i=68) because it doesn't seem to be available in the server. Unable to build complete AddressSpace Cache but will continue without this node. 2022-09-02 12:04:26.233 Error - UaSession::isSubTypeOfTypeCached(): Unable to build object map 2022-09-02 12:04:26.289 Info - UaSession::UaSessionClass(): Session Constructor 10a11c00 2022-09-02 12:04:26.289 Info - UaSession::UaSessionClass(): Session Constructor 10a12650 2022-09-02 12:04:26.794 Info - UaSession::UaSessionClass(): Session Constructor 0fceb8f8 2022-09-02 12:04:26.794 Info - UaSession::UaSessionClass(): Session Constructor 0fceb538 2022-09-02 12:04:26.918 Info - UaSession::UaSessionClass(): Session Constructor 0fce01d8 2022-09-02 12:04:26.918 Info - UaSession::UaSessionClass(): Session Constructor 0fce1128 2022-09-02 12:04:26.939 Info - UaSession::UaSessionClass(): Session Destructor 10a25520 2022-09-02 12:04:26.939 Info - UaSession::UaSessionClass(): Session Destructor 10a25570 2022-09-02 12:04:26.985 Info - UaSession::UaSessionClass(): Session Destructor 10a11c00 2022-09-02 12:04:26.985 Info - UaSession::UaSessionClass(): Session Destructor 10a12650 2022-09-02 12:04:26.986 Info - UaSession::UaSessionClass(): Session Destructor 10bc1698 2022-09-02 12:04:27.012 Info - UaSession::UaSessionClass(): Session Destructor 0fceb8f8 2022-09-02 12:04:27.302 Info - UaSession::UaSessionClass(): Session Destructor 0fce01d8 2022-09-02 12:04:27.305 Info - Project::startTest(): Test run has been finished. 2022-09-02 12:04:27.309 Info - UaSession::UaSessionClass(): Session Destructor 0fceb538 2022-09-02 12:04:27.312 Info - UaSession::UaSessionClass(): Session Destructor 0fce1128 MonitoreItem2Err001.txt (11,053 bytes)
AuditThread::Start args = false GetEndpoints( LocaleIds #0; ProfileUris #0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet OpenSecureChannel( MessageSecurityMode: None; RequestedSecurityPolicyUri: http://opcfoundation.org/UA/SecurityPolicy#None ); Result = Good (0x00000000) Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CreateSession( EndpointUrl=opc.tcp://192.168.1.3:4840; SessionName: UaCttSession_1; RequestedSessionTimeout: 60000 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet ActivateSession( LocaleIds #1; UserIdentityToken: http://opcfoundation.org/UA/SecurityPolicy#None00000000010000000001 ( ClientSignature=, UserTokenSignature= ) ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 1; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Obtaining the ServerCapabilities... Read( NodesToRead #2; TimestampsToReturn: 2; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 2; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 2; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 2; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 2; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 2; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 2; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSession().Result: Good (0x00000000) CloseSession( DeleteSubscriptions=true ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSecureChannel(); Result = Good (0x00000000) Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet OpenSecureChannel( MessageSecurityMode: None; RequestedSecurityPolicyUri: http://opcfoundation.org/UA/SecurityPolicy#None ); Result = Good (0x00000000) Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CreateSession( EndpointUrl=opc.tcp://192.168.1.3:4840; SessionName: UaCttSession_2; RequestedSessionTimeout: 60000 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet ActivateSession( LocaleIds #1; UserIdentityToken: http://opcfoundation.org/UA/SecurityPolicy#None00000000010000000001 ( ClientSignature=, UserTokenSignature= ) ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 1; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Calling BuildCacheMap Loop Count 1 Unexpected error during build of Object Cache Map. Retrying Received:-2146959360 Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSession().Result: Good (0x00000000) CloseSession( DeleteSubscriptions=true ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSecureChannel(); Result = Good (0x00000000) Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet OpenSecureChannel( MessageSecurityMode: None; RequestedSecurityPolicyUri: http://opcfoundation.org/UA/SecurityPolicy#None ); Result = Good (0x00000000) Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CreateSession( EndpointUrl=opc.tcp://192.168.1.3:4840; SessionName: UaCttSession_3; RequestedSessionTimeout: 60000 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet ActivateSession( LocaleIds #1; UserIdentityToken: http://opcfoundation.org/UA/SecurityPolicy#None00000000010000000001 ( ClientSignature=, UserTokenSignature= ) ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 1; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Calling BuildCacheMap Loop Count 2 Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSession().Result: Good (0x00000000) CloseSession( DeleteSubscriptions=true ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSecureChannel(); Result = Good (0x00000000) Time in BuildCacheMap = 0 seconds Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet OpenSecureChannel( MessageSecurityMode: None; RequestedSecurityPolicyUri: http://opcfoundation.org/UA/SecurityPolicy#None ); Result = Good (0x00000000) Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CreateSession( EndpointUrl=opc.tcp://192.168.1.3:4840; SessionName: UaCttSession_4; RequestedSessionTimeout: 60000 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet ActivateSession( LocaleIds #1; UserIdentityToken: http://opcfoundation.org/UA/SecurityPolicy#None00000000010000000001 ( ClientSignature=, UserTokenSignature= ) ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 1; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. CreateSubscription Requested Parameters: DefaultTimeoutHint: 20000; PublishingInterval: 250; LifetimeCount: 242; MaxKeepAliveCount: 3; PublishingEnabled: true; Priority: 0; MaxNotificationsPerPublish: 0 CreateSubscription( ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. SubscriptionId: 2336392304; RevisedPublishingInterval: 250; RevisedLifetimeCount: 242; RevisedMaxKeepAliveCount: 5 ***** CONFORMANCE UNIT 'Monitor Items 2' TEST SCRIPTS STARTING ****** ~~~ START OF TEST [tooManyItems2] ~~~ CreateMonitoredItems( ItemsToCreate #2; SubscriptionId: 2336392304; TimestampsToReturn: 1 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. CreateMonitoredItems( ItemsToCreate #2; SubscriptionId: 2336392304; TimestampsToReturn: 1 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. CreateMonitoredItems( ItemsToCreate #2; SubscriptionId: 2336392304; TimestampsToReturn: 1 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. DeleteMonitoredItems( MonitoredItemIds #0; SubscriptionId: 2336392304 ).Response.ResponseHeader.ServiceResult: BadNothingToDo (0x800f0000) as expected. ~~~ END OF TEST [tooManyItems2] ~~~ ***** CONFORMANCE UNIT 'Monitor Items 2'' TEST SCRIPTS COMPLETE ****** DeleteSubscription( SubscriptionIds #1 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSession().Result: Good (0x00000000) CloseSession( DeleteSubscriptions=true ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSecureChannel(); Result = Good (0x00000000) ***** CONFORMANCE UNIT 'Monitor Items 2' TESTING COMPLETE ****** Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet OpenSecureChannel( MessageSecurityMode: None; RequestedSecurityPolicyUri: http://opcfoundation.org/UA/SecurityPolicy#None ); Result = Good (0x00000000) Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CreateSession( EndpointUrl=opc.tcp://192.168.1.3:4840; SessionName: UaCttSession_5; RequestedSessionTimeout: 60000 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet ActivateSession( LocaleIds #1; UserIdentityToken: http://opcfoundation.org/UA/SecurityPolicy#None00000000010000000001 ( ClientSignature=, UserTokenSignature= ) ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Read( NodesToRead #2; TimestampsToReturn: 1; MaxAge: 0 ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. ~~~ START OF TEST [CheckAllUAServices] ~~~ Discovery => FindServers() => Implemented GetEndpoints() => Implemented RegisterServer() => NotImplemented Session => CreateSession() => Implemented ActivateSession() => Implemented CloseSession() => Implemented Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet Cancel() => NotImplemented NodeManagement => AddNodes() => NotImplemented AddReferences() => NotImplemented DeleteNodes() => NotImplemented DeleteReferences() => NotImplemented View => Browse() => Implemented BrowseNext() => Implemented TranslateBrowsePathsToNodeIds() => Implemented RegisteredNodes() => Implemented UnregisterNodes() => Implemented Query => QueryFirst() => NotImplemented QueryNext() => NotImplemented Attribute => Read() => Implemented HistoryRead() => NotImplemented Write() => Implemented HistoryUpdate() => NotImplemented Method => Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet Call() => Implemented MonitoredItem => CreateMonitoredItems() => Implemented ModifyMonitoredItems() => Implemented SetMonitoringMode() => Implemented SetTriggering() => NotImplemented DeleteMonitoredItems() => Implemented Subscription => CreateSubscription() => Implemented ModifySubscription() => Implemented SetPublishingMode() => Implemented Publish() => Implemented Republish() => NotImplemented Verify if this Conformance Unit should be selected for testing. TransferSubscriptions() => NotImplemented DeleteSubscriptions() => Implemented ~~~ END OF TEST [CheckAllUAServices] ~~~ Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSession().Result: Good (0x00000000) CloseSession( DeleteSubscriptions=true ).Response.ResponseHeader.ServiceResult: Good (0x00000000) as expected. Audit::PushAuditRecord - Thread and/or Subscription id is not initialized yet CloseSecureChannel(); Result = Good (0x00000000) ****************************************** COMPLIANCE TEST RUN COMPLETE ****************************************** FINAL REPORT ****************************************** UA SERVICES TESTED ****************************************** Sessions Used: 5 ****************************************** | ||||
| Files Affected | |||||
| parent of | 0004057 | closed | Yannik Klaass | Server limitations specified in Server_ServerCapabilites_OperationLimits are not used in CTT tests |
|
|
The script need to be updated to actual test what is in the test case - it should in a single call pass 15-20 monitored items, require the first 2 to work and the additional item could report the correct error or also work (if the server limit is larger then 2). |
|
|
Problem will not occur anymore as with fix of Mantis 0004057, the Responses of CreateMonitoredItemsHelper will be reassembled in case of splitting calls. |
|
|
Reviewed in call, agreed that fixes in 4057 will make this issue go away, closed issue |
| Date Modified | Username | Field | Change |
|---|---|---|---|
| 2022-09-06 09:44 | Martin Herberg | New Issue | |
| 2022-09-06 09:44 | Martin Herberg | File Added: MonitoreItem2Err001.JPG | |
| 2022-09-06 09:44 | Martin Herberg | File Added: MonitoreItem2Err001.log | |
| 2022-09-06 09:44 | Martin Herberg | File Added: MonitoreItem2Err001.pcapng | |
| 2022-09-06 09:44 | Martin Herberg | File Added: MonitoreItem2Err001.txt | |
| 2022-09-06 09:44 | Martin Herberg | File Added: MonitoreItem2Err001Debug1.JPG | |
| 2022-09-06 09:44 | Martin Herberg | File Added: MonitoreItem2Err001Debug2.JPG | |
| 2022-09-09 15:16 | Paul Hunkar | Note Added: 0017592 | |
| 2022-09-09 15:16 | Paul Hunkar | Assigned To | => Alexander Allmendinger |
| 2022-09-09 15:16 | Paul Hunkar | Status | new => assigned |
| 2022-09-12 09:24 | Sebastian Allmendinger | Assigned To | Alexander Allmendinger => Yannik Klaass |
| 2022-10-04 07:39 | Yannik Klaass | Relationship added | parent of 0004057 |
| 2022-10-04 07:49 | Yannik Klaass | Status | assigned => resolved |
| 2022-10-04 07:49 | Yannik Klaass | Resolution | open => fixed |
| 2022-10-04 07:49 | Yannik Klaass | Note Added: 0017925 | |
| 2022-10-07 11:55 | Paul Hunkar | Status | resolved => closed |
| 2022-10-07 11:55 | Paul Hunkar | Fixed in Version | => 1.03.501 |
| 2022-10-07 11:55 | Paul Hunkar | Note Added: 0017971 |
