Sat 3/18 1:53:30.223 [main@6e2c634b] Error processing TZ:America/Chicago threw:java.text.ParseException: Missing non-optional hours Sat 3/18 1:53:30.230 [main@6e2c634b] Changed default timezone to:Central Standard Time Sat 3/18 1:53:30.244 [main@6e2c634b] user.dir2=/opt/sagetv/server Sat 3/18 1:53:30.244 [main@6e2c634b] classpath=Sage.jar:JARs/lucene-core-3.6.0.jar:/:JARs/ant.jar:JARs/apache-jsp-8.5.70.jar:JARs/apache-jsp-9.4.44.jar:JARs/apache-jstl-9.4.44.jar:JARs/api-common-2.0.jar:JARs/asm-9.2.jar:JARs/asm-analysis-9.2.jar:JARs/asm-commons-9.2.jar:JARs/asm-tree-9.2.jar:JARs/CommercialDetector.jar:JARs/commons-codec-1.9.jar:JARs/commons-dbutils-1.3.jar:JARs/commons-io-2.5.jar:JARs/commons-jxpath-1.1.jar:JARs/commons-lang-2.4.jar:JARs/commons-lang3-3.4.jar:JARs/commons-logging-1.2.jar:JARs/commons-net-1.4.1.jar:JARs/darksky-forecast-api-1.3.1.jar:JARs/darksky-forecast-api-jackson-1.3.1.jar:JARs/dom4j-1.6.1.jar:JARs/GoogleWeather.jar:JARs/groovy-all-2.0.5.jar:JARs/gson-2.7.jar:JARs/gtools.jar:JARs/hamcrest-core-1.3.jar:JARs/htmlparser-1.6.jar:JARs/httpclient-4.5.1.jar:JARs/httpcore-4.4.3.jar:JARs/jackson-annotations-2.9.8.jar:JARs/jackson-core-2.9.8.jar:JARs/jackson-databind-2.9.8.jar:JARs/jackson-datatype-jsr310-2.9.8.jar:JARs/javax.annotation-api-1.3.2.jar:JARs/jaxws-api-2.3.1.jar:JARs/jcifs-1.1.6.jar:JARs/jetty-annotations-9.4.44.jar:JARs/jetty-deploy-9.4.44.jar:JARs/jetty-http-9.4.44.jar:JARs/jetty-io-9.4.44.jar:JARs/jetty-jaas-9.4.44.jar:JARs/jetty-jmx-9.4.44.jar:JARs/jetty-jndi-9.4.44.jar:JARs/jetty-plus-9.4.44.jar:JARs/jetty-rewrite-9.4.44.jar:JARs/jetty-schemas-3.1.jar:JARs/jetty-security-9.4.44.jar:JARs/jetty-server-9.4.44.jar:JARs/jetty-servlet-9.4.44.jar:JARs/jetty-servlets-9.4.44.jar:JARs/jetty-starter.jar:JARs/jetty-util-9.4.44.jar:JARs/jetty-webapp-9.4.44.jar:JARs/jetty-xml-9.4.44.jar:JARs/json-20140107.jar:JARs/jsoup.jar:JARs/junit-4.12.jar:JARs/log4j-1.2.17.jar:JARs/lucene-core-3.6.0.jar:JARs/nielm_sageutls.jar:JARs/nielm_sagexmlinfo.jar:JARs/org.apache.taglibs.taglibs-standard-impl-1.2.5.jar:JARs/org.apache.taglibs.taglibs-standard-spec-1.2.5.jar:JARs/org.eclipse.jdt.ecj-3.19.0.jar:JARs/org.eclipse.jetty.apache-jsp-9.4.44.jar:JARs/org.mortbay.jasper.apache-el-8.5.70.jar:JARs/org.mortbay.jasper.apache-jsp-8.5.70.jar:JARs/phoenix.jar:JARs/sagex-api.jar:JARs/sbbi-upnplib-1.0.3.jar:JARs/servlet-api-3.1.jar:JARs/slf4j-api-1.7.12.jar:JARs/slf4j-log4j12-1.7.12.jar:JARs/themoviedbapi-4.4.jar:JARs/thetvdbapi-1.10.jar:JARs/validation-api-1.1.0.Final.jar:JARs/vecmath.jar:JARs/webui-4.0.0.jar Sat 3/18 1:53:30.245 [main@6e2c634b] JVM version=1.8.0_41 Sat 3/18 1:53:30.245 [main@6e2c634b] OS=Linux 5.19.17-Unraid Sat 3/18 1:53:30.246 [main@6e2c634b] client=false Sat 3/18 1:53:30.246 [main@6e2c634b] locale=en_US Sat 3/18 1:53:30.256 [ThreadMonitor@595b58c0] Thread CPU monitoring started interval=300000 Sat 3/18 1:53:30.263 [main@6e2c634b] SageTV V9.2.8.1 Sat 3/18 1:53:30.263 [main@6e2c634b] Data Model=64-bit Sat 3/18 1:53:30.272 [main@6e2c634b] hostname=429c7bba09b0 Sat 3/18 1:53:30.273 [main@6e2c634b] Splash: User Interface Manager is initializing... Sat 3/18 1:53:30.404 [main@6e2c634b] Splash: Object Database is initializing... Sat 3/18 1:53:30.508 [main@6e2c634b] dbFile=/opt/sagetv/server/Wiz.bin(72735904) dbBackupFile=/opt/sagetv/server/Wiz.bak(75018831) Sat 3/18 1:53:30.509 [main@6e2c634b] Wizard starting to load database info... Sat 3/18 1:53:30.510 [main@6e2c634b] Splash: Object Database Source is initializing... Sat 3/18 1:53:30.525 [main@6e2c634b] Reading DB file:/opt/sagetv/server/Wiz.bin with version 87 Sat 3/18 1:53:30.525 [main@6e2c634b] DBFile at version 87 FileSize=72735904 Sat 3/18 1:53:30.526 [main@6e2c634b] Wizard allocating table for Year of size 473 Sat 3/18 1:53:30.530 [main@6e2c634b] Splash: Object Database is initializing... 0% done Sat 3/18 1:53:30.531 [main@6e2c634b] Wizard loading main index for Year bytes=8576 Sat 3/18 1:53:30.534 [main@6e2c634b] Load time for Year 3 msec 0.006342495 msec/object Sat 3/18 1:53:30.535 [main@6e2c634b] Index check time for Year 0 msec Sat 3/18 1:53:30.536 [main@6e2c634b] Splash: Object Database is initializing... 0% done Sat 3/18 1:53:30.537 [main@6e2c634b] Wizard allocating table for Network of size 197 Sat 3/18 1:53:30.538 [main@6e2c634b] Splash: Object Database is initializing... 0% done Sat 3/18 1:53:30.538 [main@6e2c634b] Wizard loading main index for Network bytes=3295 Sat 3/18 1:53:30.539 [main@6e2c634b] Load time for Network 1 msec 0.005076142 msec/object Sat 3/18 1:53:30.540 [main@6e2c634b] Index check time for Network 0 msec Sat 3/18 1:53:30.541 [main@6e2c634b] Splash: Object Database is initializing... 0% done Sat 3/18 1:53:30.543 [main@6e2c634b] Wizard allocating table for Title of size 35156 Sat 3/18 1:53:30.543 [main@6e2c634b] Splash: Object Database is initializing... 0% done Sat 3/18 1:53:30.544 [main@6e2c634b] Wizard loading main index for Title bytes=1138132 Sat 3/18 1:53:30.617 [main@6e2c634b] Load time for Title 73 msec 0.0020764591 msec/object Sat 3/18 1:53:30.625 [main@6e2c634b] Index check time for Title 3 msec Sat 3/18 1:53:30.626 [main@6e2c634b] Splash: Object Database is initializing... 0% done Sat 3/18 1:53:30.626 [main@6e2c634b] Wizard loading alt index 1 for Title bytes=140630 Sat 3/18 1:53:30.634 [main@6e2c634b] Load time for alt index 1 for Title 8 msec Sat 3/18 1:53:30.643 [main@6e2c634b] Index check time for alt index 1 for Title 9 msec Sat 3/18 1:53:30.644 [main@6e2c634b] Splash: Object Database is initializing... 2% done Sat 3/18 1:53:30.644 [main@6e2c634b] Wizard allocating table for Channel of size 435 Sat 3/18 1:53:30.645 [main@6e2c634b] Splash: Object Database is initializing... 2% done Sat 3/18 1:53:30.645 [main@6e2c634b] Wizard loading main index for Channel bytes=68131 Sat 3/18 1:53:30.648 [main@6e2c634b] Load time for Channel 3 msec 0.0068965517 msec/object Sat 3/18 1:53:30.649 [main@6e2c634b] Index check time for Channel 1 msec Sat 3/18 1:53:30.649 [main@6e2c634b] Splash: Object Database is initializing... 2% done Sat 3/18 1:53:30.650 [main@6e2c634b] Wizard allocating table for Bonus of size 464 Sat 3/18 1:53:30.650 [main@6e2c634b] Splash: Object Database is initializing... 2% done Sat 3/18 1:53:30.651 [main@6e2c634b] Wizard loading main index for Bonus bytes=8915 Sat 3/18 1:53:30.651 [main@6e2c634b] Load time for Bonus 0 msec 0.0 msec/object Sat 3/18 1:53:30.652 [main@6e2c634b] Index check time for Bonus 0 msec Sat 3/18 1:53:30.652 [main@6e2c634b] Splash: Object Database is initializing... 2% done Sat 3/18 1:53:30.653 [main@6e2c634b] Wizard allocating table for People of size 91134 Sat 3/18 1:53:30.654 [main@6e2c634b] Splash: Object Database is initializing... 2% done Sat 3/18 1:53:30.654 [main@6e2c634b] Wizard loading main index for People bytes=4977290 Sat 3/18 1:53:30.667 [main@6e2c634b] Lucene index(person): rooted at /rw/lucene/ running at /rw/lucene-run/ DiskIndex:false RunningDiskIndex:false Sat 3/18 1:53:30.872 [main@6e2c634b] Lucene index(person) reader opened in 4 Sat 3/18 1:53:30.876 [main@6e2c634b] Lucene index(person) docs: 0 Sat 3/18 1:53:30.877 [main@6e2c634b] Increased Thread pool to size=1 Sat 3/18 1:53:30.877 [main@6e2c634b] Lucene index(person) does not have same item count as wizard (idx:0, wiz:91134) - RESETING Sat 3/18 1:53:30.879 [main@6e2c634b] Index(person) reset Sat 3/18 1:53:31.043 [main@6e2c634b] Load time for People 389 msec 0.00426844 msec/object Sat 3/18 1:53:31.056 [main@6e2c634b] Index check time for People 12 msec Sat 3/18 1:53:31.056 [main@6e2c634b] Lucene index(person) built from Wizard Sat 3/18 1:53:31.057 [main@6e2c634b] Splash: Object Database is initializing... 2% done Sat 3/18 1:53:31.058 [main@6e2c634b] Wizard loading alt index 2 for People bytes=364542 Sat 3/18 1:53:31.082 [main@6e2c634b] Load time for alt index 2 for People 25 msec Sat 3/18 1:53:31.108 [LucenePersonTransactionTask@18fd2fbb] 19.43% / 5146 work queue, 1000 inserted @ 0.19 ms/peep avg [tot:189ms] Sat 3/18 1:53:31.113 [main@6e2c634b] Index check time for alt index 2 for People 29 msec Sat 3/18 1:53:31.113 [main@6e2c634b] Wizard loading alt index 16 for People bytes=364542 Sat 3/18 1:53:31.135 [main@6e2c634b] Load time for alt index 16 for People 22 msec Sat 3/18 1:53:31.148 [LucenePersonTransactionTask@18fd2fbb] 38.87% / 5146 work queue, 2000 inserted @ 0.11 ms/peep avg [tot:227ms] Sat 3/18 1:53:31.153 [main@6e2c634b] Index check time for alt index 16 for People 17 msec Sat 3/18 1:53:31.154 [main@6e2c634b] Wizard allocating table for SubCategory of size 263 Sat 3/18 1:53:31.155 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.156 [main@6e2c634b] Wizard loading main index for SubCategory bytes=5041 Sat 3/18 1:53:31.157 [main@6e2c634b] Load time for SubCategory 1 msec 0.0038022813 msec/object Sat 3/18 1:53:31.158 [main@6e2c634b] Index check time for SubCategory 0 msec Sat 3/18 1:53:31.159 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.160 [main@6e2c634b] Wizard allocating table for Rated of size 6 Sat 3/18 1:53:31.161 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.162 [main@6e2c634b] Wizard loading main index for Rated bytes=82 Sat 3/18 1:53:31.163 [main@6e2c634b] Load time for Rated 1 msec 0.16666667 msec/object Sat 3/18 1:53:31.164 [main@6e2c634b] Index check time for Rated 0 msec Sat 3/18 1:53:31.165 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.166 [main@6e2c634b] Wizard allocating table for ParentalRating of size 0 Sat 3/18 1:53:31.167 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.167 [main@6e2c634b] Wizard allocating table for ExtendedRating of size 18 Sat 3/18 1:53:31.168 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.168 [main@6e2c634b] Wizard loading main index for ExtendedRating bytes=393 Sat 3/18 1:53:31.169 [main@6e2c634b] Load time for ExtendedRating 1 msec 0.055555556 msec/object Sat 3/18 1:53:31.169 [main@6e2c634b] Index check time for ExtendedRating 0 msec Sat 3/18 1:53:31.170 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.171 [main@6e2c634b] Wizard allocating table for Category of size 378 Sat 3/18 1:53:31.171 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.172 [main@6e2c634b] Wizard loading main index for Category bytes=7834 Sat 3/18 1:53:31.173 [main@6e2c634b] Load time for Category 1 msec 0.0026455026 msec/object Sat 3/18 1:53:31.174 [main@6e2c634b] Index check time for Category 0 msec Sat 3/18 1:53:31.175 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.175 [main@6e2c634b] Wizard allocating table for PrimeTitle of size 0 Sat 3/18 1:53:31.176 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.177 [main@6e2c634b] Wizard allocating table for Show of size 81697 Sat 3/18 1:53:31.178 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:31.178 [LucenePersonTransactionTask@18fd2fbb] 58.30% / 5146 work queue, 3000 inserted @ 0.09 ms/peep avg [tot:255ms] Sat 3/18 1:53:31.179 [main@6e2c634b] Wizard loading main index for Show bytes=29093960 Sat 3/18 1:53:31.180 [main@6e2c634b] Lucene index(show): rooted at /rw/lucene/ running at /rw/lucene-run/ DiskIndex:false RunningDiskIndex:false Sat 3/18 1:53:31.181 [main@6e2c634b] Lucene index(show) reader opened in 0 Sat 3/18 1:53:31.181 [main@6e2c634b] Lucene index(show) docs: 0 Sat 3/18 1:53:31.183 [main@6e2c634b] Lucene index(show) does not have same item count as wizard (idx:0, wiz:81697) - RESETING Sat 3/18 1:53:31.184 [main@6e2c634b] Index(show) reset Sat 3/18 1:53:31.223 [LucenePersonTransactionTask@18fd2fbb] 77.73% / 5146 work queue, 4000 inserted @ 0.07 ms/peep avg [tot:296ms] Sat 3/18 1:53:31.288 [LucenePersonTransactionTask@18fd2fbb] 97.16% / 5146 work queue, 5000 inserted @ 0.07 ms/peep avg [tot:358ms] Sat 3/18 1:53:31.302 [LucenePersonTransactionTask@18fd2fbb] 100% work queue, 5146 insertions @ 0.07 ms/peep [tot:361ms] Sat 3/18 1:53:31.344 [LuceneShowTransactionTask@10ad105d] 17.60% / 5681 work queue, 1169 inserted @ 0.14 ms/show avg [tot:158ms] Sat 3/18 1:53:31.353 [LucenePersonTransactionTask@18fd2fbb] 1.16% / 85989 work queue, 6146 inserted @ 0.07 ms/peep avg [tot:409ms] Sat 3/18 1:53:31.388 [LucenePersonTransactionTask@18fd2fbb] 2.33% / 85989 work queue, 7146 inserted @ 0.06 ms/peep avg [tot:442ms] Sat 3/18 1:53:31.417 [LucenePersonTransactionTask@18fd2fbb] 3.49% / 85989 work queue, 8146 inserted @ 0.06 ms/peep avg [tot:469ms] Sat 3/18 1:53:31.421 [LuceneShowTransactionTask@10ad105d] 35.21% / 5681 work queue, 2169 inserted @ 0.11 ms/show avg [tot:233ms] Sat 3/18 1:53:31.448 [LucenePersonTransactionTask@18fd2fbb] 4.65% / 85989 work queue, 9146 inserted @ 0.05 ms/peep avg [tot:500ms] Sat 3/18 1:53:31.502 [LucenePersonTransactionTask@18fd2fbb] 5.81% / 85989 work queue, 10146 inserted @ 0.05 ms/peep avg [tot:550ms] Sat 3/18 1:53:31.508 [LuceneShowTransactionTask@10ad105d] 52.81% / 5681 work queue, 3169 inserted @ 0.10 ms/show avg [tot:317ms] Sat 3/18 1:53:31.551 [LucenePersonTransactionTask@18fd2fbb] 6.98% / 85989 work queue, 11146 inserted @ 0.05 ms/peep avg [tot:591ms] Sat 3/18 1:53:31.577 [LuceneShowTransactionTask@10ad105d] 70.41% / 5681 work queue, 4169 inserted @ 0.09 ms/show avg [tot:378ms] Sat 3/18 1:53:31.587 [LucenePersonTransactionTask@18fd2fbb] 8.14% / 85989 work queue, 12146 inserted @ 0.05 ms/peep avg [tot:624ms] Sat 3/18 1:53:31.693 [LuceneShowTransactionTask@10ad105d] 88.01% / 5681 work queue, 5169 inserted @ 0.09 ms/show avg [tot:490ms] Sat 3/18 1:53:31.710 [LucenePersonTransactionTask@18fd2fbb] 9.30% / 85989 work queue, 13146 inserted @ 0.06 ms/peep avg [tot:742ms] Sat 3/18 1:53:31.753 [LucenePersonTransactionTask@18fd2fbb] 10.47% / 85989 work queue, 14146 inserted @ 0.06 ms/peep avg [tot:780ms] Sat 3/18 1:53:31.760 [LuceneShowTransactionTask@10ad105d] 100% work queue, 5850 insertions @ 0.09 ms/show [tot:545ms] Sat 3/18 1:53:31.778 [LucenePersonTransactionTask@18fd2fbb] 11.63% / 85989 work queue, 15146 inserted @ 0.05 ms/peep avg [tot:802ms] Sat 3/18 1:53:31.810 [LucenePersonTransactionTask@18fd2fbb] 12.79% / 85989 work queue, 16146 inserted @ 0.05 ms/peep avg [tot:833ms] Sat 3/18 1:53:31.852 [LuceneShowTransactionTask@10ad105d] 2.26% / 44323 work queue, 6850 inserted @ 0.09 ms/show avg [tot:633ms] Sat 3/18 1:53:31.873 [LucenePersonTransactionTask@18fd2fbb] 13.96% / 85989 work queue, 17146 inserted @ 0.05 ms/peep avg [tot:894ms] Sat 3/18 1:53:31.909 [LucenePersonTransactionTask@18fd2fbb] 15.12% / 85989 work queue, 18146 inserted @ 0.05 ms/peep avg [tot:928ms] Sat 3/18 1:53:31.938 [LuceneShowTransactionTask@10ad105d] 4.51% / 44323 work queue, 7850 inserted @ 0.09 ms/show avg [tot:718ms] Sat 3/18 1:53:31.951 [LucenePersonTransactionTask@18fd2fbb] 16.28% / 85989 work queue, 19146 inserted @ 0.05 ms/peep avg [tot:967ms] Sat 3/18 1:53:31.968 [LucenePersonTransactionTask@18fd2fbb] 17.44% / 85989 work queue, 20146 inserted @ 0.05 ms/peep avg [tot:983ms] Sat 3/18 1:53:31.994 [LucenePersonTransactionTask@18fd2fbb] 18.61% / 85989 work queue, 21146 inserted @ 0.05 ms/peep avg [tot:1007ms] Sat 3/18 1:53:31.999 [main@6e2c634b] Load time for Show 821 msec 0.010049328 msec/object Sat 3/18 1:53:32.011 [main@6e2c634b] Index check time for Show 11 msec Sat 3/18 1:53:32.011 [main@6e2c634b] Lucene index(show) built from Wizard Sat 3/18 1:53:32.012 [main@6e2c634b] Splash: Object Database is initializing... 10% done Sat 3/18 1:53:32.012 [main@6e2c634b] Wizard loading alt index 3 for Show bytes=326794 Sat 3/18 1:53:32.017 [main@6e2c634b] Load time for alt index 3 for Show 5 msec Sat 3/18 1:53:32.102 [LucenePersonTransactionTask@18fd2fbb] 19.77% / 85989 work queue, 22146 inserted @ 0.05 ms/peep avg [tot:1113ms] Sat 3/18 1:53:32.111 [main@6e2c634b] Index check time for alt index 3 for Show 93 msec Sat 3/18 1:53:32.119 [main@6e2c634b] Wizard allocating table for Airing of size 157211 Sat 3/18 1:53:32.123 [main@6e2c634b] Splash: Object Database is initializing... 50% done Sat 3/18 1:53:32.124 [main@6e2c634b] Wizard loading main index for Airing bytes=6131235 Sat 3/18 1:53:32.150 [LucenePersonTransactionTask@18fd2fbb] 20.93% / 85989 work queue, 23146 inserted @ 0.05 ms/peep avg [tot:1154ms] Sat 3/18 1:53:32.156 [LuceneShowTransactionTask@10ad105d] 6.77% / 44323 work queue, 8850 inserted @ 0.11 ms/show avg [tot:935ms] Sat 3/18 1:53:32.194 [LucenePersonTransactionTask@18fd2fbb] 22.10% / 85989 work queue, 24146 inserted @ 0.05 ms/peep avg [tot:1194ms] Sat 3/18 1:53:32.231 [LucenePersonTransactionTask@18fd2fbb] 23.26% / 85989 work queue, 25146 inserted @ 0.05 ms/peep avg [tot:1227ms] Sat 3/18 1:53:32.261 [LucenePersonTransactionTask@18fd2fbb] 24.42% / 85989 work queue, 26146 inserted @ 0.05 ms/peep avg [tot:1253ms] Sat 3/18 1:53:32.282 [main@6e2c634b] Load time for Airing 158 msec 0.0010050187 msec/object Sat 3/18 1:53:32.290 [LucenePersonTransactionTask@18fd2fbb] 25.58% / 85989 work queue, 27146 inserted @ 0.05 ms/peep avg [tot:1276ms] Sat 3/18 1:53:32.294 [main@6e2c634b] Index check time for Airing 11 msec Sat 3/18 1:53:32.295 [main@6e2c634b] Splash: Object Database is initializing... 50% done Sat 3/18 1:53:32.297 [main@6e2c634b] Wizard loading alt index 6 for Airing bytes=628850 Sat 3/18 1:53:32.319 [LucenePersonTransactionTask@18fd2fbb] 26.75% / 85989 work queue, 28146 inserted @ 0.05 ms/peep avg [tot:1302ms] Sat 3/18 1:53:32.326 [main@6e2c634b] Load time for alt index 6 for Airing 30 msec Sat 3/18 1:53:32.356 [main@6e2c634b] Index check time for alt index 6 for Airing 29 msec Sat 3/18 1:53:32.357 [main@6e2c634b] Wizard loading alt index 5 for Airing bytes=628850 Sat 3/18 1:53:32.365 [LucenePersonTransactionTask@18fd2fbb] 27.91% / 85989 work queue, 29146 inserted @ 0.05 ms/peep avg [tot:1341ms] Sat 3/18 1:53:32.367 [LuceneShowTransactionTask@10ad105d] 9.02% / 44323 work queue, 9850 inserted @ 0.12 ms/show avg [tot:1142ms] Sat 3/18 1:53:32.379 [main@6e2c634b] Load time for alt index 5 for Airing 22 msec Sat 3/18 1:53:32.384 [LucenePersonTransactionTask@18fd2fbb] 29.07% / 85989 work queue, 30146 inserted @ 0.05 ms/peep avg [tot:1358ms] Sat 3/18 1:53:32.394 [main@6e2c634b] Index check time for alt index 5 for Airing 12 msec Sat 3/18 1:53:32.395 [main@6e2c634b] Wizard allocating table for ManualRecord of size 2 Sat 3/18 1:53:32.395 [main@6e2c634b] Splash: Object Database is initializing... 60% done Sat 3/18 1:53:32.396 [main@6e2c634b] Wizard loading main index for ManualRecord bytes=122 Sat 3/18 1:53:32.400 [main@6e2c634b] Load time for ManualRecord 4 msec 2.0 msec/object Sat 3/18 1:53:32.401 [main@6e2c634b] Index check time for ManualRecord 0 msec Sat 3/18 1:53:32.402 [main@6e2c634b] Splash: Object Database is initializing... 60% done Sat 3/18 1:53:32.403 [main@6e2c634b] Wizard allocating table for MediaFile of size 53256 Sat 3/18 1:53:32.404 [main@6e2c634b] Splash: Object Database is initializing... 60% done Sat 3/18 1:53:32.404 [main@6e2c634b] Wizard loading main index for MediaFile bytes=22308961 Sat 3/18 1:53:32.407 [LucenePersonTransactionTask@18fd2fbb] 30.24% / 85989 work queue, 31146 inserted @ 0.04 ms/peep avg [tot:1377ms] Sat 3/18 1:53:32.430 [LucenePersonTransactionTask@18fd2fbb] 31.40% / 85989 work queue, 32146 inserted @ 0.04 ms/peep avg [tot:1398ms] Sat 3/18 1:53:32.461 [LucenePersonTransactionTask@18fd2fbb] 32.56% / 85989 work queue, 33146 inserted @ 0.04 ms/peep avg [tot:1426ms] Sat 3/18 1:53:32.483 [LucenePersonTransactionTask@18fd2fbb] 33.73% / 85989 work queue, 34146 inserted @ 0.04 ms/peep avg [tot:1447ms] Sat 3/18 1:53:32.500 [LucenePersonTransactionTask@18fd2fbb] 34.89% / 85989 work queue, 35146 inserted @ 0.04 ms/peep avg [tot:1461ms] Sat 3/18 1:53:32.513 [LucenePersonTransactionTask@18fd2fbb] 36.05% / 85989 work queue, 36146 inserted @ 0.04 ms/peep avg [tot:1472ms] Sat 3/18 1:53:32.543 [LucenePersonTransactionTask@18fd2fbb] 37.21% / 85989 work queue, 37146 inserted @ 0.04 ms/peep avg [tot:1499ms] Sat 3/18 1:53:32.558 [LucenePersonTransactionTask@18fd2fbb] 38.38% / 85989 work queue, 38146 inserted @ 0.04 ms/peep avg [tot:1513ms] Sat 3/18 1:53:32.577 [LucenePersonTransactionTask@18fd2fbb] 39.54% / 85989 work queue, 39146 inserted @ 0.04 ms/peep avg [tot:1530ms] Sat 3/18 1:53:32.591 [LucenePersonTransactionTask@18fd2fbb] 40.70% / 85989 work queue, 40146 inserted @ 0.04 ms/peep avg [tot:1541ms] Sat 3/18 1:53:32.701 [LucenePersonTransactionTask@18fd2fbb] 41.87% / 85989 work queue, 41146 inserted @ 0.04 ms/peep avg [tot:1649ms] Sat 3/18 1:53:32.729 [LucenePersonTransactionTask@18fd2fbb] 43.03% / 85989 work queue, 42146 inserted @ 0.04 ms/peep avg [tot:1667ms] Sat 3/18 1:53:32.740 [LucenePersonTransactionTask@18fd2fbb] 44.19% / 85989 work queue, 43146 inserted @ 0.04 ms/peep avg [tot:1675ms] Sat 3/18 1:53:32.755 [LucenePersonTransactionTask@18fd2fbb] 45.35% / 85989 work queue, 44146 inserted @ 0.04 ms/peep avg [tot:1688ms] Sat 3/18 1:53:32.770 [LucenePersonTransactionTask@18fd2fbb] 46.52% / 85989 work queue, 45146 inserted @ 0.04 ms/peep avg [tot:1700ms] Sat 3/18 1:53:32.782 [LucenePersonTransactionTask@18fd2fbb] 47.68% / 85989 work queue, 46146 inserted @ 0.04 ms/peep avg [tot:1710ms] Sat 3/18 1:53:32.806 [LucenePersonTransactionTask@18fd2fbb] 48.84% / 85989 work queue, 47146 inserted @ 0.04 ms/peep avg [tot:1731ms] Sat 3/18 1:53:32.821 [LucenePersonTransactionTask@18fd2fbb] 50.01% / 85989 work queue, 48146 inserted @ 0.04 ms/peep avg [tot:1745ms] Sat 3/18 1:53:32.834 [LucenePersonTransactionTask@18fd2fbb] 51.17% / 85989 work queue, 49146 inserted @ 0.04 ms/peep avg [tot:1756ms] Sat 3/18 1:53:32.848 [LucenePersonTransactionTask@18fd2fbb] 52.33% / 85989 work queue, 50146 inserted @ 0.04 ms/peep avg [tot:1764ms] Sat 3/18 1:53:32.863 [LucenePersonTransactionTask@18fd2fbb] 53.50% / 85989 work queue, 51146 inserted @ 0.03 ms/peep avg [tot:1778ms] Sat 3/18 1:53:32.885 [LucenePersonTransactionTask@18fd2fbb] 54.66% / 85989 work queue, 52146 inserted @ 0.03 ms/peep avg [tot:1796ms] Sat 3/18 1:53:32.902 [LucenePersonTransactionTask@18fd2fbb] 55.82% / 85989 work queue, 53146 inserted @ 0.03 ms/peep avg [tot:1811ms] Sat 3/18 1:53:32.918 [LucenePersonTransactionTask@18fd2fbb] 56.98% / 85989 work queue, 54146 inserted @ 0.03 ms/peep avg [tot:1824ms] Sat 3/18 1:53:32.932 [LucenePersonTransactionTask@18fd2fbb] 58.15% / 85989 work queue, 55146 inserted @ 0.03 ms/peep avg [tot:1835ms] Sat 3/18 1:53:32.944 [LucenePersonTransactionTask@18fd2fbb] 59.31% / 85989 work queue, 56146 inserted @ 0.03 ms/peep avg [tot:1844ms] Sat 3/18 1:53:32.962 [LucenePersonTransactionTask@18fd2fbb] 60.47% / 85989 work queue, 57146 inserted @ 0.03 ms/peep avg [tot:1860ms] Sat 3/18 1:53:32.975 [LucenePersonTransactionTask@18fd2fbb] 61.64% / 85989 work queue, 58146 inserted @ 0.03 ms/peep avg [tot:1873ms] Sat 3/18 1:53:33.002 [LucenePersonTransactionTask@18fd2fbb] 62.80% / 85989 work queue, 59146 inserted @ 0.03 ms/peep avg [tot:1897ms] Sat 3/18 1:53:33.015 [LucenePersonTransactionTask@18fd2fbb] 63.96% / 85989 work queue, 60146 inserted @ 0.03 ms/peep avg [tot:1909ms] Sat 3/18 1:53:33.031 [LucenePersonTransactionTask@18fd2fbb] 65.12% / 85989 work queue, 61146 inserted @ 0.03 ms/peep avg [tot:1921ms] Sat 3/18 1:53:33.047 [LucenePersonTransactionTask@18fd2fbb] 66.29% / 85989 work queue, 62146 inserted @ 0.03 ms/peep avg [tot:1936ms] Sat 3/18 1:53:33.061 [LucenePersonTransactionTask@18fd2fbb] 67.45% / 85989 work queue, 63146 inserted @ 0.03 ms/peep avg [tot:1948ms] Sat 3/18 1:53:33.082 [LucenePersonTransactionTask@18fd2fbb] 68.61% / 85989 work queue, 64146 inserted @ 0.03 ms/peep avg [tot:1968ms] Sat 3/18 1:53:33.093 [LucenePersonTransactionTask@18fd2fbb] 69.78% / 85989 work queue, 65146 inserted @ 0.03 ms/peep avg [tot:1978ms] Sat 3/18 1:53:33.572 [LuceneShowTransactionTask@10ad105d] 11.28% / 44323 work queue, 10850 inserted @ 0.22 ms/show avg [tot:2343ms] Sat 3/18 1:53:33.714 [LuceneShowTransactionTask@10ad105d] 13.54% / 44323 work queue, 11850 inserted @ 0.21 ms/show avg [tot:2480ms] Sat 3/18 1:53:33.956 [main@6e2c634b] Load time for MediaFile 1552 msec 0.029142257 msec/object Sat 3/18 1:53:33.962 [main@6e2c634b] Index check time for MediaFile 5 msec Sat 3/18 1:53:33.962 [main@6e2c634b] Splash: Object Database is initializing... 60% done Sat 3/18 1:53:33.963 [main@6e2c634b] Wizard loading alt index 10 for MediaFile bytes=213030 Sat 3/18 1:53:33.967 [main@6e2c634b] Load time for alt index 10 for MediaFile 4 msec Sat 3/18 1:53:33.977 [main@6e2c634b] Index check time for alt index 10 for MediaFile 9 msec Sat 3/18 1:53:33.978 [main@6e2c634b] Wizard loading alt index 12 for MediaFile bytes=213030 Sat 3/18 1:53:33.983 [main@6e2c634b] Load time for alt index 12 for MediaFile 5 msec Sat 3/18 1:53:34.019 [main@6e2c634b] Index check time for alt index 12 for MediaFile 35 msec Sat 3/18 1:53:34.020 [main@6e2c634b] Wizard allocating table for Watched of size 4725 Sat 3/18 1:53:34.021 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.022 [main@6e2c634b] Wizard loading main index for Watched bytes=283506 Sat 3/18 1:53:34.030 [main@6e2c634b] Load time for Watched 9 msec 0.0019047619 msec/object Sat 3/18 1:53:34.033 [main@6e2c634b] Index check time for Watched 2 msec Sat 3/18 1:53:34.034 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.035 [main@6e2c634b] Wizard loading alt index 7 for Watched bytes=18906 Sat 3/18 1:53:34.036 [main@6e2c634b] Load time for alt index 7 for Watched 1 msec Sat 3/18 1:53:34.038 [main@6e2c634b] Index check time for alt index 7 for Watched 2 msec Sat 3/18 1:53:34.039 [main@6e2c634b] Wizard allocating table for Agent of size 1172 Sat 3/18 1:53:34.039 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.040 [main@6e2c634b] Wizard loading main index for Agent bytes=115092 Sat 3/18 1:53:34.050 [main@6e2c634b] Load time for Agent 10 msec 0.0085324235 msec/object Sat 3/18 1:53:34.052 [main@6e2c634b] Index check time for Agent 0 msec Sat 3/18 1:53:34.053 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.055 [main@6e2c634b] Wizard loading alt index 11 for Agent bytes=4694 Sat 3/18 1:53:34.056 [main@6e2c634b] Load time for alt index 11 for Agent 0 msec Sat 3/18 1:53:34.057 [main@6e2c634b] Index check time for alt index 11 for Agent 1 msec Sat 3/18 1:53:34.058 [main@6e2c634b] Wizard allocating table for Wasted of size 1782 Sat 3/18 1:53:34.058 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.059 [main@6e2c634b] Wizard loading main index for Wasted bytes=23172 Sat 3/18 1:53:34.060 [main@6e2c634b] Load time for Wasted 1 msec 5.6116725E-4 msec/object Sat 3/18 1:53:34.061 [main@6e2c634b] Index check time for Wasted 1 msec Sat 3/18 1:53:34.061 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.062 [main@6e2c634b] Wizard allocating table for Playlist of size 5 Sat 3/18 1:53:34.062 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.063 [main@6e2c634b] Wizard loading main index for Playlist bytes=983 Sat 3/18 1:53:34.065 [main@6e2c634b] Load time for Playlist 2 msec 0.4 msec/object Sat 3/18 1:53:34.065 [main@6e2c634b] Index check time for Playlist 0 msec Sat 3/18 1:53:34.066 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.067 [main@6e2c634b] Wizard allocating table for TVEditorial of size 0 Sat 3/18 1:53:34.068 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.069 [main@6e2c634b] Wizard allocating table for SeriesInfo of size 5663 Sat 3/18 1:53:34.069 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.070 [main@6e2c634b] Wizard loading main index for SeriesInfo bytes=5611766 Sat 3/18 1:53:34.134 [main@6e2c634b] Load time for SeriesInfo 64 msec 0.01130143 msec/object Sat 3/18 1:53:34.135 [main@6e2c634b] Index check time for SeriesInfo 0 msec Sat 3/18 1:53:34.136 [main@6e2c634b] Splash: Object Database is initializing... 92% done Sat 3/18 1:53:34.137 [main@6e2c634b] Wizard loading alt index 13 for SeriesInfo bytes=22658 Sat 3/18 1:53:34.138 [main@6e2c634b] Load time for alt index 13 for SeriesInfo 1 msec Sat 3/18 1:53:34.142 [main@6e2c634b] Index check time for alt index 13 for SeriesInfo 3 msec Sat 3/18 1:53:34.142 [main@6e2c634b] Wizard loading alt index 15 for SeriesInfo bytes=22658 Sat 3/18 1:53:34.144 [main@6e2c634b] Load time for alt index 15 for SeriesInfo 2 msec Sat 3/18 1:53:34.147 [main@6e2c634b] Index check time for alt index 15 for SeriesInfo 2 msec Sat 3/18 1:53:34.147 [main@6e2c634b] Wizard allocating table for UserRecord of size 0 Sat 3/18 1:53:34.148 [main@6e2c634b] Splash: Object Database is initializing... 100% done Sat 3/18 1:53:34.150 [main@6e2c634b] Wizard performing validation on database objects... Sat 3/18 1:53:34.395 [main@6e2c634b] Wizard DONE loading database info. loadTime=3.886 sec Sat 3/18 1:53:34.409 [main@6e2c634b] Splash: Object Database is initializing... 100% done Sat 3/18 1:53:34.414 [main@6e2c634b] Splash: EPG is initializing... Sat 3/18 1:53:34.454 [main@6e2c634b] Increased hash set pool to size=1 Sat 3/18 1:53:34.500 [LucenePersonTransactionTask@18fd2fbb] 70.94% / 85989 work queue, 66146 inserted @ 0.05 ms/peep avg [tot:3385ms] Sat 3/18 1:53:34.529 [LucenePersonTransactionTask@18fd2fbb] 72.10% / 85989 work queue, 67146 inserted @ 0.05 ms/peep avg [tot:3412ms] Sat 3/18 1:53:34.530 [main@6e2c634b] Splash: Profiler is initializing... Sat 3/18 1:53:34.557 [main@6e2c634b] Loaded 282 messages from system message log file Sat 3/18 1:53:34.991 [main@6e2c634b] Splash: Acquisition System is initializing... Sat 3/18 1:53:34.995 [LucenePersonTransactionTask@18fd2fbb] 73.27% / 85989 work queue, 68146 inserted @ 0.06 ms/peep avg [tot:3876ms] Sat 3/18 1:53:35.029 [LucenePersonTransactionTask@18fd2fbb] 74.43% / 85989 work queue, 69146 inserted @ 0.06 ms/peep avg [tot:3906ms] Sat 3/18 1:53:35.047 [main@6e2c634b] MMC calling detectCaptureDevices on sage.NetworkEncoderManager@6eebc39e Sat 3/18 1:53:35.056 [LucenePersonTransactionTask@18fd2fbb] 75.59% / 85989 work queue, 70146 inserted @ 0.06 ms/peep avg [tot:3932ms] Sat 3/18 1:53:35.082 [LucenePersonTransactionTask@18fd2fbb] 76.75% / 85989 work queue, 71146 inserted @ 0.06 ms/peep avg [tot:3956ms] Sat 3/18 1:53:35.115 [LucenePersonTransactionTask@18fd2fbb] 77.92% / 85989 work queue, 72146 inserted @ 0.06 ms/peep avg [tot:3987ms] Sat 3/18 1:53:35.146 [LucenePersonTransactionTask@18fd2fbb] 79.08% / 85989 work queue, 73146 inserted @ 0.05 ms/peep avg [tot:4017ms] Sat 3/18 1:53:35.171 [LucenePersonTransactionTask@18fd2fbb] 80.24% / 85989 work queue, 74146 inserted @ 0.05 ms/peep avg [tot:4041ms] Sat 3/18 1:53:35.205 [LucenePersonTransactionTask@18fd2fbb] 81.41% / 85989 work queue, 75146 inserted @ 0.05 ms/peep avg [tot:4074ms] Sat 3/18 1:53:35.230 [LucenePersonTransactionTask@18fd2fbb] 82.57% / 85989 work queue, 76146 inserted @ 0.05 ms/peep avg [tot:4098ms] Sat 3/18 1:53:35.251 [LucenePersonTransactionTask@18fd2fbb] 83.73% / 85989 work queue, 77146 inserted @ 0.05 ms/peep avg [tot:4118ms] Sat 3/18 1:53:35.273 [LucenePersonTransactionTask@18fd2fbb] 84.89% / 85989 work queue, 78146 inserted @ 0.05 ms/peep avg [tot:4139ms] Sat 3/18 1:53:35.293 [LucenePersonTransactionTask@18fd2fbb] 86.06% / 85989 work queue, 79146 inserted @ 0.05 ms/peep avg [tot:4157ms] Sat 3/18 1:53:35.314 [LucenePersonTransactionTask@18fd2fbb] 87.22% / 85989 work queue, 80146 inserted @ 0.05 ms/peep avg [tot:4177ms] Sat 3/18 1:53:35.337 [LucenePersonTransactionTask@18fd2fbb] 88.38% / 85989 work queue, 81146 inserted @ 0.05 ms/peep avg [tot:4197ms] Sat 3/18 1:53:35.384 [LucenePersonTransactionTask@18fd2fbb] 89.55% / 85989 work queue, 82146 inserted @ 0.05 ms/peep avg [tot:4244ms] Sat 3/18 1:53:35.400 [LuceneShowTransactionTask@10ad105d] 15.79% / 44323 work queue, 12850 inserted @ 0.32 ms/show avg [tot:4165ms] Sat 3/18 1:53:35.403 [LucenePersonTransactionTask@18fd2fbb] 90.71% / 85989 work queue, 83146 inserted @ 0.05 ms/peep avg [tot:4261ms] Sat 3/18 1:53:35.420 [LucenePersonTransactionTask@18fd2fbb] 91.87% / 85989 work queue, 84146 inserted @ 0.05 ms/peep avg [tot:4278ms] Sat 3/18 1:53:35.435 [LucenePersonTransactionTask@18fd2fbb] 93.04% / 85989 work queue, 85146 inserted @ 0.05 ms/peep avg [tot:4292ms] Sat 3/18 1:53:35.443 [LucenePersonTransactionTask@18fd2fbb] 94.20% / 85989 work queue, 86146 inserted @ 0.05 ms/peep avg [tot:4298ms] Sat 3/18 1:53:35.451 [LucenePersonTransactionTask@18fd2fbb] 95.36% / 85989 work queue, 87146 inserted @ 0.05 ms/peep avg [tot:4306ms] Sat 3/18 1:53:35.458 [LucenePersonTransactionTask@18fd2fbb] 96.52% / 85989 work queue, 88146 inserted @ 0.05 ms/peep avg [tot:4313ms] Sat 3/18 1:53:35.465 [LucenePersonTransactionTask@18fd2fbb] 97.69% / 85989 work queue, 89146 inserted @ 0.05 ms/peep avg [tot:4319ms] Sat 3/18 1:53:35.472 [LucenePersonTransactionTask@18fd2fbb] 98.85% / 85989 work queue, 90146 inserted @ 0.05 ms/peep avg [tot:4325ms] Sat 3/18 1:53:35.481 [LucenePersonTransactionTask@18fd2fbb] Snapshot index person snap-count: 0 Sat 3/18 1:53:35.565 [LuceneShowTransactionTask@10ad105d] 18.05% / 44323 work queue, 13850 inserted @ 0.31 ms/show avg [tot:4327ms] Sat 3/18 1:53:35.628 [LuceneShowTransactionTask@10ad105d] 20.31% / 44323 work queue, 14850 inserted @ 0.30 ms/show avg [tot:4389ms] Sat 3/18 1:53:35.683 [LucenePersonTransactionTask@18fd2fbb] 100% work queue, 91134 insertions @ 0.05 ms/peep [tot:4333ms] Sat 3/18 1:53:35.827 [LuceneShowTransactionTask@10ad105d] 22.56% / 44323 work queue, 15850 inserted @ 0.29 ms/show avg [tot:4585ms] Sat 3/18 1:53:36.003 [LuceneShowTransactionTask@10ad105d] 24.82% / 44323 work queue, 16850 inserted @ 0.28 ms/show avg [tot:4761ms] Sat 3/18 1:53:36.039 [LuceneShowTransactionTask@10ad105d] 27.07% / 44323 work queue, 17850 inserted @ 0.27 ms/show avg [tot:4797ms] Sat 3/18 1:53:36.060 [LuceneShowTransactionTask@10ad105d] 29.33% / 44323 work queue, 18850 inserted @ 0.26 ms/show avg [tot:4816ms] Sat 3/18 1:53:36.087 [LuceneShowTransactionTask@10ad105d] 31.59% / 44323 work queue, 19850 inserted @ 0.24 ms/show avg [tot:4843ms] Sat 3/18 1:53:36.130 [LuceneShowTransactionTask@10ad105d] 33.84% / 44323 work queue, 20850 inserted @ 0.23 ms/show avg [tot:4885ms] Sat 3/18 1:53:36.171 [LuceneShowTransactionTask@10ad105d] 36.10% / 44323 work queue, 21850 inserted @ 0.23 ms/show avg [tot:4925ms] Sat 3/18 1:53:36.212 [LuceneShowTransactionTask@10ad105d] 38.35% / 44323 work queue, 22850 inserted @ 0.22 ms/show avg [tot:4966ms] Sat 3/18 1:53:36.376 [LuceneShowTransactionTask@10ad105d] 40.61% / 44323 work queue, 23850 inserted @ 0.22 ms/show avg [tot:5130ms] Sat 3/18 1:53:36.797 [LuceneShowTransactionTask@10ad105d] 42.87% / 44323 work queue, 24850 inserted @ 0.22 ms/show avg [tot:5550ms] Sat 3/18 1:53:36.958 [LuceneShowTransactionTask@10ad105d] 45.12% / 44323 work queue, 25850 inserted @ 0.22 ms/show avg [tot:5711ms] Sat 3/18 1:53:37.014 [LuceneShowTransactionTask@10ad105d] 47.38% / 44323 work queue, 26850 inserted @ 0.21 ms/show avg [tot:5765ms] Sat 3/18 1:53:37.041 [LuceneShowTransactionTask@10ad105d] 49.64% / 44323 work queue, 27850 inserted @ 0.21 ms/show avg [tot:5791ms] Sat 3/18 1:53:37.107 [LuceneShowTransactionTask@10ad105d] 51.89% / 44323 work queue, 28850 inserted @ 0.20 ms/show avg [tot:5855ms] Sat 3/18 1:53:37.141 [LuceneShowTransactionTask@10ad105d] 54.15% / 44323 work queue, 29850 inserted @ 0.20 ms/show avg [tot:5888ms] Sat 3/18 1:53:37.174 [LuceneShowTransactionTask@10ad105d] 56.40% / 44323 work queue, 30850 inserted @ 0.19 ms/show avg [tot:5920ms] Sat 3/18 1:53:37.212 [LuceneShowTransactionTask@10ad105d] 58.66% / 44323 work queue, 31850 inserted @ 0.19 ms/show avg [tot:5958ms] Sat 3/18 1:53:37.246 [LuceneShowTransactionTask@10ad105d] 60.92% / 44323 work queue, 32850 inserted @ 0.18 ms/show avg [tot:5992ms] Sat 3/18 1:53:37.282 [LuceneShowTransactionTask@10ad105d] 63.17% / 44323 work queue, 33850 inserted @ 0.18 ms/show avg [tot:6028ms] Sat 3/18 1:53:37.320 [LuceneShowTransactionTask@10ad105d] 65.43% / 44323 work queue, 34850 inserted @ 0.17 ms/show avg [tot:6065ms] Sat 3/18 1:53:37.358 [LuceneShowTransactionTask@10ad105d] 67.68% / 44323 work queue, 35850 inserted @ 0.17 ms/show avg [tot:6100ms] Sat 3/18 1:53:37.403 [LuceneShowTransactionTask@10ad105d] 69.94% / 44323 work queue, 36850 inserted @ 0.17 ms/show avg [tot:6144ms] Sat 3/18 1:53:37.449 [LuceneShowTransactionTask@10ad105d] 72.20% / 44323 work queue, 37850 inserted @ 0.16 ms/show avg [tot:6188ms] Sat 3/18 1:53:37.479 [LuceneShowTransactionTask@10ad105d] 74.45% / 44323 work queue, 38850 inserted @ 0.16 ms/show avg [tot:6217ms] Sat 3/18 1:53:37.512 [LuceneShowTransactionTask@10ad105d] 76.71% / 44323 work queue, 39850 inserted @ 0.16 ms/show avg [tot:6250ms] Sat 3/18 1:53:37.550 [LuceneShowTransactionTask@10ad105d] 78.97% / 44323 work queue, 40850 inserted @ 0.15 ms/show avg [tot:6288ms] Sat 3/18 1:53:37.612 [LuceneShowTransactionTask@10ad105d] 81.22% / 44323 work queue, 41850 inserted @ 0.15 ms/show avg [tot:6350ms] Sat 3/18 1:53:37.649 [LuceneShowTransactionTask@10ad105d] 83.48% / 44323 work queue, 42850 inserted @ 0.15 ms/show avg [tot:6386ms] Sat 3/18 1:53:37.681 [LuceneShowTransactionTask@10ad105d] 85.73% / 44323 work queue, 43850 inserted @ 0.15 ms/show avg [tot:6416ms] Sat 3/18 1:53:37.714 [LuceneShowTransactionTask@10ad105d] 87.99% / 44323 work queue, 44850 inserted @ 0.14 ms/show avg [tot:6448ms] Sat 3/18 1:53:37.752 [LuceneShowTransactionTask@10ad105d] 90.25% / 44323 work queue, 45850 inserted @ 0.14 ms/show avg [tot:6484ms] Sat 3/18 1:53:37.782 [LuceneShowTransactionTask@10ad105d] 92.50% / 44323 work queue, 46850 inserted @ 0.14 ms/show avg [tot:6514ms] Sat 3/18 1:53:37.812 [LuceneShowTransactionTask@10ad105d] 94.76% / 44323 work queue, 47850 inserted @ 0.14 ms/show avg [tot:6543ms] Sat 3/18 1:53:37.840 [LuceneShowTransactionTask@10ad105d] 97.02% / 44323 work queue, 48850 inserted @ 0.13 ms/show avg [tot:6571ms] Sat 3/18 1:53:37.872 [LuceneShowTransactionTask@10ad105d] 99.27% / 44323 work queue, 49850 inserted @ 0.13 ms/show avg [tot:6603ms] Sat 3/18 1:53:37.885 [LuceneShowTransactionTask@10ad105d] 100% work queue, 50173 insertions @ 0.13 ms/show [tot:6615ms] Sat 3/18 1:53:38.232 [LuceneShowTransactionTask@10ad105d] 3.17% / 31525 work queue, 51173 inserted @ 0.14 ms/show avg [tot:6961ms] Sat 3/18 1:53:38.262 [LuceneShowTransactionTask@10ad105d] 6.34% / 31525 work queue, 52173 inserted @ 0.13 ms/show avg [tot:6991ms] Sat 3/18 1:53:38.317 [LuceneShowTransactionTask@10ad105d] 9.52% / 31525 work queue, 53173 inserted @ 0.13 ms/show avg [tot:7043ms] Sat 3/18 1:53:38.358 [LuceneShowTransactionTask@10ad105d] 12.69% / 31525 work queue, 54173 inserted @ 0.13 ms/show avg [tot:7083ms] Sat 3/18 1:53:38.384 [LuceneShowTransactionTask@10ad105d] 15.86% / 31525 work queue, 55173 inserted @ 0.13 ms/show avg [tot:7109ms] Sat 3/18 1:53:38.464 [LuceneShowTransactionTask@10ad105d] 19.03% / 31525 work queue, 56173 inserted @ 0.13 ms/show avg [tot:7188ms] Sat 3/18 1:53:38.515 [LuceneShowTransactionTask@10ad105d] 22.20% / 31525 work queue, 57173 inserted @ 0.13 ms/show avg [tot:7238ms] Sat 3/18 1:53:38.566 [LuceneShowTransactionTask@10ad105d] 25.38% / 31525 work queue, 58173 inserted @ 0.13 ms/show avg [tot:7289ms] Sat 3/18 1:53:38.629 [LuceneShowTransactionTask@10ad105d] 28.55% / 31525 work queue, 59173 inserted @ 0.12 ms/show avg [tot:7352ms] Sat 3/18 1:53:38.714 [LuceneShowTransactionTask@10ad105d] 31.72% / 31525 work queue, 60173 inserted @ 0.12 ms/show avg [tot:7436ms] Sat 3/18 1:53:38.779 [LuceneShowTransactionTask@10ad105d] 34.89% / 31525 work queue, 61173 inserted @ 0.12 ms/show avg [tot:7500ms] Sat 3/18 1:53:38.834 [LuceneShowTransactionTask@10ad105d] 38.07% / 31525 work queue, 62173 inserted @ 0.12 ms/show avg [tot:7553ms] Sat 3/18 1:53:38.888 [LuceneShowTransactionTask@10ad105d] 41.24% / 31525 work queue, 63173 inserted @ 0.12 ms/show avg [tot:7606ms] Sat 3/18 1:53:38.943 [LuceneShowTransactionTask@10ad105d] 44.41% / 31525 work queue, 64173 inserted @ 0.12 ms/show avg [tot:7661ms] Sat 3/18 1:53:39.233 [LuceneShowTransactionTask@10ad105d] 47.58% / 31525 work queue, 65173 inserted @ 0.12 ms/show avg [tot:7950ms] Sat 3/18 1:53:39.278 [LuceneShowTransactionTask@10ad105d] 50.75% / 31525 work queue, 66173 inserted @ 0.12 ms/show avg [tot:7995ms] Sat 3/18 1:53:39.323 [LuceneShowTransactionTask@10ad105d] 53.93% / 31525 work queue, 67173 inserted @ 0.12 ms/show avg [tot:8040ms] Sat 3/18 1:53:39.374 [LuceneShowTransactionTask@10ad105d] 57.10% / 31525 work queue, 68173 inserted @ 0.12 ms/show avg [tot:8090ms] Sat 3/18 1:53:39.420 [LuceneShowTransactionTask@10ad105d] 60.27% / 31525 work queue, 69173 inserted @ 0.12 ms/show avg [tot:8136ms] Sat 3/18 1:53:39.463 [LuceneShowTransactionTask@10ad105d] 63.44% / 31525 work queue, 70173 inserted @ 0.12 ms/show avg [tot:8176ms] Sat 3/18 1:53:39.509 [LuceneShowTransactionTask@10ad105d] 66.61% / 31525 work queue, 71173 inserted @ 0.12 ms/show avg [tot:8220ms] Sat 3/18 1:53:39.556 [LuceneShowTransactionTask@10ad105d] 69.79% / 31525 work queue, 72173 inserted @ 0.11 ms/show avg [tot:8266ms] Sat 3/18 1:53:39.608 [LuceneShowTransactionTask@10ad105d] 72.96% / 31525 work queue, 73173 inserted @ 0.11 ms/show avg [tot:8317ms] Sat 3/18 1:53:39.655 [LuceneShowTransactionTask@10ad105d] 76.13% / 31525 work queue, 74173 inserted @ 0.11 ms/show avg [tot:8364ms] Sat 3/18 1:53:39.699 [LuceneShowTransactionTask@10ad105d] 79.30% / 31525 work queue, 75173 inserted @ 0.11 ms/show avg [tot:8408ms] Sat 3/18 1:53:39.746 [LuceneShowTransactionTask@10ad105d] 82.47% / 31525 work queue, 76173 inserted @ 0.11 ms/show avg [tot:8454ms] Sat 3/18 1:53:40.036 [LuceneShowTransactionTask@10ad105d] 85.65% / 31525 work queue, 77173 inserted @ 0.11 ms/show avg [tot:8744ms] Sat 3/18 1:53:40.080 [LuceneShowTransactionTask@10ad105d] 88.82% / 31525 work queue, 78173 inserted @ 0.11 ms/show avg [tot:8787ms] Sat 3/18 1:53:40.136 [LuceneShowTransactionTask@10ad105d] 91.99% / 31525 work queue, 79173 inserted @ 0.11 ms/show avg [tot:8841ms] Sat 3/18 1:53:40.184 [LuceneShowTransactionTask@10ad105d] 95.16% / 31525 work queue, 80173 inserted @ 0.11 ms/show avg [tot:8887ms] Sat 3/18 1:53:40.230 [LuceneShowTransactionTask@10ad105d] 98.33% / 31525 work queue, 81173 inserted @ 0.11 ms/show avg [tot:8931ms] Sat 3/18 1:53:40.252 [LuceneShowTransactionTask@10ad105d] Snapshot index show snap-count: 0 Sat 3/18 1:53:40.406 [LuceneShowTransactionTask@10ad105d] 100% work queue, 81697 insertions @ 0.11 ms/show [tot:8953ms] Sat 3/18 1:58:30.260 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 1:58:30.260 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) LuceneShowTransactionTask:2% Sat 3/18 2:03:30.261 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:03:30.262 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:08:30.263 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:08:30.263 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:13:30.264 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:13:30.265 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:18:30.266 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:18:30.267 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:23:30.268 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:23:30.268 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:28:30.269 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:28:30.270 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:33:30.271 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:33:30.272 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:38:30.272 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:38:30.273 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:43:30.273 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:43:30.274 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:48:30.275 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 LucenePersonTransactionTask:2 main:2 Sat 3/18 2:48:30.276 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:53:30.277 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:2 LucenePersonTransactionTask:2 Sat 3/18 2:53:30.278 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 2:58:30.279 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:2 LucenePersonTransactionTask:2 Sat 3/18 2:58:30.279 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:03:30.280 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:2 LucenePersonTransactionTask:2 Sat 3/18 3:03:30.281 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:08:30.282 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:2 LucenePersonTransactionTask:2 Sat 3/18 3:08:30.283 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:13:30.283 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:13:30.284 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:18:30.285 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:18:30.285 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:23:30.286 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:23:30.287 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:28:30.288 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:28:30.289 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:33:30.290 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:33:30.291 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:38:30.292 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:38:30.292 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:43:30.293 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:43:30.294 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:48:30.295 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:48:30.296 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:53:30.297 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:53:30.297 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 3:58:30.298 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 3:58:30.299 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:03:30.300 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:03:30.301 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:08:30.302 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:08:30.302 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:13:30.303 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:13:30.304 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:18:30.305 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:18:30.306 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:23:30.306 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:23:30.307 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:28:30.307 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:28:30.308 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:33:30.309 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:33:30.310 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:38:30.310 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:38:30.311 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:43:30.312 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:43:30.312 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:48:30.313 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:48:30.314 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:53:30.315 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:53:30.316 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 4:58:30.316 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 4:58:30.317 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:03:30.318 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:03:30.319 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:08:30.320 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:08:30.320 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:13:30.321 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:13:30.322 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:18:30.323 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:18:30.324 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:23:30.324 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:23:30.325 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:28:30.329 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:28:30.329 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:33:30.330 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:33:30.331 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:38:30.332 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:38:30.332 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:43:30.333 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:43:30.334 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:48:30.334 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:48:30.335 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:53:30.336 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:53:30.337 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 5:58:30.338 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 5:58:30.339 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:03:30.340 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:03:30.340 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:08:30.341 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:08:30.342 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:13:30.343 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:13:30.344 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:18:30.345 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:18:30.346 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:23:30.347 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:23:30.347 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:28:30.348 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:28:30.349 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:33:30.350 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:33:30.351 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:38:30.351 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:38:30.352 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:43:30.352 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:43:30.353 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:48:30.354 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:48:30.355 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:53:30.355 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:53:30.356 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 6:58:30.357 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 6:58:30.358 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:03:30.359 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:03:30.359 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:08:30.360 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:08:30.361 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:13:30.362 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:13:30.363 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:18:30.363 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:18:30.364 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:18:35.766 [main@6e2c634b] network encoder version:3.0 Sat 3/18 7:18:35.766 [main@6e2c634b] Parsed network encoder major version: 3 Sat 3/18 7:23:30.365 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:23:30.366 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:28:30.367 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:28:30.368 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:33:30.368 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:33:30.369 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:38:30.370 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:38:30.371 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:43:30.372 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:43:30.373 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:48:30.374 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:48:30.375 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:53:30.376 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:53:30.377 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 7:58:30.378 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 7:58:30.379 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 8:03:30.380 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 8:03:30.380 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 8:08:30.381 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 8:08:30.382 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 8:13:30.383 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 8:13:30.384 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 8:18:30.385 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:3 LucenePersonTransactionTask:2 Sat 3/18 8:18:30.385 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 8:23:30.386 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:4 LucenePersonTransactionTask:2 Sat 3/18 8:23:30.387 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 8:28:30.389 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:4 LucenePersonTransactionTask:2 Sat 3/18 8:28:30.389 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s) Sat 3/18 8:33:30.390 [ThreadMonitor@595b58c0] Top 10 Cumulative CPU(sec) LuceneShowTransactionTask:7 main:4 LucenePersonTransactionTask:2 Sat 3/18 8:33:30.391 [ThreadMonitor@595b58c0] Top 10 %CPU (last 300s)