Yet another "Stuck on splash" topic

For help and support with Universal Media Server
Forum rules
Please make sure you follow the Problem Reporting Guidelines before posting if you want a reply
Post Reply
cesedy
Posts: 10
Joined: Sat Apr 04, 2020 2:29 am

Yet another "Stuck on splash" topic

Post by cesedy »

Hi.

For a long time I have had problems with UMS stuck on splash screen.

A while back I re-installed Windows and for a month it was working like a charm. But after again - stuck on splash screen.

If you do not want to read, here is a video https://files.fm/u/w78f6f3y#/view/UMS.mkv;play
The preview is in bad quality, so, please, download the video for better quality.

When I checked debug.log file, I got this

Code: Select all

DEBUG 2020-04-03 17:41:43.517 [main] Reading log_level: "TRACE" (default: "DEBUG")
DEBUG 2020-04-03 17:41:43.519 [main] Default logfile folder set to: C:\ProgramData\UMS
WARN  2020-04-03 17:41:43.520 [main] Could not rename "C:\ProgramData\UMS\debug.log" to "C:\ProgramData\UMS\debug.log.prev"
DEBUG 2020-04-03 17:41:43.580 [main] LogBack started with configuration file: C:\Program Files (x86)\Universal Media Server\logback.xml
DEBUG 2020-04-03 17:41:43.588 [main] Starting services
DEBUG 2020-04-03 17:41:43.589 [main] Starting ProcessManager
DEBUG 2020-04-03 17:41:43.590 [Process Terminator] ProcessTerminator is starting
TRACE 2020-04-03 17:41:43.590 [Process Terminator] ProcessTerminator is waiting for new tickets
DEBUG 2020-04-03 17:41:43.591 [main] Starting SleepManager
DEBUG 2020-04-03 17:41:43.593 [main] Fri Apr 03 17:41:43 EEST 2020
DEBUG 2020-04-03 17:41:43.593 [main] Reading cred.path: "C:\ProgramData\UMS\UMS.cred" (default: "")
DEBUG 2020-04-03 17:41:43.668 [main] Writing PID: 6792
TRACE 2020-04-03 17:41:43.670 [System Information Logger] Starting gathering of system information
DEBUG 2020-04-03 17:41:43.748 [main] 
INFO  2020-04-03 17:41:43.748 [main] Starting Universal Media Server 9.3.1
INFO  2020-04-03 17:41:43.749 [main] Based on PS3 Media Server by shagrath, copyright 2008-2014
INFO  2020-04-03 17:41:43.749 [main] https://www.universalmediaserver.com
INFO  2020-04-03 17:41:43.749 [main] 
INFO  2020-04-03 17:41:43.749 [main] Build: f7d202435 (2020-03-22)
INFO  2020-04-03 17:41:43.749 [main] Java: Java HotSpot(TM) 64-Bit Server VM 1.8.0_241 (64-bit) by Oracle Corporation
INFO  2020-04-03 17:41:43.749 [main] OS: Windows 10 64-bit 10.0
INFO  2020-04-03 17:41:43.751 [main] Maximum JVM Memory: 1.1 GiB
INFO  2020-04-03 17:41:43.755 [main] Language: English (United States)
INFO  2020-04-03 17:41:43.755 [main] Encoding: UTF-8
INFO  2020-04-03 17:41:43.755 [main] 
INFO  2020-04-03 17:41:43.756 [main] Working directory: C:\Program Files (x86)\Universal Media Server
INFO  2020-04-03 17:41:43.761 [main] Temporary directory: C:\Users\cesedy\AppData\Local\Temp\UMS
INFO  2020-04-03 17:41:43.763 [main] Logging configuration file: C:\Program Files (x86)\Universal Media Server\logback.xml
INFO  2020-04-03 17:41:43.763 [main] Logfile: C:\ProgramData\UMS\debug.log
INFO  2020-04-03 17:41:43.763 [main] 
INFO  2020-04-03 17:41:43.763 [main] Profile directory: C:\ProgramData\UMS
INFO  2020-04-03 17:41:43.764 [main] Profile directory permissions: drwx
INFO  2020-04-03 17:41:43.764 [main] Profile configuration file: C:\ProgramData\UMS\UMS.conf
INFO  2020-04-03 17:41:43.765 [main] Profile configuration file permissions: -rwx
INFO  2020-04-03 17:41:43.766 [main] Profile name: DESKTOP-LJ9GI0P
INFO  2020-04-03 17:41:43.766 [main] 
DEBUG 2020-04-03 17:41:43.766 [main] Reading web_conf: "C:\ProgramData\UMS\WEB.conf" (previous: null, default: "C:\ProgramData\UMS\WEB.conf")
INFO  2020-04-03 17:41:43.766 [main] Web configuration file: C:\ProgramData\UMS\WEB.conf
INFO  2020-04-03 17:41:43.767 [main] Web configuration file permissions: -rwx
INFO  2020-04-03 17:41:43.767 [main] 
DEBUG 2020-04-03 17:41:43.774 [main] Using database URL: jdbc:h2:C:\ProgramData\UMS\database\medias
INFO  2020-04-03 17:41:43.774 [main] Using database located at: "C:\ProgramData\UMS\database"
DEBUG 2020-04-03 17:41:43.774 [main] Database logging is disabled
ERROR 2020-04-03 17:41:43.855 [main] Database connection error: Database may be already in use: null. Possible solutions: close all other connection(s); use the server mode [90020-199]
TRACE 2020-04-03 17:41:43.856 [main] 
org.h2.jdbc.JdbcSQLNonTransientConnectionException: Database may be already in use: null. Possible solutions: close all other connection(s); use the server mode [90020-199]
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:617)
	at org.h2.message.DbException.getJdbcSQLException(DbException.java:427)
	at org.h2.message.DbException.get(DbException.java:194)
	at org.h2.mvstore.db.MVTableEngine$Store.convertIllegalStateException(MVTableEngine.java:193)
	at org.h2.mvstore.db.MVTableEngine$Store.open(MVTableEngine.java:173)
	at org.h2.mvstore.db.MVTableEngine.init(MVTableEngine.java:95)
	at org.h2.engine.Database.getPageStore(Database.java:2739)
	at org.h2.engine.Database.open(Database.java:769)
	at org.h2.engine.Database.openDatabase(Database.java:319)
	at org.h2.engine.Database.<init>(Database.java:313)
	at org.h2.engine.Engine.openSession(Engine.java:69)
	at org.h2.engine.Engine.openSession(Engine.java:201)
	at org.h2.engine.Engine.createSessionAndValidate(Engine.java:178)
	at org.h2.engine.Engine.createSession(Engine.java:161)
	at org.h2.engine.Engine.createSession(Engine.java:31)
	at org.h2.engine.SessionRemote.connectEmbeddedOrServer(SessionRemote.java:336)
	at org.h2.jdbc.JdbcConnection.<init>(JdbcConnection.java:169)
	at org.h2.jdbc.JdbcConnection.<init>(JdbcConnection.java:148)
	at org.h2.Driver.connect(Driver.java:69)
	at org.h2.jdbcx.JdbcDataSource.getJdbcConnection(JdbcDataSource.java:189)
	at org.h2.jdbcx.JdbcDataSource.getXAConnection(JdbcDataSource.java:352)
	at org.h2.jdbcx.JdbcDataSource.getPooledConnection(JdbcDataSource.java:384)
	at org.h2.jdbcx.JdbcConnectionPool.getConnectionNow(JdbcConnectionPool.java:234)
	at org.h2.jdbcx.JdbcConnectionPool.getConnection(JdbcConnectionPool.java:199)
	at net.pms.dlna.DLNAMediaDatabase.getConnection(DLNAMediaDatabase.java:167)
	at net.pms.dlna.DLNAMediaDatabase.init(DLNAMediaDatabase.java:185)
	at net.pms.PMS.getDatabase(PMS.java:266)
	at net.pms.database.Tables.<clinit>(Tables.java:45)
	at net.pms.PMS.init(PMS.java:425)
	at net.pms.PMS.createInstance(PMS.java:908)
	at net.pms.PMS.main(PMS.java:1078)
Caused by: java.lang.IllegalStateException: The file is locked: nio:C:/ProgramData/UMS/database/medias.mv.db [1.4.199/7]
	at org.h2.mvstore.DataUtils.newIllegalStateException(DataUtils.java:883)
	at org.h2.mvstore.FileStore.open(FileStore.java:172)
	at org.h2.mvstore.MVStore.<init>(MVStore.java:390)
	at org.h2.mvstore.MVStore$Builder.open(MVStore.java:3343)
	at org.h2.mvstore.db.MVTableEngine$Store.open(MVTableEngine.java:162)
	... 26 common frames omitted
INFO  2020-04-03 17:41:44.209 [System Information Logger] System information:
  JVM: Java HotSpot(TM) 64-Bit Server VM 1.8.0_241 (64-bit) by Oracle Corporation
  OS: Microsoft Windows 10 build 18363 64-bit
  CPU: AMD Ryzen 5 1600X Six-Core Processor            with 6 cores (12 virtual cores)
  Physical Memory: 16.0 GiB
  Free Memory: 11.2 GiB
  Maximum JVM Memory: 1.1 GiB

TRACE 2020-04-03 17:41:44.209 [System Information Logger] Done logging system information, shutting down thread
By this line

Code: Select all

Caused by: java.lang.IllegalStateException: The file is locked: nio:C:/ProgramData/UMS/database/medias.mv.db
I understood that file medias.mv.db is locked.
The I downloaded application LockHunter to see what is using the file and got this:

Code: Select all

java.exe
  Process ID: 6048
  Command Line: "C:\Program Files (x86)\Common Files\Oracle\Java\javapath\java.exe" -Djava.encoding=UTF-8 -Djava.net.preferIPv4Stack=true -Dstart.service=true -Xmx1024m -Djava.library.path="win32/service/" -classpath "win32/service/wrapper.jar;ums.jar" -Dwrapper.key="0OAAI_OiFocH8x0m" -Dwrapper.port=32000 -Dwrapper.jvm.port.min=31000 -Dwrapper.jvm.port.max=31999 -Dwrapper.pid=4180 -Dwrapper.version="3.5.17" -Dwrapper.native_library="wrapper" -Dwrapper.arch="x86" -Dwrapper.service="TRUE" -Dwrapper.cpu.timeout="10" -Dwrapper.jvmid=1 org.tanukisoftware.wrapper.WrapperSimpleApp net.pms.PMS
  
After I "Unlock" the medias.mv.db file and start UMS, the file gets used with JAVA what comes bundled with UMS:

Code: Select all

javaw.exe
  Process ID: 10616
  Command Line: "jre-x64\bin\javaw.exe" -classpath update.jar;ums.jar -Xmx1280M -Djava.net.preferIPv4Stack=true -Dfile.encoding=UTF-8 net.pms.PMS 
I have disabled option "Start with Windows", but anyway, every time I switch on the computer, the file medias.mv.db gets used by java.exe process once it starts.


So, what can I do to prevent java.exe from accessing the medias.mv.db file once it starts?

Thank you.
Post Reply