Sagetv 9 upgrade - Service halts

[skyeclad]

Ok, I installed Sagetv 9 over Sagetv 7 and after receiving Java matrix errors, I ran a repair install which seemed to fix those. Then I started the service again and it seems to stop after a second of operation. I'm thinking that it has something to do with the old Wiz.bin file but that's just a guess. I am seeing some Lucene errors in my log file but I'm at a loss as to what to try next.

[jusjoken]

Check the jars folder to see if there is an old lucene jar...if so delete it while sage is NOT running and try again.

k

[egeller]

It looks like you have two versions of lucene installed.

Look at line 3. The error is, most likely, the result of JARs\lucene-core-3.0.1.jar being ahead of lucene-core-3.6.0 in the classpath. Therefore it grabs 3.0.1 first. I am thinking that removing 3.0.1 altogether will fix the issue.

Try removing the jars\lucene-core-3.0.1.jar (earlier version) and see if that makes a difference.

My upgrade to V9 was manual. For some reason I think I remember instructions to remove the earlier lucene when JARs\lucene-core-3.6.0.jar was installed.

[skyeclad]

Thanks guys, that seemed to be the issue. It's going through the first run now...I can't recall though if it deleted my wiz.bin copy over. It seemed to have changed the wiz.bin name to corrupt and is making a new one?

[skyeclad]

Oh boy. I'm having new issues with this upgrade.

1) My media import and sagetv recording directories aren't seen at all. In fact, inside the Sage client, I can't even search my PC to find them at all. The media center import directory is defaulting to My Computer with only 1 folder option called Network. Selecting that folder results in a selection called smb:///// with an error Invalid Directory. Near as I can tell, all of my PC directories aren't seen.

2) I'm missing the TV Menu Item altogether. My menu list starts at Videos but since I have no import directories, it's empty and the free space menu bar is 0.0GB free.

3) My extender acts like it's in better shape, with both the TV menu item showing and with Media Center Import directories appearing to be set. However, when I select TV or Videos, I get an infinite spinning circle.

I've attached my SageTV Server logs. My Sagetv_client file is too large to attach but I'm getting a ton of these errors:

Sat 1/14 21:30:57.228 [AWT-EventQueue-0@5cb672] Error with c/s comm: requestAction: java.lang.NullPointerException
Sat 1/14 21:30:57.230 [AWT-EventQueue-0@5cb672] java.lang.NullPointerException
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.SageTVConnection.requestAction(SageTVConnection.java:2139)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.PredefinedJEPFunction.run(PredefinedJEPFunction.java:100)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.jep.JEP$CommandEvaluator.evaluate(JEP.java:558)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.jep.JEP.getValueAsObject(JEP.java:428)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.Catbert.evaluateExpression(Catbert.java:641)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.processChain(ZPseudoComp.java:4703)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.processParentActions(ZPseudoComp.java:5212)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluate(ZPseudoComp.java:5090)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluateTree(ZPseudoComp.java:1154)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluate(ZPseudoComp.java:5127)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluateTree(ZPseudoComp.java:1154)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluate(ZPseudoComp.java:5127)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluateTree(ZPseudoComp.java:1154)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluate(ZPseudoComp.java:5127)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluateTree(ZPseudoComp.java:1154)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluate(ZPseudoComp.java:5127)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluateTree(ZPseudoComp.java:1154)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluate(ZPseudoComp.java:5127)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.evaluateTree(ZPseudoComp.java:1154)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.PseudoMenu.activate(PseudoMenu.java:99)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.UIManager.setUI(UIManager.java:1932)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.UIManager.advanceUI(UIManager.java:1558)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.UIManager.advanceUI(UIManager.java:1568)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.processChain(ZPseudoComp.java:4854)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.processChain(ZPseudoComp.java:4579)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.actionPerformed(ZPseudoComp.java:4562)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.action(ZPseudoComp.java:3800)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.PseudoMenu.action(PseudoMenu.java:225)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.EventRouter.processUserEvent(EventRouter.java:882)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.EventRouter.submitUserEvent(EventRouter.java:974)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.UIManager.doUserEvent2(UIManager.java:2140)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.api.Global$34.runSafely(Global.java:565)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.PredefinedJEPFunction.run(PredefinedJEPFunction.java:110)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.jep.JEP$CommandEvaluator.evaluate(JEP.java:586)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.jep.JEP.getValueAsObject(JEP.java:428)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.Catbert.evaluateExpression(Catbert.java:641)
Sat 1/14 21:30:57.231 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.processChain(ZPseudoComp.java:4641)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.processChain(ZPseudoComp.java:4579)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZPseudoComp.mouseReleased(ZPseudoComp.java:3133)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZComp.processMouseEvent(ZComp.java:726)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZRoot.analyzeMouseEvent(ZRoot.java:1605)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZRoot.analyzeMouseEvent(ZRoot.java:1576)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZRoot.analyzeMouseEvent(ZRoot.java:1576)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZRoot.analyzeMouseEvent(ZRoot.java:1576)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZRoot.analyzeMouseEvent(ZRoot.java:1576)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZRoot.analyzeMouseEvent(ZRoot.java:1532)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at sage.ZRoot.mouseReleased(ZRoot.java:1461)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.AWTEventMulticaster.mouseReleased(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.Component.processMouseEvent(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.Component.processEvent(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.Component.dispatchEventImpl(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.Component.dispatchEvent(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventQueue.dispatchEventImpl(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventQueue.access$500(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventQueue$3.run(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventQueue$3.run(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.security.AccessController.doPrivileged(Native Method)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.security.ProtectionDomain$JavaSecurityAccessImpl.doIntersectionPrivilege(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.security.ProtectionDomain$JavaSecurityAccessImpl.doIntersectionPrivilege(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventQueue$4.run(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventQueue$4.run(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.security.AccessController.doPrivileged(Native Method)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.security.ProtectionDomain$JavaSecurityAccessImpl.doIntersectionPrivilege(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventQueue.dispatchEvent(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventDispatchThread.pumpOneEventForFilters(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventDispatchThread.pumpEventsForFilter(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventDispatchThread.pumpEventsForHierarchy(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventDispatchThread.pumpEvents(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventDispatchThread.pumpEvents(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] at java.awt.EventDispatchThread.run(Unknown Source)
Sat 1/14 21:30:57.232 [AWT-EventQueue-0@5cb672] Error with c/s comm: requestAction: java.lang.NullPointerException

[tmiranda]

Originally Posted by skyeclad

Thanks guys, that seemed to be the issue. It's going through the first run now...I can't recall though if it deleted my wiz.bin copy over. It seemed to have changed the wiz.bin name to corrupt and is making a new one?

The issues you are seeing are all a cascade from having two lucene jars, been there

I had to roll back my system to before the upgrade then do the upgrade again making sure only the newest lucene was there.

[Narflex]

SageTV should also have created backups of your Wiz.bin and Sage.properties when you did the upgrade, so if you just revert back to those after fixing the Lucene problem you should be all good.

[Fuzzy]

The inability to access the network shares, however, is likely due to the sagetv service being logged in as LocalSystem. This needs to be changed to run as an actual user (it has been reported a few times I think that the service settings get reset on upgrades).

[skyeclad]

Thank you for the advice. I had to go out of town for a while so I reloaded my old backup. Now that I'm back, I'm going to reinstall the application, delete the extra lucene and make sure the service is logged in correctly. Hopefully things go smoother this time. Appreciate it.

[thomaszoo]

I was also having this problem. Deleting the old lucene jar did the trick. A big thank you to those in this thread and those who developed version 9.

[Fuzzy]

Just FYI, the current builds do not require you to delete the lucene jar file, as it will only use the newest version it finds now.