INFO | jvm 1 | 2013/03/04 23:10:23 | 231798.239: [GC 231798.239: [ParNew: 34654K->615K(38336K), 0.0093091 secs] 979211K->945175K(1065664K), 0.0094705 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:10:26 | 231800.771: [GC 231800.771: [ParNew: 34727K->671K(38336K), 0.0093389 secs] 979287K->945241K(1065664K), 0.0094877 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:10:30 | 231805.248: [GC 231805.248: [ParNew: 34783K->652K(38336K), 0.0094566 secs] 979353K->945227K(1065664K), 0.0095929 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:10:34 | 231809.410: [GC 231809.410: [ParNew: 34764K->500K(38336K), 0.0091980 secs] 979339K->945160K(1065664K), 0.0093195 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:10:39 | 231813.806: [GC 231813.806: [ParNew: 34612K->405K(38336K), 0.0093374 secs] 979272K->945069K(1065664K), 0.0095461 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:10:43 | 231818.469: [GC 231818.469: [ParNew: 34517K->486K(38336K), 0.0094601 secs] 979181K->945151K(1065664K), 0.0095816 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:10:48 | 231823.273: [GC 231823.273: [ParNew: 34598K->596K(38336K), 0.0094262 secs] 979263K->945265K(1065664K), 0.0095873 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:10:52 | WARN [SQLTags$ClientSubscriptionProxy] [23:10:52,604]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:10:54 | 231828.911: [GC 231828.911: [ParNew: 34698K->581K(38336K), 0.0099522 secs] 979367K->945251K(1065664K), 0.0100948 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:10:56 | 231830.704: [GC 231830.704: [ParNew: 34693K->616K(38336K), 0.0094171 secs] 979363K->945294K(1065664K), 0.0095336 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:01 | 231836.004: [GC 231836.004: [ParNew: 34728K->709K(38336K), 0.0095785 secs] 979406K->945402K(1065664K), 0.0097261 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:03 | 231838.449: [GC 231838.449: [ParNew: 34821K->742K(38336K), 0.0097193 secs] 979514K->945441K(1065664K), 0.0099462 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:07 | 231842.411: [GC 231842.412: [ParNew: 34854K->950K(38336K), 0.0094198 secs] 979553K->945697K(1065664K), 0.0095498 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:11 | 231846.515: [GC 231846.515: [ParNew: 35062K->619K(38336K), 0.0094444 secs] 979809K->945425K(1065664K), 0.0095611 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:16 | 231851.270: [GC 231851.271: [ParNew: 34731K->602K(38336K), 0.0094979 secs] 979537K->945447K(1065664K), 0.0096416 secs] [Times: user=0.01 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:20 | 231855.631: [GC 231855.631: [ParNew: 34714K->501K(38336K), 0.0092369 secs] 979559K->945361K(1065664K), 0.0093705 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:22 | WARN [SQLTags$ClientSubscriptionProxy] [23:11:22,614]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:11:26 | 231861.352: [GC 231861.353: [ParNew: 34613K->523K(38336K), 0.0093094 secs] 979473K->945400K(1065664K), 0.0094740 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:31 | 231866.159: [GC 231866.159: [ParNew: 34635K->513K(38336K), 0.0094615 secs] 979512K->945397K(1065664K), 0.0095879 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:34 | 231868.746: [GC 231868.746: [ParNew: 34625K->505K(38336K), 0.0101252 secs] 979509K->945392K(1065664K), 0.0102862 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:39 | 231873.754: [GC 231873.754: [ParNew: 34617K->605K(38336K), 0.0091818 secs] 979504K->945494K(1065664K), 0.0093145 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:41 | 231876.580: [GC 231876.580: [ParNew: 34713K->635K(38336K), 0.0091195 secs] 979602K->945528K(1065664K), 0.0092332 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:45 | 231879.815: [GC 231879.816: [ParNew: 34747K->637K(38336K), 0.0102246 secs] 979640K->945534K(1065664K), 0.0103517 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:49 | 231884.496: [GC 231884.496: [ParNew: 34749K->664K(38336K), 0.0097837 secs] 979646K->945637K(1065664K), 0.0099329 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:52 | WARN [SQLTags$ClientSubscriptionProxy] [23:11:52,618]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:11:52 | WARN [SQLTags$ClientSubscriptionProxy] [23:11:52,619]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:11:54 | 231889.010: [GC 231889.011: [ParNew: 34776K->551K(38336K), 0.0093193 secs] 979749K->945531K(1065664K), 0.0094645 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:11:59 | 231893.772: [GC 231893.773: [ParNew: 34663K->713K(38336K), 0.0095864 secs] 979643K->945700K(1065664K), 0.0097428 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:04 | 231898.774: [GC 231898.775: [ParNew: 34825K->542K(38336K), 0.0098026 secs] 979812K->945535K(1065664K), 0.0099987 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:08 | 231903.532: [GC 231903.532: [ParNew: 34654K->576K(38336K), 0.0107979 secs] 979647K->945580K(1065664K), 0.0109204 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:11 | 231906.224: [GC 231906.225: [ParNew: 34688K->729K(38336K), 0.0096350 secs] 979692K->945736K(1065664K), 0.0097887 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:16 | 231910.903: [GC 231910.903: [ParNew: 34841K->794K(38336K), 0.0095504 secs] 979848K->945853K(1065664K), 0.0096714 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:19 | 231914.443: [GC 231914.443: [ParNew: 34906K->572K(38336K), 0.0095088 secs] 979965K->945639K(1065664K), 0.0096311 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:22 | WARN [SQLTags$ClientSubscriptionProxy] [23:12:22,556]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:12:22 | WARN [SQLTags$ClientSubscriptionProxy] [23:12:22,557]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:12:22 | 231917.628: [GC 231917.628: [ParNew: 34684K->647K(38336K), 0.0103806 secs] 979751K->945717K(1065664K), 0.0105296 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:26 | 231921.566: [GC 231921.566: [ParNew: 34759K->656K(38336K), 0.0098975 secs] 979829K->945788K(1065664K), 0.0100360 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:31 | 231926.012: [GC 231926.013: [ParNew: 34768K->760K(38336K), 0.0108952 secs] 979900K->945898K(1065664K), 0.0110874 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:35 | 231930.471: [GC 231930.472: [ParNew: 34872K->589K(38336K), 0.0094900 secs] 980010K->945733K(1065664K), 0.0096419 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:36 | 231930.511: [GC INFO | jvm 1 | 2013/03/04 23:12:36 | [1 CMS-initial-mark: 945143K(1027328K)] 946776K(1065664K), 0.7046252 secs] [Times: user=0.00 sys=0.00, real=0.70 secs] INFO | jvm 1 | 2013/03/04 23:12:36 | 231931.215: [CMS-concurrent-mark-start] INFO | jvm 1 | 2013/03/04 23:12:41 | 231936.209: [GC 231936.209: [ParNew: 34701K->572K(38336K), 0.0888566 secs] 979845K->945723K(1065664K), 0.0890131 secs] [Times: user=0.03 sys=0.00, real=0.09 secs] INFO | jvm 1 | 2013/03/04 23:12:46 | 231940.806: [GC 231940.806: [ParNew: 34684K->714K(38336K), 0.0104004 secs] 979835K->945868K(1065664K), 0.0105675 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:48 | 231942.933: [CMS-concurrent-mark: 11.482/11.588 secs] [Times: user=1.42 sys=0.19, real=11.72 secs] INFO | jvm 1 | 2013/03/04 23:12:48 | 231942.933: [CMS-concurrent-preclean-start] INFO | jvm 1 | 2013/03/04 23:12:48 | 231943.006: [CMS-concurrent-preclean: 0.069/0.073 secs] [Times: user=0.05 sys=0.00, real=0.07 secs] INFO | jvm 1 | 2013/03/04 23:12:48 | 231943.006: [CMS-concurrent-abortable-preclean-start] INFO | jvm 1 | 2013/03/04 23:12:49 | 231944.090: [GC 231944.091: [ParNew: 34826K->933K(38336K), 0.0102062 secs] 979980K->946092K(1065664K), 0.0103396 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:12:50 | 231945.394: [CMS-concurrent-abortable-preclean: 0.313/2.388 secs] [Times: user=0.80 sys=0.00, real=2.39 secs] INFO | jvm 1 | 2013/03/04 23:12:51 | 231945.449: [GC[YG occupancy: 18491 K (38336 K)]231945.449: [Rescan (parallel) , 0.0272771 secs]231945.476: [weak refs processing INFO | jvm 1 | 2013/03/04 23:12:57 | , 6.3628486 secs]231951.839: [class unloading, 0.0568311 secs]231951.896: [scrub symbol & string tables, 0.0275796 secs] [1 CMS-remark: 945159K(1027328K)] 963650K(1065664K), 6.4875921 secs] [Times: user=0.12 sys=0.09, real=6.49 secs] INFO | jvm 1 | 2013/03/04 23:12:57 | 231951.947: [CMS-concurrent-sweep-start] INFO | jvm 1 | 2013/03/04 23:12:57 | INFO [MasterTCPChannel ] [23:12:57,106]: (id=2) Connected to address '/10.202.1.226' INFO | jvm 1 | 2013/03/04 23:12:57 | INFO [MasterTCPChannel ] [23:12:57,147]: Error occured while communicating with backup client. Client has likely become unavailable. INFO | jvm 1 | 2013/03/04 23:12:57 | java.io.EOFException INFO | jvm 1 | 2013/03/04 23:12:57 | at com.inductiveautomation.ignition.gateway.redundancy.channels.tcp.AbstractTCPChannel.readMessage(AbstractTCPChannel.java:427) INFO | jvm 1 | 2013/03/04 23:12:57 | at com.inductiveautomation.ignition.gateway.redundancy.channels.tcp.AbstractTCPChannel.expectMessage(AbstractTCPChannel.java:482) INFO | jvm 1 | 2013/03/04 23:12:57 | at com.inductiveautomation.ignition.gateway.redundancy.channels.tcp.TCPMasterStateChannel.runProtocol(TCPMasterStateChannel.java:161) INFO | jvm 1 | 2013/03/04 23:12:57 | at com.inductiveautomation.ignition.gateway.redundancy.channels.tcp.AbstractTCPChannel.run(AbstractTCPChannel.java:327) INFO | jvm 1 | 2013/03/04 23:12:57 | INFO [MasterTCPChannel ] [23:12:57,168]: Starting redundancy channel id 2 INFO | jvm 1 | 2013/03/04 23:12:57 | INFO [MasterStateManager ] [23:12:57,193]: Successfully registered new connection to redundant master from '/10.202.1.226:54871' INFO | jvm 1 | 2013/03/04 23:12:57 | INFO [MasterTCPChannel ] [23:12:57,197]: (id=1) Shutting down channel. INFO | jvm 1 | 2013/03/04 23:12:57 | 231952.139: [GC 231952.139: [ParNew: 35045K->1964K(38336K), 0.0270179 secs] 947518K->914438K(1065664K), 0.0272584 secs] [Times: user=0.05 sys=0.00, real=0.03 secs] INFO | jvm 1 | 2013/03/04 23:12:58 | INFO [MasterTCPChannel ] [23:12:58,475]: Reporting master start time of Sat Mar 02 06:47:36 EST 2013 INFO | jvm 1 | 2013/03/04 23:12:59 | INFO [MasterTCPChannel ] [23:12:58,960]: Peer node information has been updated: ClusterNode(address=10.202.1.226, httpAddresses=[http://10.202.1.226:8088/main], sessionCount=0, loadFactor=1, activityLevel=Cold) INFO | jvm 1 | 2013/03/04 23:12:59 | 231954.430: [GC 231954.430: [ParNew: 36073K->2671K(38336K), 0.0115825 secs] 801303K->767906K(1065664K), 0.0117224 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:00 | 231955.621: [CMS-concurrent-sweep: 3.544/3.673 secs] [Times: user=1.75 sys=0.16, real=3.68 secs] INFO | jvm 1 | 2013/03/04 23:13:00 | 231955.621: [CMS-concurrent-reset-start] INFO | jvm 1 | 2013/03/04 23:13:00 | 231955.637: [CMS-concurrent-reset: 0.016/0.016 secs] [Times: user=0.01 sys=0.00, real=0.02 secs] INFO | jvm 1 | 2013/03/04 23:13:03 | 231958.601: [GC 231958.601: [ParNew: 36777K->2479K(38336K), 0.0097916 secs] 142784K->108534K(1065664K), 0.0099634 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:07 | 231962.536: [GC 231962.536: [ParNew: 36591K->2568K(38336K), 0.0092291 secs] 142646K->108636K(1065664K), 0.0093879 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:12 | 231967.535: [GC 231967.535: [ParNew: 36680K->1715K(38336K), 0.0099890 secs] 142748K->108910K(1065664K), 0.0101101 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:17 | 231972.328: [GC 231972.328: [ParNew: 35827K->583K(38336K), 0.0087357 secs] 143022K->107911K(1065664K), 0.0088528 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:22 | 231977.286: [GC 231977.286: [ParNew: 34695K->511K(38336K), 0.0082466 secs] 142023K->107900K(1065664K), 0.0083697 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:22 | WARN [SQLTags$ClientSubscriptionProxy] [23:13:22,586]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:13:22 | WARN [SQLTags$ClientSubscriptionProxy] [23:13:22,586]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:13:27 | 231981.986: [GC 231981.986: [ParNew: 34623K->613K(38336K), 0.0098055 secs] 142012K->108005K(1065664K), 0.0099492 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:29 | 231984.727: [GC 231984.727: [ParNew: 34725K->574K(38336K), 0.0094439 secs] 142117K->107969K(1065664K), 0.0095765 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:34 | 231989.785: [GC 231989.785: [ParNew: 34686K->670K(38336K), 0.0082590 secs] 142081K->108092K(1065664K), 0.0083792 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:37 | 231992.113: [GC 231992.113: [ParNew: 34782K->459K(38336K), 0.0080568 secs] 142204K->107883K(1065664K), 0.0081823 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:41 | 231996.113: [GC 231996.113: [ParNew: 34571K->520K(38336K), 0.0079697 secs] 141995K->107965K(1065664K), 0.0082214 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:45 | 232000.532: [GC 232000.532: [ParNew: 34632K->588K(38336K), 0.0084902 secs] 142077K->108041K(1065664K), 0.0086962 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:49 | 232004.611: [GC 232004.611: [ParNew: 34700K->493K(38336K), 0.0091464 secs] 142153K->107949K(1065664K), 0.0092716 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:13:54 | 232009.466: [GC 232009.466: [ParNew: 34605K->538K(38336K), 0.0084103 secs] 142061K->108006K(1065664K), 0.0085588 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:00 | 232014.952: [GC 232014.952: [ParNew: 34650K->541K(38336K), 0.0082210 secs] 142118K->108018K(1065664K), 0.0083531 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:05 | 232019.953: [GC 232019.953: [ParNew: 34653K->561K(38336K), 0.0088152 secs] 142130K->108042K(1065664K), 0.0089627 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:07 | 232022.535: [GC 232022.536: [ParNew: 34673K->559K(38336K), 0.0081038 secs] 142154K->108044K(1065664K), 0.0082422 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:12 | 232027.430: [GC 232027.430: [ParNew: 34665K->611K(38336K), 0.0082939 secs] 142149K->108099K(1065664K), 0.0084449 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:15 | 232029.768: [GC 232029.768: [ParNew: 34723K->596K(38336K), 0.0085931 secs] 142211K->108101K(1065664K), 0.0087331 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:18 | 232033.732: [GC 232033.732: [ParNew: 34708K->645K(38336K), 0.0080590 secs] 142213K->108160K(1065664K), 0.0082085 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:22 | WARN [SQLTags$ClientSubscriptionProxy] [23:14:22,556]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:14:23 | 232038.133: [GC 232038.133: [ParNew: 34742K->630K(38336K), 0.0080793 secs] 142258K->108207K(1065664K), 0.0082214 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:27 | 232042.368: [GC 232042.368: [ParNew: 34742K->510K(38336K), 0.0082108 secs] 142319K->108088K(1065664K), 0.0083472 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:32 | 232047.637: [GC 232047.637: [ParNew: 34613K->541K(38336K), 0.0078936 secs] 142191K->108122K(1065664K), 0.0080376 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:37 | 232052.562: [GC 232052.562: [ParNew: 34653K->524K(38336K), 0.0079924 secs] 142234K->108108K(1065664K), 0.0081471 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:42 | 232057.652: [GC 232057.652: [ParNew: 34636K->542K(38336K), 0.0083773 secs] 142220K->108129K(1065664K), 0.0084974 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:44 | 232059.690: [GC 232059.690: [ParNew: 34654K->563K(38336K), 0.0081211 secs] 142241K->108153K(1065664K), 0.0082503 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:50 | 232065.378: [GC 232065.378: [ParNew: 34675K->614K(38336K), 0.0095467 secs] 142265K->108206K(1065664K), 0.0096941 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:52 | 232067.251: [GC 232067.251: [ParNew: 34726K->577K(38336K), 0.0082844 secs] 142318K->108178K(1065664K), 0.0084326 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:14:56 | 232071.675: [GC 232071.675: [ParNew: 34689K->586K(38336K), 0.0084218 secs] 142290K->108222K(1065664K), 0.0085753 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:00 | 232075.722: [GC 232075.723: [ParNew: 34698K->491K(38336K), 0.0085710 secs] 142334K->108130K(1065664K), 0.0087258 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:05 | 232080.318: [GC 232080.318: [ParNew: 34603K->520K(38336K), 0.0079600 secs] 142242K->108161K(1065664K), 0.0080900 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:10 | 232084.860: [GC 232084.860: [ParNew: 34632K->500K(38336K), 0.0080227 secs] 142273K->108142K(1065664K), 0.0081670 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:15 | 232090.041: [GC 232090.042: [ParNew: 34612K->741K(38336K), 0.0082753 secs] 142254K->108385K(1065664K), 0.0084354 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:20 | 232095.284: [GC 232095.284: [ParNew: 34853K->614K(38336K), 0.0087014 secs] 142497K->108270K(1065664K), 0.0088571 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:22 | WARN [SQLTags$ClientSubscriptionProxy] [23:15:22,554]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:15:22 | 232097.462: [GC 232097.463: [ParNew: 34726K->602K(38336K), 0.0085555 secs] 142382K->108267K(1065664K), 0.0086866 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:27 | 232102.391: [GC 232102.391: [ParNew: 34714K->632K(38336K), 0.0082272 secs] 142379K->108305K(1065664K), 0.0083741 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:30 | 232105.171: [GC 232105.171: [ParNew: 34736K->624K(38336K), 0.0081976 secs] 142409K->108343K(1065664K), 0.0083392 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:33 | 232108.722: [GC 232108.722: [ParNew: 34728K->500K(38336K), 0.0083675 secs] 142448K->108229K(1065664K), 0.0084958 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:38 | 232113.418: [GC 232113.419: [ParNew: 34612K->528K(38336K), 0.0079840 secs] 142341K->108275K(1065664K), 0.0081211 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:42 | 232117.607: [GC 232117.607: [ParNew: 34640K->544K(38336K), 0.0082034 secs] 142387K->108293K(1065664K), 0.0083463 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:47 | 232122.407: [GC 232122.407: [ParNew: 34656K->684K(38336K), 0.0082457 secs] 142405K->108445K(1065664K), 0.0083895 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:52 | 232127.736: [GC 232127.736: [ParNew: 34796K->639K(38336K), 0.0091827 secs] 142557K->108415K(1065664K), 0.0093301 secs] [Times: user=0.02 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:15:57 | 232132.768: [GC 232132.768: [ParNew: 34741K->618K(38336K), 0.0109470 secs] 142517K->108402K(1065664K), 0.0110711 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:00 | 232134.897: [GC 232134.897: [ParNew: 34730K->719K(38336K), 0.0087415 secs] 142514K->108510K(1065664K), 0.0088822 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:05 | 232139.865: [GC 232139.865: [ParNew: 34831K->734K(38336K), 0.0117296 secs] 142622K->108574K(1065664K), 0.0118745 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:08 | 232143.036: [GC 232143.036: [ParNew: 34846K->677K(38336K), 0.0087341 secs] 142686K->108519K(1065664K), 0.0088953 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:11 | 232146.698: [GC 232146.698: [ParNew: 34789K->526K(38336K), 0.0084722 secs] 142631K->108371K(1065664K), 0.0086046 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:16 | 232151.089: [GC 232151.089: [ParNew: 34638K->674K(38336K), 0.0082355 secs] 142483K->108547K(1065664K), 0.0083685 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:20 | 232155.125: [GC 232155.125: [ParNew: 34786K->619K(38336K), 0.0085270 secs] 142659K->108494K(1065664K), 0.0086781 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:22 | WARN [SQLTags$ClientSubscriptionProxy] [23:16:22,601]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:16:25 | 232160.175: [GC 232160.175: [ParNew: 34731K->584K(38336K), 0.0084930 secs] 142606K->108466K(1065664K), 0.0086444 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:30 | 232164.998: [GC 232164.998: [ParNew: 34696K->571K(38336K), 0.0082698 secs] 142578K->108482K(1065664K), 0.0084062 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:35 | 232170.637: [GC 232170.637: [ParNew: 34683K->498K(38336K), 0.0083557 secs] 142594K->108411K(1065664K), 0.0085340 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:38 | 232172.907: [GC 232172.908: [ParNew: 34605K->485K(38336K), 0.0084107 secs] 142518K->108402K(1065664K), 0.0085620 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:43 | 232177.954: [GC 232177.954: [ParNew: 34597K->545K(38336K), 0.0080654 secs] 142514K->108466K(1065664K), 0.0082029 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:46 | 232180.951: [GC 232180.951: [ParNew: 34657K->566K(38336K), 0.0083610 secs] 142578K->108489K(1065664K), 0.0084931 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:49 | 232184.506: [GC 232184.506: [ParNew: 34678K->573K(38336K), 0.0087675 secs] 142601K->108499K(1065664K), 0.0089025 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:52 | WARN [SQLTags$ClientSubscriptionProxy] [23:16:52,618]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:16:53 | 232188.681: [GC 232188.681: [ParNew: 34685K->581K(38336K), 0.0085062 secs] 142611K->108539K(1065664K), 0.0086590 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:16:58 | 232193.129: [GC 232193.129: [ParNew: 34693K->602K(38336K), 0.0082552 secs] 142651K->108568K(1065664K), 0.0083837 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:02 | 232197.697: [GC 232197.697: [ParNew: 34714K->628K(38336K), 0.0082944 secs] 142680K->108597K(1065664K), 0.0084290 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:08 | 232203.128: [GC 232203.128: [ParNew: 34740K->631K(38336K), 0.0082096 secs] 142709K->108612K(1065664K), 0.0083670 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:13 | 232208.078: [GC 232208.078: [ParNew: 34743K->613K(38336K), 0.0095279 secs] 142724K->108641K(1065664K), 0.0096475 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:16 | 232210.954: [GC 232210.955: [ParNew: 34725K->581K(38336K), 0.0085487 secs] 142753K->108611K(1065664K), 0.0086697 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:20 | 232215.583: [GC 232215.583: [ParNew: 34693K->600K(38336K), 0.0081846 secs] 142723K->108642K(1065664K), 0.0083118 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:24 | 232219.090: [GC 232219.090: [ParNew: 34703K->600K(38336K), 0.0083291 secs] 142745K->108651K(1065664K), 0.0084522 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:27 | 232221.990: [GC 232221.990: [ParNew: 34712K->569K(38336K), 0.0086171 secs] 142763K->108621K(1065664K), 0.0087518 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:31 | 232226.385: [GC 232226.385: [ParNew: 34681K->829K(38336K), 0.0096158 secs] 142733K->108917K(1065664K), 0.0097443 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:35 | 232230.764: [GC 232230.764: [ParNew: 34941K->593K(38336K), 0.0083525 secs] 143029K->108682K(1065664K), 0.0084696 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:40 | 232235.471: [GC 232235.471: [ParNew: 34705K->564K(38336K), 0.0082947 secs] 142794K->108671K(1065664K), 0.0084209 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:45 | 232240.242: [GC 232240.242: [ParNew: 34676K->542K(38336K), 0.0086726 secs] 142783K->108651K(1065664K), 0.0088123 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:50 | 232245.073: [GC 232245.073: [ParNew: 34654K->554K(38336K), 0.0103718 secs] 142763K->108667K(1065664K), 0.0105742 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:52 | WARN [SQLTags$ClientSubscriptionProxy] [23:17:52,639]: Client subscription proxy got a tag change event after it was shut down. INFO | jvm 1 | 2013/03/04 23:17:53 | 232248.583: [GC 232248.583: [ParNew: 34666K->707K(38336K), 0.0087343 secs] 142779K->108830K(1065664K), 0.0088800 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:17:57 | 232252.288: [GC 232252.288: [ParNew: 34819K->681K(38336K), 0.0085567 secs] 142942K->108843K(1065664K), 0.0086870 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:18:02 | 232256.798: [GC 232256.798: [ParNew: 34793K->599K(38336K), 0.0084072 secs] 142955K->108767K(1065664K), 0.0085279 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:18:04 | 232259.468: [GC 232259.468: [ParNew: 34711K->586K(38336K), 0.0082292 secs] 142879K->108763K(1065664K), 0.0083459 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:18:09 | 232263.725: [GC 232263.725: [ParNew: 34698K->618K(38336K), 0.0086969 secs] 142875K->108817K(1065664K), 0.0088464 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:18:13 | 232268.093: [GC 232268.093: [ParNew: 34730K->597K(38336K), 0.0081927 secs] 142929K->108797K(1065664K), 0.0083099 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:18:18 | 232272.798: [GC 232272.798: [ParNew: 34709K->659K(38336K), 0.0088871 secs] 142909K->108919K(1065664K), 0.0090336 secs] [Times: user=0.03 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:18:23 | 232277.857: [GC 232277.857: [ParNew: 34771K->541K(38336K), 0.0084347 secs] 143031K->108802K(1065664K), 0.0085602 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] INFO | jvm 1 | 2013/03/04 23:18:28 | 232283.189: [GC 232283.190: [ParNew: 34637K->565K(38336K), 0.0081976 secs] 142898K->108844K(1065664K), 0.0083157 secs] [Times: user=0.03 sys=0.00, real=0.01 secs]