Using V7.7.1 RC1
I get nothing but Warnings in the gateway console related to every device I have connected via OPC. This only happens when I enable two logix V21 devices using the new V21 driver. When I disable the V21 devices all my problems go away. This symptom renders the gateway useless.
The two devices are Allen-Bradley L73S guardlogix PLC’s. It seems to me that there is something with the new V21 driver that is causing havoc with the older Ethernet drivers.
Is this a known issue? See below for reference
Time Logger Message
(I) 11:41:12 AM DownTimeDetailRecorder IsShortStop did not update any rows.
(I) 11:41:12 AM DownTimeDetailRecorder OperatorCellName did not update any rows.
(I) 11:41:12 AM CacheManager [[global]] Starting production cache manager, delay execute for 59 seconds.
(I) 11:41:12 AM MESObjectManager Successfully verified MES equipment objects.
(I) 11:41:11 AM ProductionModelRunner [[global]] Production Model Runner starting.
(I) 11:41:10 AM ProductionSubscription [Scanclass ‘Default[default]’] Starting Production OPC subscription (productioncontext is running=true.)
(I) 11:41:10 AM ProductionSubscription [Scanclass ‘Default[default]’] Stopped Production OPC subscription.
(I) 11:41:10 AM ProductionSubscriptionCollection Invalidating all subscriptions.
(I) 11:41:10 AM ProductionModelManager [[global]] Loading MES production model from project using serialization version 1. (Resource name = Model)
(I) 11:41:10 AM ProductionGatewayHook [Staging version] projectUpdated called on [global]. Edit Count=176
ERROR 11:41:01 AM RuntimeDataQueryManager Error collecting scheduled vs. actual data.
com.sepasoft.production.common.exception.ProductionException: Production Module Error: RunContext operation named getRunInfo not found.
more
ERROR 11:40:30 AM RuntimeDataQueryManager Error collecting scheduled vs. actual data.
com.sepasoft.production.common.exception.ProductionException: Production Module Error: RunContext operation named getRunInfo not found.
more
(I) 11:40:30 AM ControlLogixDriver[BMS Cell 25] [BMS Cell 25] Updating tagManager with edit version 44801 with 3629 tags
(I) 11:40:30 AM ControlLogixDriver[BMS Cell 25] [BMS Cell 25] Browse complete.
(I) 11:40:30 AM ABControlLogixBrowseRequest [BMS Cell 25] Browse complete.
(I) 11:40:30 AM ABControlLogixBrowseRequest [BMS Cell 25] Creating browse nodes.
ERROR 11:40:00 AM RuntimeDataQueryManager Error collecting scheduled vs. actual data.
com.sepasoft.production.common.exception.ProductionException: Production Module Error: RunContext operation named getRunInfo not found.
more
(I) 11:39:46 AM ABControlLogixBrowseRequest [BMS Cell 25] Creating browse request using HIGH priority.
(I) 11:39:46 AM ControlLogixDriver[BMS Cell 25] Comm state changed to ACTIVE
(I) 11:39:45 AM PropertiesFactory Loading properties files from jar:file:/C:/Program%20Files%20(x86)/Inductive%20Automation/Ignition/webserver/webapps/main/WEB-INF/lib/wicket-extensions-6.1.1.jar!/org/apache/wicket/extensions/Initializer.properties with loader org.apache.wicket.resource.IsoPropertiesFilePropertiesLoader@108191a
(I) 11:39:45 AM PropertiesFactory Loading properties files from jar:file:/C:/Program%20Files%20(x86)/Inductive%20Automation/Ignition/webserver/webapps/main/WEB-INF/lib/wicket-core-6.1.1.jar!/org/apache/wicket/Application.properties with loader org.apache.wicket.resource.IsoPropertiesFilePropertiesLoader@108191a
WARN 11:39:45 AM ClockDriftDetector Clock drift, degraded performance, or pause-the-world detected. lastTime=Sat Aug 16 11:39:41 EDT 2014 currentTime=Sat Aug 16 11:39:45 EDT 2014 deviation from expected 1000ms delta=2619ms.
(I) 11:39:41 AM LocalDBManagerImpl Created auto-backup of internal database “settings” in 15 seconds
(I) 11:39:41 AM ENGINE Successfully backed up instance ‘settings’ to ‘C:\Program Files (x86)\Inductive Automation\Ignition\data\db\autobackup\db_20140816_113925.tar.gz’
(I) 11:39:40 AM LogixBrowseStateManager Browse completed in 29777ms. 607 symbols, 923673 tags, 22 programs.
(I) 11:39:40 AM ControlLogixDriver[BMS Cell 25] Processor info: Vendor=1, Product Type=14, Product Code=86, Revision=19.11, Product Name=1756-L63S/B LOGIX5563SAFETY
(I) 11:39:40 AM ControlLogixDriver[BMS Cell 25] Comm state changed to INACTIVE
WARN 11:39:40 AM ControlLogixDriver[BMS Cell 25] [BMS Cell 25] Browse unsuccessfully.
WARN 11:39:40 AM ABControlLogixBrowseRequest [BMS Cell 25] Browse request failed because fail type is other than TIMEOUT, type = DISCONNECTED.
(I) 11:39:40 AM ABControlLogixBrowseRequest [BMS Cell 25] Browse request failed because fail type is other than TIMEOUT, type = DISCONNECTED.
WARN 11:39:40 AM ABSLCReadRequest Read Request timeout. First item: N31:20, Timeout Count: 1, Transaction: 2634
WARN 11:39:40 AM TimeoutDaemon ScheduledRequest[com.inductiveautomation.xopc.drivers.allenbradley.requests.ABSLCReadRequest@ed166b] request with key “2634” failed due to timeout.
WARN 11:39:40 AM ABSLCReadRequest Read Request timeout. First item: B3:16/5, Timeout Count: 1, Transaction: 3809
WARN 11:39:40 AM TimeoutDaemon ScheduledRequest[com.inductiveautomation.xopc.drivers.allenbradley.requests.ABSLCReadRequest@110ceb3] request with key “3809” failed due to timeout.
WARN 11:39:40 AM ABSLCReadRequest Read Request timeout. First item: C5:39.ACC, Timeout Count: 1, Transaction: 649
WARN 11:39:40 AM TimeoutDaemon ScheduledRequest[com.inductiveautomation.xopc.drivers.allenbradley.requests.ABSLCReadRequest@d49245] request with key “649” failed due to timeout.
WARN 11:39:40 AM ControlLogixDriver[BMS Cell 25] [BMS Cell 25] Browse unsuccessfully.
WARN 11:39:40 AM ABControlLogixBrowseRequest [BMS Cell 25] Browse request failed because fail type is other than TIMEOUT, type = DISCONNECTED.
(I) 11:39:40 AM ABControlLogixBrowseRequest [BMS Cell 25] Browse request failed because fail type is other than TIMEOUT, type = DISCONNECTED.
WARN 11:39:40 AM ABSLCReadRequest Read Request timeout. First item: N20:6, Timeout Count: 1, Transaction: 259
WARN 11:39:40 AM TimeoutDaemon ScheduledRequest[com.inductiveautomation.xopc.drivers.allenbradley.requests.ABSLCReadRequest@c1265] request with key “259” failed due to timeout.
WARN 11:39:40 AM ABSLCReadRequest Read Request timeout. First item: N7:1, Timeout Count: 1, Transaction: 3851
WARN 11:39:40 AM TimeoutDaemon ScheduledRequest[com.inductiveautomation.xopc.drivers.allenbradley.requests.ABSLCReadRequest@19be348] request with key “3851” failed due to timeout.
WARN 11:39:40 AM ControlLogixDriver[BMS Cell 25] [BMS Cell 25] Browse unsuccessfully.
WARN 11:39:40 AM ABControlLogixBrowseRequest [BMS Cell 25] Browse aborted due to 3 consecutive timeouts.
WARN 11:39:40 AM ABControlLogixBrowseRequest [BMS Cell 25] Browse aborted due to 3 consecutive timeouts.
WARN 11:39:40 AM ABControlLogixTransportPool [BMS Cell 25] Reseting CIP connection for transaction ID of 2048
WARN 11:39:40 AM TimeoutDaemon [ABControlLogixBrowseRequest] request with key “2048” failed due to timeout.
WARN 11:39:40 AM ABSLCReadRequest Read Request timeout. First item: N10:51, Timeout Count: 1, Transaction: 746
WARN 11:39:40 AM ABSLCReadRequest Read Request timeout. First item: N7:1, Timeout Count: 1, Transaction: 4460
WARN 11:39:40 AM TimeoutDaemon ScheduledRequest[com.inductiveautomation.xopc.drivers.allenbradley.requests.ABSLCReadRequest@12f58] request with key “4460” failed due to timeout.
WARN 11:39:40 AM TimeoutDaemon ScheduledRequest[com.inductiveautomation.xopc.drivers.allenbradley.requests.ABSLCReadRequest@8a2566] request with key “746” failed due to timeout.
WARN 11:39:40 AM ClockDriftDetector Clock drift, degraded performance, or pause-the-world detected. lastTime=Sat Aug 16 11:39:34 EDT 2014 currentTime=Sat Aug 16 11:39:40 EDT 2014 deviation from expected 1000ms delta=4727ms.
WARN 11:39:34 AM ClockDriftDetector Clock drift, degraded performance, or pause-the-world detected. lastTime=Sat Aug 16 11:39:30 EDT 2014 currentTime=Sat Aug 16 11:39:34 EDT 2014 deviation from expected 1000ms delta=2834ms.
WARN 11:39:30 AM CipConnectedLayer Pending keys: Set(449)
WARN 11:39:30 AM CipConnectedLayer Received unexpected ConnectedPacket: InboundConnectedPacket(448,Swapped(SlicedByteBuf(ridx: 0, widx: 456, cap: 456/456, unwrapped: UnpooledUnsafeDirectByteBuf(ridx: 1370, widx: 1370, cap: 1370))))
WARN 11:39:30 AM CipConnectedLayer Pending keys: Set(449)
WARN 11:39:30 AM CipConnectedLayer Received unexpected ConnectedPacket: InboundConnectedPacket(447,Swapped(SlicedByteBuf(ridx: 0, widx: 327, cap: 327/327, unwrapped: UnpooledUnsafeDirectByteBuf(ridx: 1370, widx: 1370, cap: 1370))))
ERROR 11:39:30 AM CipConnectedLayer Error receiving inbound connected data.
java.lang.Exception: timed out waiting for response to sequence=447
more
ERROR 11:39:30 AM CipConnectedLay