Slow Database shut down. Any solutions?
I have about 6000 images and on an 8 core 8000M/Bs CPU and 16GB of RAM (Windows 10) the Databse takes approximately 4 mins to shut down. All these images are in 1 catalogued folder (many sub) My Pictures.
Meanwhile, over 90% of RAM is being used.
Frequently, enterering the Browse module causes internimable delays. This is becoming very frustrating indeed. Does removing catalogues help?
Any other work arounds? ON1 did spell out the need to let the computer work in the background to let the files be catalogued and I have done that - but all to no avail, I'm afraid.
-
I would look in the log file and see if ON1 is complaining about any of your files. If you are not familiar with the log file...
Look under the Help menu for Show ON1 Log. It may be a huge text file as it never deletes anything in it (that I am aware of). Once you know where the log file is located (replace Kevin below with your username):
C:\Users\Kevin\AppData\Roaming\ON1\ON1 Photo RAW 2019\ON1 Photo RAW Log.txt
You can exit ON1, rename this file and ON1 will create a clean one when you run it again.
0 -
Some users have had problems with On1 Catalog and have abandoned it's use.
0 -
Here is the log file, produced as suggested:
2019-02-20 10:19:16 ON1 - Build: 13.2.0.6564
2019-02-20 10:19:16 ON1 - LibRaw: 0.19.1-Release
2019-02-20 10:19:16 ON1 Photo RAW 2019 - Launched Standalone
2019-02-20 10:19:16 ON1 - System Locale: en-GB
2019-02-20 10:19:16 ON1 - Default Locale: en-GB
2019-02-20 10:19:17 ON1 - ONRaw: 212
[m4856] 2019-02-20 10:19:17 ON1 - System reports VRAM: 1990 MB
[ 14868] 2019-02-20 10:19:17 ON1 - OnOneFilterPipe::RunJobThread> RUNNING
[ 2452] 2019-02-20 10:19:17 ON1 - OnOneGPUPipe::RunJobThread> RUNNING
2019-02-20 10:19:18 Analytics - DeviceID: 00001abf0000490400005dd60000142e000057b0
2019-02-20 10:19:18 ON1 - Video Card Vendor: NVIDIA Corporation
2019-02-20 10:19:18 ON1 - Video Card VersionEx: 4.5.0 NVIDIA 391.35
2019-02-20 10:19:18 ON1 - Video Card: NVIDIA GeForce GT 730
2019-02-20 10:19:18 ON1 - CreateRGBColorCube: 17.301100 ms
2019-02-20 10:19:18 ON1 - CreateRGBColorCube2: 17.389379 ms
[m4856] 2019-02-20 10:19:18 ON1 - System reports VRAM: 1990 MB
[m4856] 2019-02-20 10:19:21 ON1 - Cleanup: Removed 1 tile store files.
[m4856] 2019-02-20 10:19:22 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:22 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:22 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:22 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:22 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)2019-02-20 10:19:22 ON1 - Server starting up
2019-02-20 10:19:22 ONQtServer - ONQtServer listening on 50280
[m4856] 2019-02-20 10:19:22 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_set_psk_client_callback[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_set_psk_server_callback[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_CTX_use_psk_identity_hint[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve TLSv1_1_client_method[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve TLSv1_2_client_method[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve TLSv1_1_server_method[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve TLSv1_2_server_method[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_select_next_proto[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_CTX_set_next_proto_select_cb[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_get0_next_proto_negotiated[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_set_alpn_protos[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_CTX_set_alpn_select_cb[m4856] 2019-02-20 10:19:22 ON1 - QSslSocket: cannot resolve SSL_get0_alpn_selected[m4856] 2019-02-20 10:19:26 ON1 - System reports VRAM: 1990 MB
[m4856] 2019-02-20 10:19:26 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:26 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.) [ 1292] 2019-02-20 10:19:26 ON1 - QSslSocket: cannot call unresolved function SSL_get0_next_proto_negotiated2019-02-20 10:19:27 ON1 - Activation - Network Active (getLicenseStatus)
[m4856] 2019-02-20 10:19:27 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.) [ 4704] 2019-02-20 10:19:27 ON1 - QSslSocket: cannot call unresolved function SSL_get0_next_proto_negotiated2019-02-20 10:19:28 ON1 - Activation - Network Active (membershipActive)
[m4856] 2019-02-20 10:19:28 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.) [ 1600] 2019-02-20 10:19:29 ON1 - QSslSocket: cannot call unresolved function SSL_get0_next_proto_negotiated[m4856] 2019-02-20 10:19:30 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:31 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:31 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)2019-02-20 10:19:31 ON1 - PLLrMigrationCacheMgr::initialize - > cache manager initilized.
2019-02-20 10:19:31 ON1 - PLLrMigrationCacheMgr::initialize - > loaded from archive.
[m4856] 2019-02-20 10:19:31 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:31 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)2019-02-20 10:19:32 ON1 - Marketing URL: https://www.on1.com/appmessages/?product=photoraw2019&version=2019.2&plus=yes&state=Active
[m4856] 2019-02-20 10:19:32 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:33 ON1 - Query Marketing url FAILED with code: 0[m4856] 2019-02-20 10:19:34 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)2019-02-20 10:19:37 ON1 - CreateRGBColorCube: 17.727440 ms
2019-02-20 10:19:37 ON1 - CreateRGBColorCube2: 17.812402 ms
[m4856] 2019-02-20 10:19:43 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)2019-02-20 10:19:43 ON1 - ********************** Opened file Feb Walk3.arw with ONPhotoRaw
[m4856] 2019-02-20 10:19:57 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:57 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:58 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:19:59 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:20:12 ON1 - BRController::shutdown() Stop ND Listener.
[m4856] 2019-02-20 10:20:12 ON1 - BRController::shutdown() Stop ES Listener.
[m4856] 2019-02-20 10:20:12 ON1 - BRController::shutdown() Release ND Service.
[m4856] 2019-02-20 10:20:12 ON1 - BRController::shutdown() Stop PS Listener.
[m4856] 2019-02-20 10:20:12 ON1 - BRController::shutdown() Stop Preview Bridge.
[m4856] 2019-02-20 10:20:12 ON1 - BRController::shutdown() Shutdown Grid Controller.
[m4856] 2019-02-20 10:20:12 ON1 - BRController::shutdown() Stop FS watchers.
2019-02-20 10:20:12 ON1 - Starting Shutdown.
[m4856] 2019-02-20 10:20:12 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m4856] 2019-02-20 10:20:13 ON1 - QFileSystemWatcher::removePaths: list is empty[m4856] 2019-02-20 10:20:14 ON1 - QWindowsWindow::setGeometry: Unable to set geometry 350x130+788+537 on QWidgetWindow/'OnOneProgressWindow'. Resulting geometry: 344x109+788+537 (frame: 8, 31, 8, 8, custom margin: 0, 0, 0, 0, minimum size: 344x109, maximum size: 344x109).2019-02-20 10:21:13 ON1 - ONExploreService::loadPhotos() loaded 0 photos; took 112447 ms.
[ 12464] 2019-02-20 10:21:13 ON1 - ONExploreStartup::run() took 114595 ms.
2019-02-20 10:21:60 ON1 - Shutdown complete in 107465 ms.Means little to me but does repeat 'Failed to set thread priority' and other apparent anomolies.
Is this significant?
0 -
I have a similar issue. it takes 7 minutes for ON1 to come down. This log is just bringing it up and then down.
2019-02-24 14:25:51 ON1 - Build: 13.2.0.6564
2019-02-24 14:25:52 ON1 - LibRaw: 0.19.1-Release
2019-02-24 14:25:52 ON1 Photo RAW 2019 - Launched Standalone
2019-02-24 14:25:53 ON1 - System Locale: en
2019-02-24 14:25:53 ON1 - Default Locale: en
2019-02-24 14:25:55 ON1 - ONRaw: 212
[m12140] 2019-02-24 14:25:56 ON1 - System reports VRAM: 1990 MB
[ 11440] 2019-02-24 14:25:56 ON1 - OnOneFilterPipe::RunJobThread> RUNNING
[ 9244] 2019-02-24 14:25:56 ON1 - OnOneGPUPipe::RunJobThread> RUNNING
2019-02-24 14:25:58 Analytics - DeviceID: 0000678100005bcb000009ae0000362d00004ae9
2019-02-24 14:25:58 ON1 - Video Card Vendor: NVIDIA Corporation
2019-02-24 14:25:58 ON1 - Video Card VersionEx: 4.5.0 NVIDIA 391.35
2019-02-24 14:25:58 ON1 - Video Card: NVIDIA GeForce GT 730
2019-02-24 14:25:58 ON1 - CreateRGBColorCube: 24.356900 ms
2019-02-24 14:25:58 ON1 - CreateRGBColorCube2: 24.497700 ms
[m12140] 2019-02-24 14:25:58 ON1 - System reports VRAM: 1990 MB
[m12140] 2019-02-24 14:26:16 ON1 - Cleanup: Removed 1 tile store files.
[m12140] 2019-02-24 14:26:19 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:26:20 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:26:20 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:26:20 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:26:20 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)2019-02-24 14:26:44 ON1 - Server starting up
2019-02-24 14:26:44 ONQtServer - ONQtServer listening on 58644
[m12140] 2019-02-24 14:26:44 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_set_psk_client_callback[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_set_psk_server_callback[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_CTX_use_psk_identity_hint[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve TLSv1_1_client_method[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve TLSv1_2_client_method[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve TLSv1_1_server_method[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve TLSv1_2_server_method[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_select_next_proto[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_CTX_set_next_proto_select_cb[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_get0_next_proto_negotiated[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_set_alpn_protos[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_CTX_set_alpn_select_cb[m12140] 2019-02-24 14:26:45 ON1 - QSslSocket: cannot resolve SSL_get0_alpn_selected[m12140] 2019-02-24 14:26:47 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:26:47 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.) [ 2752] 2019-02-24 14:26:47 ON1 - QSslSocket: cannot call unresolved function SSL_get0_next_proto_negotiated2019-02-24 14:26:47 ON1 - Activation - Network Active (getLicenseStatus)
[m12140] 2019-02-24 14:26:47 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.) [ 12052] 2019-02-24 14:26:48 ON1 - QSslSocket: cannot call unresolved function SSL_get0_next_proto_negotiated2019-02-24 14:26:49 ON1 - Activation - Network Active (membershipActive)
[m12140] 2019-02-24 14:26:49 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.) [ 3616] 2019-02-24 14:26:49 ON1 - QSslSocket: cannot call unresolved function SSL_get0_next_proto_negotiated[m12140] 2019-02-24 14:26:52 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:26:52 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:26:57 ON1 - QWindowsWindow::setGeometry: Unable to set geometry 350x130+823+493 on QWidgetWindow/'OnOneProgressWindow'. Resulting geometry: 344x112+823+493 (frame: 8, 31, 8, 8, custom margin: 0, 0, 0, 0, minimum size: 344x112, maximum size: 344x112).[m12140] 2019-02-24 14:27:01 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:27:01 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)2019-02-24 14:27:01 ON1 - PLLrMigrationCacheMgr::initialize - > cache manager initilized.
2019-02-24 14:27:02 ON1 - PLLrMigrationCacheMgr::initialize - > loaded from archive.
[m12140] 2019-02-24 14:27:02 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:27:02 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:27:02 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:27:17 ON1 - BRController::shutdown() Stop ND Listener.
[m12140] 2019-02-24 14:27:17 ON1 - BRController::shutdown() Stop ES Listener.
[m12140] 2019-02-24 14:27:17 ON1 - BRController::shutdown() Release ND Service.
[m12140] 2019-02-24 14:27:17 ON1 - BRController::shutdown() Stop PS Listener.
[m12140] 2019-02-24 14:27:17 ON1 - BRController::shutdown() Stop Preview Bridge.
[m12140] 2019-02-24 14:27:17 ON1 - BRController::shutdown() Shutdown Grid Controller.
[m12140] 2019-02-24 14:27:17 ON1 - BRController::shutdown() Stop FS watchers.
2019-02-24 14:27:18 ON1 - Starting Shutdown.
[m12140] 2019-02-24 14:27:18 ON1 - QThread::start: Failed to set thread priority (The parameter is incorrect.)[m12140] 2019-02-24 14:27:18 ON1 - QFileSystemWatcher::removePaths: list is empty[m12140] 2019-02-24 14:27:20 ON1 - QWindowsWindow::setGeometry: Unable to set geometry 350x130+823+495 on QWidgetWindow/'OnOneProgressWindow'. Resulting geometry: 344x109+823+495 (frame: 8, 31, 8, 8, custom margin: 0, 0, 0, 0, minimum size: 344x109, maximum size: 344x109).2019-02-24 14:29:37 ON1 - ONExploreService::loadPhotos() loaded 0 photos; took 216006 ms.
[ 6152] 2019-02-24 14:29:37 ON1 - ONExploreStartup::run() took 217262 ms.
2019-02-24 14:36:37 ON1 - Shutdown complete in 559756 ms.0 -
I hope you both have sent this to On1 so they can see what's happening.
Bill's shutdown is under 2 minutes (107/60) which I would consider acceptable, after all, it is a Database shutting down.
James 9 minute shutdown (559/60) is not acceptable and On1 should be made aware of it.
0 -
As a reference, I have 30G+ databases with full EXIF/IPTC schemas that shut down in under 15 seconds. Longer than that, I am looking for code optimizations or database maintenance.
It seems well known, the On1 data cataloging is sensitive to certain files, So this can certainly play a part.
database maintenance
On1 seems to be "considering" database maintenance for a future release. Maybe they will include maintenance for orphaned files. Until that time, if you use the On1 cataloging feature, it is probably best to avoid managing photos from outside of On1 to avoid orphaned files.For instance... On1 will not be aware if File Explorer is used to mover images between different files. This inherently creates orphaned files (and probably orphaned caches).
Certainly On1 software development should know the processes inherently,
Warning: Advanced Techniques Required
If there is interest in self-diagnosing the problem, using a process monitor during the 2-min or 9-min shutdown could lend insight into where On1 is spending time. Thus, helping point the direction to the root cause.0 -
Very interesting Gus. I have removed all my catalogues from inside ON1 but database shutdown is now over 5 mins. I just use the folders to seek files and Albums.
I am so fed up of freezes going from Develop to Browse and vice versa that I'm back to Affinity and contemplating Adobe again. Quite sad as the programme features are very attractive ...
All other programmes including video editing run smoothly ...
0
Please sign in to leave a comment.
Comments
7 comments