Database errors

[Overcast451]

I just updated to 9.8.1 (Build 2020-09-05) - and it was working just fine for a couple of days - but now I'm getting a ton of database errors.
Not sure what happened - I managed to fix this by just deleting the database files in C:\ProgramData\UMS\database and resetting the configuration options.

But thought I would mention it - in case anyone runs into it. First time I've had any issues with UMS really.

I was going to ask about it when I initially started this thread, but before I posted I thought.. hmm.. maybe it'll work if I delete the DB.

[SubJunk]

It would be great to know what those errors are/were. Please let us know if it happens again

[Overcast451]

It did actually - just happened to me again last night. Was able to quickly get UMS up and running by just deleting the database files.
The debug log claimed that database logging is off. I didn't see any option in ums.conf to enable it.

I do see a number of errors in the debug.log - but far as I can tell, they are all related to ffmpg:

Code: Select all

DEBUG 2020-09-25 11:19:31.451 [ffmpeg64.exe-21-2] Error while decoding stream #0:0: Invalid data found when processing input
DEBUG 2020-09-25 11:19:31.451 [ffmpeg64.exe-21-2] [mpeg4 @ 000002634fa5db00] Context scratch buffers could not be allocated due to unknown size.

I wouldn't think those matter any - the last version of UMS I was running was pretty much flawless with this same media library. I think it ran for months without a restart, aside from maybe system restarts for Windows patches.

If you can let me know how to turn the logging on, I could do that.
I do get errors in the GUI for UMS, but I had to shut that down and then delete the DB files. Next time I can capture that output - well, assuming it happens again.

Usually - I run UMS as a Windows service, but if I run into issues - I'll stop the service and launch the GUI to see better what's happening. Also - even with the DB errors, the service will start, but I can't seem to get to it with any normal renderer - like a Roku or the SonyDVD player I use often. But if I recall.. the HTML pages worked fine. I'll make sure to gather a bit more data, etc if it happens again.

I also manually renamed the 'debug.log' (Current one is almost 500MB - I've been using UMS for quite sometime now) - I'm not sure why I got that warning about it being unable to rename the file. I checked the file system permissions and I have even 'users' set to allow modifications to that directory, so it shouldn't be an issue in terms of permissions at least. I did notice.. when I shut down the GUI, the JDKFramwork process didn't want to terminate. I had to kill the task after about 5 minutes for it to allow me to rename the log, since it had a lock on the file, I assume.

One last note - I've upgraded across a number of versions of UMS, don't think I've done a 'clean install' ever for it.

It's the least I can do - UMS is a great product. Thanks much for this app

Code: Select all

11:17:24 INFO  The Windows service is installed.
11:17:24 WARN  Could not rename "C:\ProgramData\UMS\debug.log" to "C:\ProgramData\UMS\debug.log.prev"
11:17:42 INFO  Starting Universal Media Server 9.8.1
11:17:42 INFO  Based on PS3 Media Server by shagrath, copyright 2008-2014
11:17:42 INFO  https://www.universalmediaserver.com
11:17:42 INFO  
11:17:42 INFO  Build: dc2b6720c (2020-09-05)
11:17:42 INFO  Java: OpenJDK 64-Bit Server VM 14.0.2 (64-bit) by AdoptOpenJDK
11:17:42 INFO  OS: Windows 10 64-bit 10.0
11:17:42 INFO  Maximum JVM Memory: 1.3 GiB
11:17:42 INFO  Language: English (United States)
11:17:42 INFO  Encoding: UTF-8

***

DEBUG 2020-09-25 11:17:42.875 [main] 
INFO  2020-09-25 11:17:42.875 [main] Starting Universal Media Server 9.8.1
INFO  2020-09-25 11:17:42.875 [main] Based on PS3 Media Server by shagrath, copyright 2008-2014
INFO  2020-09-25 11:17:42.875 [main] https://www.universalmediaserver.com
INFO  2020-09-25 11:17:42.875 [main] 
INFO  2020-09-25 11:17:42.875 [main] Build: dc2b6720c (2020-09-05)
INFO  2020-09-25 11:17:42.875 [main] Java: OpenJDK 64-Bit Server VM 14.0.2 (64-bit) by AdoptOpenJDK
INFO  2020-09-25 11:17:42.876 [main] OS: Windows 10 64-bit 10.0
INFO  2020-09-25 11:17:42.883 [main] Maximum JVM Memory: 1.3 GiB
INFO  2020-09-25 11:17:42.896 [main] Language: English (United States)
INFO  2020-09-25 11:17:42.896 [main] Encoding: UTF-8
INFO  2020-09-25 11:17:42.896 [main] 
INFO  2020-09-25 11:17:42.896 [main] Working directory: C:\Program Files (x86)\Universal Media Server
INFO  2020-09-25 11:17:42.903 [main] Temporary directory: C:\Users\Overcast\AppData\Local\Temp\UMS
INFO  2020-09-25 11:17:42.905 [main] Logging configuration file: C:\Program Files (x86)\Universal Media Server\logback.xml
INFO  2020-09-25 11:17:42.905 [main] Logfile: C:\ProgramData\UMS\debug.log
INFO  2020-09-25 11:17:42.905 [main] 
INFO  2020-09-25 11:17:42.905 [main] Profile directory: C:\ProgramData\UMS
INFO  2020-09-25 11:17:42.906 [main] Profile directory permissions: drwx
INFO  2020-09-25 11:17:42.907 [main] Profile configuration file: C:\ProgramData\UMS\UMS.conf
INFO  2020-09-25 11:17:42.908 [main] Profile configuration file permissions: -rwx
INFO  2020-09-25 11:17:42.909 [main] Profile name: Antares
INFO  2020-09-25 11:17:42.909 [main] 
DEBUG 2020-09-25 11:17:42.909 [main] Reading web_conf: "C:\ProgramData\UMS\WEB.conf" (previous: null, default: "C:\ProgramData\UMS\WEB.conf")
INFO  2020-09-25 11:17:42.909 [main] Web configuration file: C:\ProgramData\UMS\WEB.conf
INFO  2020-09-25 11:17:42.911 [main] Web configuration file permissions: -rwx
INFO  2020-09-25 11:17:42.911 [main] 
DEBUG 2020-09-25 11:17:42.918 [main] Using database URL: jdbc:h2:C:\ProgramData\UMS\database\medias
INFO  2020-09-25 11:17:42.918 [main] Using database located at: "C:\ProgramData\UMS\database"

DEBUG 2020-09-25 11:17:42.919 [main] Database logging is disabled

Code: Select all

DEBUG 2020-09-25 11:17:43.413 [main] Database file count: 31339
DEBUG 2020-09-25 11:17:43.413 [main] Database version: 23
DEBUG 2020-09-25 11:17:43.413 [main] Starting check of database tables
DEBUG 2020-09-25 11:17:43.428 [main] Reading run_wizard: false (default: true)
DEBUG 2020-09-25 11:17:43.437 [main] No matching graphics configuration found, using the default
DEBUG 2020-09-25 11:17:43.498 [main] Reading hide_advanced_options: false (default: true)
DEBUG 2020-09-25 11:17:44.049 [main] Reading minimized: true (default: false)
DEBUG 2020-09-25 11:17:44.054 [main] Reading server_name: "Media Server" (default: "Universal Media Server")
DEBUG 2020-09-25 11:17:44.212 [main] Reading hostname: "192.168.1.4" (default: null)
DEBUG 2020-09-25 11:17:44.318 [main] Reading network_interface: "Intel(R) Ethernet Connection (2) I219-V" (default: "")
DEBUG 2020-09-25 11:17:44.322 [main] Reading maximum_bitrate: "30" (default: "90")
DEBUG 2020-09-25 11:17:44.330 [main] Reading thumbnail_seek_position: 120 (default: 4)
DEBUG 2020-09-25 11:17:44.344 [main] Reading show_media_library_folder: false (default: true)
DEBUG 2020-09-25 11:17:44.353 [main] Reading resume: false (default: true)
DEBUG 2020-09-25 11:17:44.354 [main] Reading show_recently_played_folder: false (default: true)
INFO  2020-09-25 11:17:44.374 [main] Checking shared folder: "D:\MediaPC\Videos"
INFO  2020-09-25 11:17:44.375 [main] Checking shared folder: "D:\MediaPC\Music"
INFO  2020-09-25 11:17:44.375 [main] Checking shared folder: "D:\MediaPC\Pictures"
DEBUG 2020-09-25 11:17:44.417 [main] Reading mpeg2_main_settings: "Automatic (Wireless)" (default: "Automatic (Wired)")
DEBUG 2020-09-25 11:17:44.419 [main] Reading x264_constant_rate_factor: "Automatic (Wireless)" (default: "Automatic (Wired)")
ERROR 2020-09-25 11:17:44.671 [main] FATAL ERROR: Unable to bind web interface on port: 9001, because: Address already in use: bind
INFO  2020-09-25 11:17:44.672 [main] Maybe another process is running or the hostname is wrong.
DEBUG 2020-09-25 11:17:44.679 [main] Added file watch at C:\ProgramData\UMS: C:\\ProgramData\\UMS\\UMS.cred
INFO  2020-09-25 11:17:44.685 [main] Loading MediaInfo library
INFO  2020-09-25 11:17:44.698 [main] Loaded MediaInfoLib - v20.08
DEBUG 2020-09-25 11:17:44.698 [main] Setting MediaInfo library characterset to UTF-8
INFO  2020-09-25 11:17:44.704 [main] Loading renderer configurations from C:\Program Files (x86)\Universal Media Server\renderers

[Overcast451]

I looked through ums.conf again.
Found the logging section and set it to 'all'.

I suspect that's going to generate a lot of data? Would 'trace' be sufficient? I'm not pressed on disk space, so I'll leave it to ALL for the time being.

Code: Select all

# Log Level
# ---------------------
# The root logging level, a root filter applied to all logging, which can be:
# ALL, TRACE, DEBUG, INFO, WARN, ERROR or OFF
# This property can also be set from the 'Logs' tab in the gui.
# Default: "DEBUG"
log_level = ALL

[Nadahar]

Setting it to "all" won't enabled database logging. I'm not sure how much they have included of this functionality since it has been copied from DMS, but in DMS you have to set "log_database = true" in DMS.conf to enable it. That said, I'm not sure how much of a difference enabling database logging will make. It should be possible to see what's the problem in a normal trace log.

[Overcast451]

Well - I didn't run into it again. However.. I also decided it was time for me to migrate my media server over to Linux. So - I probably won't see it again.
Just wanted to mention that!

Thanks for the responses to this.