Sat 1/14 13:32:09.217 [main@1f4acd0] EMBEDDED=false Sat 1/14 13:32:10.124 [main@1f4acd0] user.dir2=C:\Sagetv\SageTV Sat 1/14 13:32:10.126 [main@1f4acd0] classpath=C:\Sagetv\SageTV\Sage.jar;C:\Sagetv\SageTV\xerces.jar;C:\Sagetv\SageTV\plugin.jar;C:\Sagetv\SageTV\;;JARs\activation.jar;JARs\activemq-all-5.3.1.jar;JARs\ant-1.6.5.jar;JARs\ant.jar;JARs\api-common-1.0.jar;JARs\cling-core-2.0.jar;JARs\cling-support-2.0.jar;JARs\cncb.SagePandora.jar;JARs\commons-codec-1.3.jar;JARs\commons-dbutils-1.3.jar;JARs\commons-httpclient-3.0.jar;JARs\commons-io-1.4.jar;JARs\commons-io-2.4.jar;JARs\commons-jxpath-1.1.jar;JARs\commons-lang-2.4.jar;JARs\commons-lang3-3.0.jar;JARs\commons-logging-1.0.4.jar;JARs\commons-net-1.4.1.jar;JARs\commons-vfs-20070823.jar;JARs\concurrent-1.3.2.jar;JARs\core-3.1.1.jar;JARs\df_importer.jar;JARs\df_sageutils.jar;JARs\dom4j-1.6.1.jar;JARs\EPPlayOn.jar;JARs\flux.jar;JARs\gkusnick.sagetv.jar;JARs\GoogleWeather.jar;JARs\groovy-all-2.0.5.jar;JARs\gson-1.7.1.jar;JARs\gtools.jar;JARs\h2-1.2.145.jar;JARs\htmlparser-1.6.jar;JARs\imageutils.jar;JARs\jackson-annotations-2.1.4.jar;JARs\jackson-core-2.1.4.jar;JARs\jackson-databind-2.1.4.jar;JARs\jcifs-1.1.6.jar;JARs\jcs-1.3.jar;JARs\jetty-6.1.19.jar;JARs\jetty-ajp-6.1.19.jar;JARs\jetty-rewrite-handler-6.1.19.jar;JARs\jetty-sslengine-6.1.19.jar;JARs\jetty-starter.jar;JARs\jetty-util-6.1.19.jar;JARs\json-20140107.jar;JARs\jsoup.jar;JARs\jsp-2.1-jetty-6.1.19.jar;JARs\jsp-2.1.jar;JARs\jsp-api-2.1.jar;JARs\log4j-1.2.15.jar;JARs\lucene-core-3.0.1.jar;JARs\lucene-core-3.6.0.jar;JARs\mail.jar;JARs\mailcheck.jar;JARs\metadata-updater.jar;JARs\miglayout-3.6.3-swing.jar;JARs\netflix.jar;JARs\nielm_getrssnews.jar;JARs\nielm_sageimdb.jar;JARs\nielm_sagemenureader.jar;JARs\nielm_sageutls.jar;JARs\nielm_sagewebserver.jar;JARs\nielm_sagexmlinfo.jar;JARs\ortus-mq.jar;JARs\phoenix.jar;JARs\PlayOnUtils.jar;JARs\PodcastRecorder.jar;JARs\razr-tools.jar;JARs\rsslib4j-0.2.jar;JARs\SageDiamond.jar;JARs\sagemc.jar;JARs\sageortus.jar;JARs\sagex-api.jar;JARs\sagex-h2.jar;JARs\salicense.jar;JARs\sbbi-upnplib-1.0.3.jar;JARs\seamless-http-1.0.jar;JARs\seamless-util-1.0.jar;JARs\seamless-xml-1.0.jar;JARs\servlet-api-2.5-6.1.19.jar;JARs\servlet.jar;JARs\slf4j-api-1.6.0.jar;JARs\themoviedb-3.0.1.jar;JARs\tmiranda.utils.jar;JARs\vecmath.jar Sat 1/14 13:32:10.130 [main@1f4acd0] JVM version=1.8.0_101 Sat 1/14 13:32:10.134 [main@1f4acd0] OS=Windows 10 10.0 Sat 1/14 13:32:10.137 [main@1f4acd0] client=false Sat 1/14 13:32:10.140 [main@1f4acd0] locale=en_US Sat 1/14 13:32:10.145 [ThreadMonitor@ec9d50] Thread CPU monitoring started interval=300000 Sat 1/14 13:32:10.149 [main@1f4acd0] Backing up properties file for SageTV upgrade... Sat 1/14 13:32:10.157 [main@1f4acd0] SageTV V9.0.12.506 Sat 1/14 13:32:10.176 [main@1f4acd0] hostname=DamatoHTPC Sat 1/14 13:32:10.180 [main@1f4acd0] Splash: User Interface Manager is initializing... Sat 1/14 13:32:10.273 [main@1f4acd0] Splash: Object Database is initializing... Sat 1/14 13:32:10.327 [main@1f4acd0] dbFile=C:\SageTV\SageTV\Wiz.bin(107420212) dbBackupFile=C:\SageTV\SageTV\Wiz.bak(0) Sat 1/14 13:32:10.330 [main@1f4acd0] Backing up DB file for upgrade... Sat 1/14 13:32:10.855 [main@1f4acd0] Wizard starting to load database info... Sat 1/14 13:32:10.858 [main@1f4acd0] Splash: Object Database Source is initializing... Sat 1/14 13:32:10.864 [main@1f4acd0] Reading DB file:C:\SageTV\SageTV\Wiz.bin with version 75 Sat 1/14 13:32:10.867 [main@1f4acd0] DBFile at version 75 FileSize=107420212 Sat 1/14 13:32:10.870 [main@1f4acd0] Wizard allocating table for Year of size 116 Sat 1/14 13:32:10.874 [main@1f4acd0] Splash: Object Database is initializing... 0% done Sat 1/14 13:32:10.878 [main@1f4acd0] Wizard loading main index for Year bytes=1292 Sat 1/14 13:32:10.883 [main@1f4acd0] Load time for Year 5 msec 0.04310345 msec/object Sat 1/14 13:32:10.886 [main@1f4acd0] Index check time for Year 0 msec Sat 1/14 13:32:10.890 [main@1f4acd0] Splash: Object Database is initializing... 0% done Sat 1/14 13:32:10.893 [main@1f4acd0] Wizard allocating table for Network of size 969 Sat 1/14 13:32:10.897 [main@1f4acd0] Splash: Object Database is initializing... 0% done Sat 1/14 13:32:10.900 [main@1f4acd0] Wizard loading main index for Network bytes=12283 Sat 1/14 13:32:10.906 [main@1f4acd0] Load time for Network 6 msec 0.0061919503 msec/object Sat 1/14 13:32:10.910 [main@1f4acd0] Index check time for Network 1 msec Sat 1/14 13:32:10.913 [main@1f4acd0] Splash: Object Database is initializing... 0% done Sat 1/14 13:32:10.916 [main@1f4acd0] Wizard allocating table for Title of size 77030 Sat 1/14 13:32:10.922 [main@1f4acd0] Splash: Object Database is initializing... 0% done Sat 1/14 13:32:10.925 [main@1f4acd0] Wizard loading main index for Title bytes=2092308 Sat 1/14 13:32:10.956 [main@1f4acd0] Load time for Title 31 msec 4.024406E-4 msec/object Sat 1/14 13:32:10.961 [main@1f4acd0] Index check time for Title 1 msec Sat 1/14 13:32:10.964 [main@1f4acd0] Wizard building alt. index 0 for Title Sat 1/14 13:32:10.985 [main@1f4acd0] Alt. index 0 for Title load time 21 msec Sat 1/14 13:32:10.988 [main@1f4acd0] Splash: Object Database is initializing... 0% done Sat 1/14 13:32:10.991 [main@1f4acd0] Wizard allocating table for Channel of size 926 Sat 1/14 13:32:10.994 [main@1f4acd0] Splash: Object Database is initializing... 2% done Sat 1/14 13:32:10.998 [main@1f4acd0] Wizard loading main index for Channel bytes=39775 Sat 1/14 13:32:11.002 [main@1f4acd0] Load time for Channel 4 msec 0.0043196543 msec/object Sat 1/14 13:32:11.004 [main@1f4acd0] Index check time for Channel 0 msec Sat 1/14 13:32:11.007 [main@1f4acd0] Splash: Object Database is initializing... 2% done Sat 1/14 13:32:11.010 [main@1f4acd0] Wizard allocating table for People of size 109765 Sat 1/14 13:32:11.036 [main@1f4acd0] Splash: Object Database is initializing... 2% done Sat 1/14 13:32:11.040 [main@1f4acd0] Wizard loading main index for People bytes=2563471 Sat 1/14 13:32:11.050 [main@1f4acd0] java.lang.NoSuchFieldError: LUCENE_36 Sat 1/14 13:32:11.051 [main@1f4acd0] sage.Wizard$LuceneIndex.(Wizard.java:9069) Sat 1/14 13:32:11.054 [main@1f4acd0] sage.Wizard.getPersonIndex(Wizard.java:9745) Sat 1/14 13:32:11.056 [main@1f4acd0] sage.Wizard.processXctFromStream(Wizard.java:7242) Sat 1/14 13:32:11.059 [main@1f4acd0] sage.Wizard.loadDBFile(Wizard.java:7536) Sat 1/14 13:32:11.062 [main@1f4acd0] sage.Wizard.startSeq(Wizard.java:2557) Sat 1/14 13:32:11.065 [main@1f4acd0] sage.Wizard.init(Wizard.java:670) Sat 1/14 13:32:11.068 [main@1f4acd0] sage.Wizard.prime(Wizard.java:473) Sat 1/14 13:32:11.070 [main@1f4acd0] sage.SageTV.(SageTV.java:404) Sat 1/14 13:32:11.073 [main@1f4acd0] sage.Sage.startup(Sage.java:1225) Sat 1/14 13:32:11.080 [main@1f4acd0] sage.Sage.b(Sage.java:990) Sat 1/14 13:32:11.090 [main@1f4acd0] thrown java.lang.NoSuchFieldError: LUCENE_36 Sat 1/14 13:32:11.096 [main@1f4acd0] java.lang.NoSuchFieldError: LUCENE_36 Sat 1/14 13:32:11.096 [main@1f4acd0] at sage.Wizard$LuceneIndex.(Wizard.java:9069) Sat 1/14 13:32:11.096 [main@1f4acd0] at sage.Wizard.getPersonIndex(Wizard.java:9745) Sat 1/14 13:32:11.096 [main@1f4acd0] at sage.Wizard.processXctFromStream(Wizard.java:7242) Sat 1/14 13:32:11.096 [main@1f4acd0] at sage.Wizard.loadDBFile(Wizard.java:7536) Sat 1/14 13:32:11.096 [main@1f4acd0] at sage.Wizard.startSeq(Wizard.java:2557) Sat 1/14 13:32:11.097 [main@1f4acd0] at sage.Wizard.init(Wizard.java:670) Sat 1/14 13:32:11.097 [main@1f4acd0] at sage.Wizard.prime(Wizard.java:473) Sat 1/14 13:32:11.097 [main@1f4acd0] at sage.SageTV.(SageTV.java:404) Sat 1/14 13:32:11.097 [main@1f4acd0] at sage.Sage.startup(Sage.java:1225) Sat 1/14 13:32:11.098 [main@1f4acd0] at sage.Sage.b(Sage.java:990) Sat 1/14 13:32:11.098 [main@1f4acd0] Error with DB file:java.lang.NoSuchFieldError: LUCENE_36, attempting to restore backup. Sat 1/14 13:32:11.106 [main@1f4acd0] Error restoring backup of:java.io.FileNotFoundException: C:\SageTV\SageTV\Wiz.bak (The system cannot find the file specified) Sat 1/14 13:32:11.112 [main@1f4acd0] Backing up DB file for upgrade... Sat 1/14 13:32:11.133 [main@1f4acd0] Wizard starting to load database info... Sat 1/14 13:32:11.139 [main@1f4acd0] Splash: Object Database Source is initializing... Sat 1/14 13:32:11.143 [main@1f4acd0] Wizard DONE loading database info. loadTime=0.01 sec Sat 1/14 13:32:11.148 [main@1f4acd0] Splash: Object Database Backup is initializing... Sat 1/14 13:32:11.151 [main@1f4acd0] Wizard backing up database file... Sat 1/14 13:32:11.155 [main@1f4acd0] thrown java.lang.NoSuchFieldError: LUCENE_36 Sat 1/14 13:32:11.158 [main@1f4acd0] java.lang.NoSuchFieldError: LUCENE_36 Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.Wizard$LuceneIndex.(Wizard.java:9069) Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.Wizard.getShowIndex(Wizard.java:9726) Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.Wizard.saveDBFile(Wizard.java:7790) Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.Wizard.startSeq(Wizard.java:2602) Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.Wizard.startSeq(Wizard.java:2640) Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.Wizard.init(Wizard.java:670) Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.Wizard.prime(Wizard.java:473) Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.SageTV.(SageTV.java:404) Sat 1/14 13:32:11.158 [main@1f4acd0] at sage.Sage.startup(Sage.java:1225) Sat 1/14 13:32:11.159 [main@1f4acd0] at sage.Sage.b(Sage.java:990) Sat 1/14 13:32:11.159 [main@1f4acd0] Error accessing file system:java.lang.NoSuchFieldError: LUCENE_36