OwlPlug icon indicating copy to clipboard operation
OwlPlug copied to clipboard

Synchronization fails repeatedly on Mac

Open sixstringv opened this issue 8 months ago • 13 comments

I'm running OwlPlug v1.29.0 on Mac OS 11.7.6 (20G1231). OwlPlug is in the Applications directory and this is the first time I've ran the app, no previous scans. My plug-ins are in the default locations: /Library/Audio/Plug-ins/VST /Library/Audio/Plug-ins/VST3

I started with running Native but it crashed a lot on common plug-ins such as Arturia, NI, etc. So I switched that off. OwlPlug seems to know it was a problem due to Native. Could it automatically deal with the error and continue scanning rather than crashing?

I've since tried to sync dozens of times. Some times it errors right away, other times it runs for minutes before erroring. The message is always the same: "Plugins synchronization failed. Check your plugin directory.". The plugin locations in settings are correct. I do have plugins in sub folders by category, such as synths, drums, etc. Could that be the problem? Looks like a java source error possibly. Below is a log from the last time a ran it.

Great looking app! Thanks for making it available. I'm anxious to try it after a sync will complete.

12566373 INFO c.owlplug.core.tasks.PluginSyncTask - Plugin Sync task started 12568465 INFO c.owlplug.core.tasks.PluginSyncTask - 1481 plugins collected [Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 12622699 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:175) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 12697849 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:175) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 12697982 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:175) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 12826934 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxVstFile.toPlugin(OsxVstFile.java:56) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:175) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 12883350 ERROR c.owlplug.core.tasks.PluginSyncTask - Plugins synchronization failed org.springframework.dao.DataIntegrityViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( /* key:0 / CAST(1669 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/Delay TAPE-201.vst3')"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?) [23505-232]] [insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?)]; SQL [insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?)]; constraint [PRIMARY KEY] at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:290) at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:241) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:566) at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:795) at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:758) at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:698) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:416) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:138) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:165) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:223) at jdk.proxy2/jdk.proxy2.$Proxy135.save(Unknown Source) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:181) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.hibernate.exception.ConstraintViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( / key:0 / CAST(1669 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/Delay TAPE-201.vst3')"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?) [23505-232]] [insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?)] at org.hibernate.dialect.H2Dialect.lambda$buildSQLExceptionConversionDelegate$3(H2Dialect.java:759) at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:58) at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:108) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:197) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.performNonBatchedMutation(AbstractMutationExecutor.java:134) at org.hibernate.engine.jdbc.mutation.internal.MutationExecutorSingleNonBatched.performNonBatchedOperations(MutationExecutorSingleNonBatched.java:55) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.execute(AbstractMutationExecutor.java:55) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.doStaticInserts(InsertCoordinatorStandard.java:194) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.coordinateInsert(InsertCoordinatorStandard.java:132) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.insert(InsertCoordinatorStandard.java:104) at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:110) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:644) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:511) at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:414) at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:41) at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:127) at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1429) at org.hibernate.internal.SessionImpl.managedFlush(SessionImpl.java:491) at org.hibernate.internal.SessionImpl.flushBeforeTransactionCompletion(SessionImpl.java:2354) at org.hibernate.internal.SessionImpl.beforeTransactionCompletion(SessionImpl.java:1978) at org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl.beforeTransactionCompletion(JdbcCoordinatorImpl.java:439) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.beforeCompletionCallback(JdbcResourceLocalTransactionCoordinatorImpl.java:169) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.commit(JdbcResourceLocalTransactionCoordinatorImpl.java:267) at org.hibernate.engine.transaction.internal.TransactionImpl.commit(TransactionImpl.java:101) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:562) ... 20 common frames omitted Caused by: org.h2.jdbc.JdbcSQLIntegrityConstraintViolationException: Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( / key:0 */ CAST(1669 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/Delay TAPE-201.vst3')"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?) [23505-232] at org.h2.message.DbException.getJdbcSQLException(DbException.java:520) at org.h2.message.DbException.getJdbcSQLException(DbException.java:489) at org.h2.message.DbException.get(DbException.java:223) at org.h2.message.DbException.get(DbException.java:199) at org.h2.mvstore.db.MVPrimaryIndex.add(MVPrimaryIndex.java:121) at org.h2.mvstore.db.MVTable.addRow(MVTable.java:517) at org.h2.command.dml.Insert.insertRows(Insert.java:174) at org.h2.command.dml.Insert.update(Insert.java:135) at org.h2.command.dml.DataChangeStatement.update(DataChangeStatement.java:74) at org.h2.command.CommandContainer.update(CommandContainer.java:139) at org.h2.command.Command.executeUpdate(Command.java:304) at org.h2.command.Command.executeUpdate(Command.java:248) at org.h2.jdbc.JdbcPreparedStatement.executeUpdateInternal(JdbcPreparedStatement.java:213) at org.h2.jdbc.JdbcPreparedStatement.executeUpdate(JdbcPreparedStatement.java:172) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:194) ... 41 common frames omitted 12883351 ERROR c.o.core.components.TaskRunner - Error while running task com.owlplug.core.tasks.TaskException: Plugins synchronization failed at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:227) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source)

sixstringv avatar Apr 15 '25 14:04 sixstringv

Update::

I found my version of Java was out of date and updated to: jre-8u451

Still getting the same error with the last few lines as: 400321 ERROR c.o.core.components.TaskRunner - Error while running task com.owlplug.core.tasks.TaskException: Plugins synchronization failed at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:227) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source)

sixstringv avatar Apr 15 '25 16:04 sixstringv

Hello @sixstringv

Thank you for using OwlPlug !

Could it automatically deal with the error and continue scanning rather than crashing?

Can you switch Native Discovery mode to OwlPlug Scanner in the Options tab ? Its slower, but more tolerant to crashes as plugin load is sandboxed in a subprocess. More info aboud sync available here.

Image

The plugin locations in settings are correct. I do have plugins in sub folders by category, such as synths, drums, etc. Could that be the problem?

I don't think it's a problem. OwlPlug should be compatile with any sub-directory organization.

I found my version of Java was out of date and updated to: jre-8u451

OwlPlug is using it's own embedded version of java 21, so no worries 😉

When plugin sync fails, do you still see these DataIntegrityViolationException exceptions in the logs ? After some analysis on my side, I think i've found the weird combination of issues you are facing.

DropSnorz avatar Apr 21 '25 20:04 DropSnorz

Thanks for the reply and your time!

Just ran again using the Native OwlPlug scanner setting. I started with my Mac offline and it was scanning pretty quick. But decided I should stop before it was finished and connect online and scan again. A few plugs stopped everything for complaining about forgetting their licenses. Aside from that it scanned until the progress bar reached about 4/5 done and stopped with the same error. What I'm seeing in console are several plugins that have installers and place files where ever they choose, seem to be throwing errors because they are in duplicate locations. An example being:

Class HttpPostDelegate_UniqOZONELITE_9_13_2768 is implemented in both /Library/Audio/Plug-ins/VST/Ozone 9 Elements.vst/Contents/MacOS/PluginHooksVST (0x10c193f50) and /Library/Audio/Plug-ins/VST/Ozone 9 Elements.vst/Contents/Resources/iZOzone9Elements.bundle/Contents/MacOS/iZOzone9Elements (0x118b47e68). One of the two will be used. Which one is undefined.

This might be the issue and why I am asked to check the plugin directory?

I quit OwlPlug and ran from terminal doing a scan to see the output. There were several periodic errors that were the same: "ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output"

I didn't see a DataIntegrityViolationException error on the latest scan.

The scan this time just seemed to freeze with the following error in OwlPlug: "Collecting file metrics on directory: /Library/Audio/Plug-ins/VST3/AmpLocker.vst3/Contents/MacOS"

And the final few lines in terminal were: 768082 INFO c.owlplug.core.tasks.FileSyncTask - Starting file sync task on directory /Library/Audio/Plug-ins/VST3 1268110 ERROR c.owlplug.core.tasks.FileSyncTask - An error occurred during file sync task execution org.springframework.orm.ObjectOptimisticLockingFailureException: Row was updated or deleted by another transaction (or unsaved-value mapping was incorrect): [com.owlplug.core.model.FileStat#8061] at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:325) at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:244) at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.translateExceptionIfPossible(AbstractEntityManagerFactoryBean.java:560) at org.springframework.dao.support.ChainedPersistenceExceptionTranslator.translateExceptionIfPossible(ChainedPersistenceExceptionTranslator.java:61) at org.springframework.dao.support.DataAccessUtils.translateIfNecessary(DataAccessUtils.java:343) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:160) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:165) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:223) at jdk.proxy2/jdk.proxy2.$Proxy143.save(Unknown Source) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:106) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:106) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:106) at com.owlplug.core.tasks.FileSyncTask.start(FileSyncTask.java:62) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.hibernate.StaleObjectStateException: Row was updated or deleted by another transaction (or unsaved-value mapping was incorrect): [com.owlplug.core.model.FileStat#8061] at org.hibernate.event.internal.DefaultMergeEventListener.entityIsDetached(DefaultMergeEventListener.java:426) at org.hibernate.event.internal.DefaultMergeEventListener.merge(DefaultMergeEventListener.java:214) at org.hibernate.event.internal.DefaultMergeEventListener.doMerge(DefaultMergeEventListener.java:152) at org.hibernate.event.internal.DefaultMergeEventListener.onMerge(DefaultMergeEventListener.java:136) at org.hibernate.event.internal.DefaultMergeEventListener.onMerge(DefaultMergeEventListener.java:89) at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:127) at org.hibernate.internal.SessionImpl.fireMerge(SessionImpl.java:854) at org.hibernate.internal.SessionImpl.merge(SessionImpl.java:840) at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(Unknown Source) at java.base/java.lang.reflect.Method.invoke(Unknown Source) at org.springframework.orm.jpa.SharedEntityManagerCreator$SharedEntityManagerInvocationHandler.invoke(SharedEntityManagerCreator.java:320) at jdk.proxy2/jdk.proxy2.$Proxy127.merge(Unknown Source) at org.springframework.data.jpa.repository.support.SimpleJpaRepository.save(SimpleJpaRepository.java:639) at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(Unknown Source) at java.base/java.lang.reflect.Method.invoke(Unknown Source) at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:359) at org.springframework.data.repository.core.support.RepositoryMethodInvoker$RepositoryFragmentMethodInvoker.lambda$new$0(RepositoryMethodInvoker.java:277) at org.springframework.data.repository.core.support.RepositoryMethodInvoker.doInvoke(RepositoryMethodInvoker.java:170) at org.springframework.data.repository.core.support.RepositoryMethodInvoker.invoke(RepositoryMethodInvoker.java:158) at org.springframework.data.repository.core.support.RepositoryComposition$RepositoryFragments.invoke(RepositoryComposition.java:515) at org.springframework.data.repository.core.support.RepositoryComposition.invoke(RepositoryComposition.java:284) at org.springframework.data.repository.core.support.RepositoryFactorySupport$ImplementationMethodExecutionInterceptor.invoke(RepositoryFactorySupport.java:731) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.repository.core.support.QueryExecutorMethodInterceptor.doInvoke(QueryExecutorMethodInterceptor.java:174) at org.springframework.data.repository.core.support.QueryExecutorMethodInterceptor.invoke(QueryExecutorMethodInterceptor.java:149) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:380) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:138) ... 17 common frames omitted 1268112 ERROR c.o.core.components.TaskRunner - Error while running task com.owlplug.core.tasks.TaskException: org.springframework.orm.ObjectOptimisticLockingFailureException: Row was updated or deleted by another transaction (or unsaved-value mapping was incorrect): [com.owlplug.core.model.FileStat#8061] at com.owlplug.core.tasks.FileSyncTask.start(FileSyncTask.java:68) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.springframework.orm.ObjectOptimisticLockingFailureException: Row was updated or deleted by another transaction (or unsaved-value mapping was incorrect): [com.owlplug.core.model.FileStat#8061] at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:325) at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:244) at org.springframework.orm.jpa.AbstractEntityManagerFactoryBean.translateExceptionIfPossible(AbstractEntityManagerFactoryBean.java:560) at org.springframework.dao.support.ChainedPersistenceExceptionTranslator.translateExceptionIfPossible(ChainedPersistenceExceptionTranslator.java:61) at org.springframework.dao.support.DataAccessUtils.translateIfNecessary(DataAccessUtils.java:343) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:160) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:165) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:223) at jdk.proxy2/jdk.proxy2.$Proxy143.save(Unknown Source) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:106) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:106) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:106) at com.owlplug.core.tasks.FileSyncTask.start(FileSyncTask.java:62) ... 7 common frames omitted Caused by: org.hibernate.StaleObjectStateException: Row was updated or deleted by another transaction (or unsaved-value mapping was incorrect): [com.owlplug.core.model.FileStat#8061] at org.hibernate.event.internal.DefaultMergeEventListener.entityIsDetached(DefaultMergeEventListener.java:426) at org.hibernate.event.internal.DefaultMergeEventListener.merge(DefaultMergeEventListener.java:214) at org.hibernate.event.internal.DefaultMergeEventListener.doMerge(DefaultMergeEventListener.java:152) at org.hibernate.event.internal.DefaultMergeEventListener.onMerge(DefaultMergeEventListener.java:136) at org.hibernate.event.internal.DefaultMergeEventListener.onMerge(DefaultMergeEventListener.java:89) at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:127) at org.hibernate.internal.SessionImpl.fireMerge(SessionImpl.java:854) at org.hibernate.internal.SessionImpl.merge(SessionImpl.java:840) at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(Unknown Source) at java.base/java.lang.reflect.Method.invoke(Unknown Source) at org.springframework.orm.jpa.SharedEntityManagerCreator$SharedEntityManagerInvocationHandler.invoke(SharedEntityManagerCreator.java:320) at jdk.proxy2/jdk.proxy2.$Proxy127.merge(Unknown Source) at org.springframework.data.jpa.repository.support.SimpleJpaRepository.save(SimpleJpaRepository.java:639) at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(Unknown Source) at java.base/java.lang.reflect.Method.invoke(Unknown Source) at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:359) at org.springframework.data.repository.core.support.RepositoryMethodInvoker$RepositoryFragmentMethodInvoker.lambda$new$0(RepositoryMethodInvoker.java:277) at org.springframework.data.repository.core.support.RepositoryMethodInvoker.doInvoke(RepositoryMethodInvoker.java:170) at org.springframework.data.repository.core.support.RepositoryMethodInvoker.invoke(RepositoryMethodInvoker.java:158) at org.springframework.data.repository.core.support.RepositoryComposition$RepositoryFragments.invoke(RepositoryComposition.java:515) at org.springframework.data.repository.core.support.RepositoryComposition.invoke(RepositoryComposition.java:284) at org.springframework.data.repository.core.support.RepositoryFactorySupport$ImplementationMethodExecutionInterceptor.invoke(RepositoryFactorySupport.java:731) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.repository.core.support.QueryExecutorMethodInterceptor.doInvoke(QueryExecutorMethodInterceptor.java:174) at org.springframework.data.repository.core.support.QueryExecutorMethodInterceptor.invoke(QueryExecutorMethodInterceptor.java:149) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:380) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:138) ... 17 common frames omitted

Maybe it's coming down to my plugins are a mess?

Thanks again for your time!

sixstringv avatar Apr 22 '25 12:04 sixstringv

A little more info. I ran again from Terminal but with no internet connection. This time was different errors with the final being:

367123 ERROR c.owlplug.core.tasks.PluginSyncTask - Plugins synchronization failed org.springframework.dao.DataIntegrityViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( /* key:0 / CAST(698 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/SlimVerb.vst3')"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?) [23505-232]] [insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?)]; SQL [insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?)]; constraint [PRIMARY KEY] at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:290) at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:241) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:566) at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:795) at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:758) at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:698) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:416) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:138) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:165) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:223) at jdk.proxy2/jdk.proxy2.$Proxy135.save(Unknown Source) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:181) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.hibernate.exception.ConstraintViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( / key:0 / CAST(698 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/SlimVerb.vst3')"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?) [23505-232]] [insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?)] at org.hibernate.dialect.H2Dialect.lambda$buildSQLExceptionConversionDelegate$3(H2Dialect.java:759) at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:58) at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:108) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:197) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.performNonBatchedMutation(AbstractMutationExecutor.java:134) at org.hibernate.engine.jdbc.mutation.internal.MutationExecutorSingleNonBatched.performNonBatchedOperations(MutationExecutorSingleNonBatched.java:55) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.execute(AbstractMutationExecutor.java:55) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.doStaticInserts(InsertCoordinatorStandard.java:194) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.coordinateInsert(InsertCoordinatorStandard.java:132) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.insert(InsertCoordinatorStandard.java:104) at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:110) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:644) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:511) at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:414) at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:41) at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:127) at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1429) at org.hibernate.internal.SessionImpl.managedFlush(SessionImpl.java:491) at org.hibernate.internal.SessionImpl.flushBeforeTransactionCompletion(SessionImpl.java:2354) at org.hibernate.internal.SessionImpl.beforeTransactionCompletion(SessionImpl.java:1978) at org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl.beforeTransactionCompletion(JdbcCoordinatorImpl.java:439) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.beforeCompletionCallback(JdbcResourceLocalTransactionCoordinatorImpl.java:169) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.commit(JdbcResourceLocalTransactionCoordinatorImpl.java:267) at org.hibernate.engine.transaction.internal.TransactionImpl.commit(TransactionImpl.java:101) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:562) ... 20 common frames omitted Caused by: org.h2.jdbc.JdbcSQLIntegrityConstraintViolationException: Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( / key:0 */ CAST(698 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/SlimVerb.vst3')"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,id) values (?,?,?) [23505-232] at org.h2.message.DbException.getJdbcSQLException(DbException.java:520) at org.h2.message.DbException.getJdbcSQLException(DbException.java:489) at org.h2.message.DbException.get(DbException.java:223) at org.h2.message.DbException.get(DbException.java:199) at org.h2.mvstore.db.MVPrimaryIndex.add(MVPrimaryIndex.java:121) at org.h2.mvstore.db.MVTable.addRow(MVTable.java:517) at org.h2.command.dml.Insert.insertRows(Insert.java:174) at org.h2.command.dml.Insert.update(Insert.java:135) at org.h2.command.dml.DataChangeStatement.update(DataChangeStatement.java:74) at org.h2.command.CommandContainer.update(CommandContainer.java:139) at org.h2.command.Command.executeUpdate(Command.java:304) at org.h2.command.Command.executeUpdate(Command.java:248) at org.h2.jdbc.JdbcPreparedStatement.executeUpdateInternal(JdbcPreparedStatement.java:213) at org.h2.jdbc.JdbcPreparedStatement.executeUpdate(JdbcPreparedStatement.java:172) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:194) ... 41 common frames omitted 367124 ERROR c.o.core.components.TaskRunner - Error while running task com.owlplug.core.tasks.TaskException: Plugins synchronization failed at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:227) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source)

sixstringv avatar Apr 22 '25 12:04 sixstringv

Hello @sixstringv ,

I'm sharing some news to keep you updated about my findings.

Unfortunately, you faced multiple issues at the same time. It was quite hard to reproduce, but after starting hundreds of scans, I managed to get some random DataIntegrityViolationException on Linux.

💥 Crash while syncing plugin with native discovery

Some plugins crash the app when Native Discovery is enabled or when it is not set to OwlPlug Scanner. Like some DAWs, an unstable plugin will likely crash OwlPlug; the only option is to turn off native discovery for that plugin.

A crash recovery dialog should show up after app restart to disable the faulty plugin.

🐛 Plugin sync fails with DataIntegrityViolationException on PUBLIC.PLUGIN_FOOTPRINT

12883350 ERROR c.owlplug.core.tasks.PluginSyncTask - Plugins synchronization failed
org.springframework.dao.DataIntegrityViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( /* key:0 / CAST(1669 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/Delay TAPE-201.vst3')"; SQL statement:
...
 at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:181)

This is a very tricky behavior that seems to be introduced after the update of a software dependency (spring-boot -> 3.4.4)

When plugins are re-synchronized, existing data is deleted (delete()) and recreated (save()). In some cases, an optimization is made by the internal persistence engine, and delete() and save() operations are sent together in the wrong order to the database. The database processes the INSERT query from the save() operation before the DELETE query from delete(), leading to a conflict of entity/identifier.

🐛 Plugin sync fails with ObjectOptimisticLockingFailureException

1268110 ERROR c.owlplug.core.tasks.FileSyncTask - An error occurred during file sync task execution
org.springframework.orm.ObjectOptimisticLockingFailureException: Row was updated or deleted by another transaction (or unsaved-value mapping was incorrect): [com.owlplug.core.model.FileStat#8061]
...
 at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111)

This one is very similar to the previous one.

In the latest version, I've optimized a query for deleting internal file statistics (hierarchy, size, ...) to improve performance. My custom query was deleting data, but the persistence engine was not aware that the data had been removed from the database. In this case, when statistics are updated later, the persistence engine uses data from the cache to build an UPDATE query, but because data has been removed, an INSERT query must be produced.


Thanks for all the details provided ! I've fixed the last two issues in #311. I will try to release a new version soon, but I need to perform additional testing.

DropSnorz avatar Apr 27 '25 15:04 DropSnorz

Thanks for your time!! You're awesome. I'm happy to provide as much info as seems helpful.

sixstringv avatar Apr 28 '25 11:04 sixstringv

I noticed another issue of the same kind: #312 I've fixed it and will publish a release soon.

DropSnorz avatar Apr 30 '25 18:04 DropSnorz

I've released a fix in OwlPlug 1.29.1.

@sixstringv Can you still reproduce the issue ?

DropSnorz avatar Apr 30 '25 18:04 DropSnorz

Here's what happened running 1.29.1 with Native plugin discovery unchecked:

[Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 104392 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 203662 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 203839 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 371514 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxVstFile.toPlugin(OsxVstFile.java:56) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 426566 ERROR c.owlplug.core.tasks.PluginSyncTask - Plugins synchronization failed org.springframework.dao.DataIntegrityViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( /* key:0 / CAST(1668 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/Deelay.vst3', NULL)"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,screenshot_url,id) values (?,?,?,?) [23505-232]] [insert into plugin_footprint (native_discovery_enabled,path,screenshot_url,id) values (?,?,?,?)]; SQL [insert into plugin_footprint (native_discovery_enabled,path,screenshot_url,id) values (?,?,?,?)]; constraint [PRIMARY KEY] at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:290) at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:241) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:566) at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:795) at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:758) at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:698) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:416) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:138) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:165) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:223) at jdk.proxy2/jdk.proxy2.$Proxy135.save(Unknown Source) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:185) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.hibernate.exception.ConstraintViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( / key:0 / CAST(1668 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/Deelay.vst3', NULL)"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,screenshot_url,id) values (?,?,?,?) [23505-232]] [insert into plugin_footprint (native_discovery_enabled,path,screenshot_url,id) values (?,?,?,?)] at org.hibernate.dialect.H2Dialect.lambda$buildSQLExceptionConversionDelegate$3(H2Dialect.java:759) at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:58) at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:108) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:197) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.performNonBatchedMutation(AbstractMutationExecutor.java:134) at org.hibernate.engine.jdbc.mutation.internal.MutationExecutorSingleNonBatched.performNonBatchedOperations(MutationExecutorSingleNonBatched.java:55) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.execute(AbstractMutationExecutor.java:55) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.doStaticInserts(InsertCoordinatorStandard.java:194) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.coordinateInsert(InsertCoordinatorStandard.java:132) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.insert(InsertCoordinatorStandard.java:104) at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:110) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:644) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:511) at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:414) at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:41) at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:127) at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1429) at org.hibernate.internal.SessionImpl.managedFlush(SessionImpl.java:491) at org.hibernate.internal.SessionImpl.flushBeforeTransactionCompletion(SessionImpl.java:2354) at org.hibernate.internal.SessionImpl.beforeTransactionCompletion(SessionImpl.java:1978) at org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl.beforeTransactionCompletion(JdbcCoordinatorImpl.java:439) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.beforeCompletionCallback(JdbcResourceLocalTransactionCoordinatorImpl.java:169) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.commit(JdbcResourceLocalTransactionCoordinatorImpl.java:267) at org.hibernate.engine.transaction.internal.TransactionImpl.commit(TransactionImpl.java:101) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:562) ... 20 common frames omitted Caused by: org.h2.jdbc.JdbcSQLIntegrityConstraintViolationException: Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_FOOTPRINT(ID) ( / key:0 */ CAST(1668 AS BIGINT), TRUE, '/Library/Audio/Plug-ins/VST3/Deelay.vst3', NULL)"; SQL statement: insert into plugin_footprint (native_discovery_enabled,path,screenshot_url,id) values (?,?,?,?) [23505-232] at org.h2.message.DbException.getJdbcSQLException(DbException.java:520) at org.h2.message.DbException.getJdbcSQLException(DbException.java:489) at org.h2.message.DbException.get(DbException.java:223) at org.h2.message.DbException.get(DbException.java:199) at org.h2.mvstore.db.MVPrimaryIndex.add(MVPrimaryIndex.java:121) at org.h2.mvstore.db.MVTable.addRow(MVTable.java:517) at org.h2.command.dml.Insert.insertRows(Insert.java:174) at org.h2.command.dml.Insert.update(Insert.java:135) at org.h2.command.dml.DataChangeStatement.update(DataChangeStatement.java:74) at org.h2.command.CommandContainer.update(CommandContainer.java:139) at org.h2.command.Command.executeUpdate(Command.java:304) at org.h2.command.Command.executeUpdate(Command.java:248) at org.h2.jdbc.JdbcPreparedStatement.executeUpdateInternal(JdbcPreparedStatement.java:213) at org.h2.jdbc.JdbcPreparedStatement.executeUpdate(JdbcPreparedStatement.java:172) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:194) ... 41 common frames omitted 426567 ERROR c.o.core.components.TaskRunner - Error while running task com.owlplug.core.tasks.TaskException: Plugins synchronization failed at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:231) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source)

Here's what happened running 1.29.1 with Native plugin discovery checked and OwlPlug Scanner selected:

106772 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 112694 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 136598 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output [Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 163707 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 174599 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 250850 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 319546 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 426017 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 426281 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 426696 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 427456 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 436647 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 626047 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 628398 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 630276 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output [Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 641344 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxVstFile.toPlugin(OsxVstFile.java:56) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 641794 ERROR com.owlplug.host.io.LibraryLoader - Error during XML mapping jakarta.xml.bind.UnmarshalException: null at jakarta.xml.bind.helpers.AbstractUnmarshallerImpl.createUnmarshalException(AbstractUnmarshallerImpl.java:296) at org.glassfish.jaxb.runtime.v2.runtime.unmarshaller.UnmarshallerImpl.createUnmarshalException(UnmarshallerImpl.java:539) at org.glassfish.jaxb.runtime.v2.runtime.unmarshaller.UnmarshallerImpl.unmarshal0(UnmarshallerImpl.java:224) at org.glassfish.jaxb.runtime.v2.runtime.unmarshaller.UnmarshallerImpl.unmarshal(UnmarshallerImpl.java:189) at jakarta.xml.bind.helpers.AbstractUnmarshallerImpl.unmarshal(AbstractUnmarshallerImpl.java:152) at jakarta.xml.bind.helpers.AbstractUnmarshallerImpl.unmarshal(AbstractUnmarshallerImpl.java:205) at com.owlplug.host.loaders.EmbeddedScannerPluginLoader.createJucePluginFromRawXml(EmbeddedScannerPluginLoader.java:209) at com.owlplug.host.loaders.EmbeddedScannerPluginLoader.createPluginsFromCommandOutput(EmbeddedScannerPluginLoader.java:183) at com.owlplug.host.loaders.EmbeddedScannerPluginLoader.loadPlugin(EmbeddedScannerPluginLoader.java:148) at com.owlplug.core.services.NativeHostService.loadPlugin(NativeHostService.java:116) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:195) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.xml.sax.SAXParseException: Character reference "&#18" is an invalid XML character. at java.xml/com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.fatalError(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLScanner.reportFatalError(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLScanner.scanCharReferenceValue(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLScanner.scanAttributeValue(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.scanAttribute(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.scanStartElement(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl$NSContentDriver.scanRootElementHook(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl$FragmentContentDriver.next(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl$PrologDriver.next(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.parsers.AbstractSAXParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.SAXParserImpl$JAXPSAXParser.parse(Unknown Source) at org.glassfish.jaxb.runtime.v2.runtime.unmarshaller.UnmarshallerImpl.unmarshal0(UnmarshallerImpl.java:218) ... 15 common frames omitted 641794 ERROR com.owlplug.host.io.LibraryLoader -

<PLUGIN name="MONSTER Ethnica v1.vst3" descriptiveName="MONSTER Ethnica" format="VST" category="Synth" manufacturer="MonsterDAW" version="0.2.5.9" file="/Library/Audio/Plug-ins/VST/MONSTER Ethnica v1.vst" uniqueId="6c6f5b75" isInstrument="1" fileTime="17a7b761898" infoUpdateTime="196885a61c7" numInputs="0" numOutputs="32" isShell="0" hasARAExtension="0" uid="6c6f5b75"/> 648792 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 693715 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 823409 INFO c.owlplug.core.tasks.PluginSyncTask - Plugin Sync task complete 823410 INFO c.owlplug.core.tasks.PluginSyncTask - Task Sync Plugins completed in 13m3s. 827518 INFO c.o.project.tasks.PluginLookupTask - Task Lookup DAW Plugins completed in 0m0s. 827568 INFO c.owlplug.core.tasks.FileSyncTask - Starting file sync task on directory /Library/Audio/Plug-ins/VST3 1421728 ERROR c.owlplug.core.tasks.FileSyncTask - An error occurred during file sync task execution org.springframework.dao.DataIntegrityViolationException: could not execute statement [Referential integrity constraint violation: "FKPTCXSPE0E9WAUQIVFK6F6OPGW: PUBLIC.FILE_STAT FOREIGN KEY(PARENT_ID) REFERENCES PUBLIC.FILE_STAT(ID) (CAST(7643 AS BIGINT))"; SQL statement: insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?) [23506-232]] [insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?)]; SQL [insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?)]; constraint [KPTCXSPE0E9WAUQIVFK6F6OPGW] at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:290) at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:241) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:566) at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:795) at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:758) at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:698) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:416) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:138) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:165) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:223) at jdk.proxy2/jdk.proxy2.$Proxy143.save(Unknown Source) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:93) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:108) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:108) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:108) at com.owlplug.core.tasks.FileSyncTask.start(FileSyncTask.java:62) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.hibernate.exception.ConstraintViolationException: could not execute statement [Referential integrity constraint violation: "FKPTCXSPE0E9WAUQIVFK6F6OPGW: PUBLIC.FILE_STAT FOREIGN KEY(PARENT_ID) REFERENCES PUBLIC.FILE_STAT(ID) (CAST(7643 AS BIGINT))"; SQL statement: insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?) [23506-232]] [insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?)] at org.hibernate.exception.internal.SQLExceptionTypeDelegate.convert(SQLExceptionTypeDelegate.java:62) at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:58) at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:108) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:197) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.performNonBatchedMutation(AbstractMutationExecutor.java:134) at org.hibernate.engine.jdbc.mutation.internal.MutationExecutorSingleNonBatched.performNonBatchedOperations(MutationExecutorSingleNonBatched.java:55) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.execute(AbstractMutationExecutor.java:55) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.doStaticInserts(InsertCoordinatorStandard.java:194) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.coordinateInsert(InsertCoordinatorStandard.java:132) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.insert(InsertCoordinatorStandard.java:104) at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:110) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:644) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:511) at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:414) at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:41) at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:127) at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1429) at org.hibernate.internal.SessionImpl.managedFlush(SessionImpl.java:491) at org.hibernate.internal.SessionImpl.flushBeforeTransactionCompletion(SessionImpl.java:2354) at org.hibernate.internal.SessionImpl.beforeTransactionCompletion(SessionImpl.java:1978) at org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl.beforeTransactionCompletion(JdbcCoordinatorImpl.java:439) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.beforeCompletionCallback(JdbcResourceLocalTransactionCoordinatorImpl.java:169) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.commit(JdbcResourceLocalTransactionCoordinatorImpl.java:267) at org.hibernate.engine.transaction.internal.TransactionImpl.commit(TransactionImpl.java:101) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:562) ... 24 common frames omitted Caused by: org.h2.jdbc.JdbcSQLIntegrityConstraintViolationException: Referential integrity constraint violation: "FKPTCXSPE0E9WAUQIVFK6F6OPGW: PUBLIC.FILE_STAT FOREIGN KEY(PARENT_ID) REFERENCES PUBLIC.FILE_STAT(ID) (CAST(7643 AS BIGINT))"; SQL statement: insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?) [23506-232] at org.h2.message.DbException.getJdbcSQLException(DbException.java:520) at org.h2.message.DbException.getJdbcSQLException(DbException.java:489) at org.h2.message.DbException.get(DbException.java:223) at org.h2.message.DbException.get(DbException.java:199) at org.h2.constraint.ConstraintReferential.checkRowOwnTable(ConstraintReferential.java:308) at org.h2.constraint.ConstraintReferential.checkRow(ConstraintReferential.java:249) at org.h2.table.Table.fireConstraints(Table.java:1227) at org.h2.table.Table.fireAfterRow(Table.java:1245) at org.h2.command.dml.Insert.insertRows(Insert.java:188) at org.h2.command.dml.Insert.update(Insert.java:135) at org.h2.command.dml.DataChangeStatement.update(DataChangeStatement.java:74) at org.h2.command.CommandContainer.update(CommandContainer.java:139) at org.h2.command.Command.executeUpdate(Command.java:304) at org.h2.command.Command.executeUpdate(Command.java:248) at org.h2.jdbc.JdbcPreparedStatement.executeUpdateInternal(JdbcPreparedStatement.java:213) at org.h2.jdbc.JdbcPreparedStatement.executeUpdate(JdbcPreparedStatement.java:172) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:194) ... 45 common frames omitted 1421729 ERROR c.o.core.components.TaskRunner - Error while running task com.owlplug.core.tasks.TaskException: org.springframework.dao.DataIntegrityViolationException: could not execute statement [Referential integrity constraint violation: "FKPTCXSPE0E9WAUQIVFK6F6OPGW: PUBLIC.FILE_STAT FOREIGN KEY(PARENT_ID) REFERENCES PUBLIC.FILE_STAT(ID) (CAST(7643 AS BIGINT))"; SQL statement: insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?) [23506-232]] [insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?)]; SQL [insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?)]; constraint [KPTCXSPE0E9WAUQIVFK6F6OPGW] at com.owlplug.core.tasks.FileSyncTask.start(FileSyncTask.java:68) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.springframework.dao.DataIntegrityViolationException: could not execute statement [Referential integrity constraint violation: "FKPTCXSPE0E9WAUQIVFK6F6OPGW: PUBLIC.FILE_STAT FOREIGN KEY(PARENT_ID) REFERENCES PUBLIC.FILE_STAT(ID) (CAST(7643 AS BIGINT))"; SQL statement: insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?) [23506-232]] [insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?)]; SQL [insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?)]; constraint [KPTCXSPE0E9WAUQIVFK6F6OPGW] at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:290) at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:241) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:566) at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:795) at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:758) at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:698) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:416) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:138) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:165) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:223) at jdk.proxy2/jdk.proxy2.$Proxy143.save(Unknown Source) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:93) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:108) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:108) at com.owlplug.core.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:108) at com.owlplug.core.tasks.FileSyncTask.start(FileSyncTask.java:62) ... 7 common frames omitted Caused by: org.hibernate.exception.ConstraintViolationException: could not execute statement [Referential integrity constraint violation: "FKPTCXSPE0E9WAUQIVFK6F6OPGW: PUBLIC.FILE_STAT FOREIGN KEY(PARENT_ID) REFERENCES PUBLIC.FILE_STAT(ID) (CAST(7643 AS BIGINT))"; SQL statement: insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?) [23506-232]] [insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?)] at org.hibernate.exception.internal.SQLExceptionTypeDelegate.convert(SQLExceptionTypeDelegate.java:62) at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:58) at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:108) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:197) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.performNonBatchedMutation(AbstractMutationExecutor.java:134) at org.hibernate.engine.jdbc.mutation.internal.MutationExecutorSingleNonBatched.performNonBatchedOperations(MutationExecutorSingleNonBatched.java:55) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.execute(AbstractMutationExecutor.java:55) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.doStaticInserts(InsertCoordinatorStandard.java:194) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.coordinateInsert(InsertCoordinatorStandard.java:132) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.insert(InsertCoordinatorStandard.java:104) at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:110) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:644) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:511) at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:414) at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:41) at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:127) at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1429) at org.hibernate.internal.SessionImpl.managedFlush(SessionImpl.java:491) at org.hibernate.internal.SessionImpl.flushBeforeTransactionCompletion(SessionImpl.java:2354) at org.hibernate.internal.SessionImpl.beforeTransactionCompletion(SessionImpl.java:1978) at org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl.beforeTransactionCompletion(JdbcCoordinatorImpl.java:439) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.beforeCompletionCallback(JdbcResourceLocalTransactionCoordinatorImpl.java:169) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.commit(JdbcResourceLocalTransactionCoordinatorImpl.java:267) at org.hibernate.engine.transaction.internal.TransactionImpl.commit(TransactionImpl.java:101) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:562) ... 24 common frames omitted Caused by: org.h2.jdbc.JdbcSQLIntegrityConstraintViolationException: Referential integrity constraint violation: "FKPTCXSPE0E9WAUQIVFK6F6OPGW: PUBLIC.FILE_STAT FOREIGN KEY(PARENT_ID) REFERENCES PUBLIC.FILE_STAT(ID) (CAST(7643 AS BIGINT))"; SQL statement: insert into file_stat (length,name,parent_id,parent_path,path,id) values (?,?,?,?,?,?) [23506-232] at org.h2.message.DbException.getJdbcSQLException(DbException.java:520) at org.h2.message.DbException.getJdbcSQLException(DbException.java:489) at org.h2.message.DbException.get(DbException.java:223) at org.h2.message.DbException.get(DbException.java:199) at org.h2.constraint.ConstraintReferential.checkRowOwnTable(ConstraintReferential.java:308) at org.h2.constraint.ConstraintReferential.checkRow(ConstraintReferential.java:249) at org.h2.table.Table.fireConstraints(Table.java:1227) at org.h2.table.Table.fireAfterRow(Table.java:1245) at org.h2.command.dml.Insert.insertRows(Insert.java:188) at org.h2.command.dml.Insert.update(Insert.java:135) at org.h2.command.dml.DataChangeStatement.update(DataChangeStatement.java:74) at org.h2.command.CommandContainer.update(CommandContainer.java:139) at org.h2.command.Command.executeUpdate(Command.java:304) at org.h2.command.Command.executeUpdate(Command.java:248) at org.h2.jdbc.JdbcPreparedStatement.executeUpdateInternal(JdbcPreparedStatement.java:213) at org.h2.jdbc.JdbcPreparedStatement.executeUpdate(JdbcPreparedStatement.java:172) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:194) ... 45 common frames omitted

Let me know if I can do anything else.

sixstringv avatar Apr 30 '25 20:04 sixstringv

Hi @sixstringv,

Thank you so much for the logs! 🔥

I've identified other locations where the data needs to be flushed to the database. I've continuously synchronized plugins during a whole night without facing any data integrity or database locking exceptions.

I've published fixes in a new version OwlPlug 1.29.2

DropSnorz avatar May 19 '25 20:05 DropSnorz

Thank you for your hard work on this!!!

I ran it 3 times. Once offline with Native plugin discovery set to OwlPlug scanner, twice online with Native plugin discovery the same, and once with it unchecked. I'm sorry to say it failed all three times but seems like it's getting a little further along. Here's the logs from a fourth scan online w/Native plugin discovery set to OwlPlug scanner. This is all of the logs since there might be something you haven't seen that's causing it to fail.

Let me know if I can do anything else to help! Scott

Music-iMac:Music sch$ /Applications/OwlPlug.app/Contents/MacOS/OwlPlug ; exit; May 20, 2025 7:20:51 AM com.sun.javafx.application.PlatformImpl startup WARNING: Unsupported JavaFX configuration: classes were loaded from 'unnamed module @7026eaa0' 07:20:52,523 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.18 07:20:52,524 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - Here is a list of configurators discovered as a service, by rank: 07:20:52,524 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - org.springframework.boot.logging.logback.RootLogLevelConfigurator 07:20:52,524 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - They will be invoked in order until ExecutionStatus.DO_NOT_INVOKE_NEXT_IF_ANY is returned. 07:20:52,524 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - Constructed configurator of type class org.springframework.boot.logging.logback.RootLogLevelConfigurator 07:20:52,528 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - org.springframework.boot.logging.logback.RootLogLevelConfigurator.configure() call lasted 1 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 07:20:52,528 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 07:20:52,528 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 07:20:52,529 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 07:20:52,529 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 07:20:52,529 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 1 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 07:20:52,529 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 07:20:52,529 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 07:20:52,530 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 07:20:52,530 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml] 07:20:52,534 |-INFO in ConfigurationWatchList(mainURL=jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml, fileWatchList={}, urlWatchList=[}) - URL [jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml] is not of type file 07:20:52,592 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE] 07:20:52,592 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] 07:20:52,598 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@46f78ad2 - value "/Users/sch/.owlplug/logs/owlplug.log" substituted for "${user.home}/.owlplug/logs/owlplug.log" 07:20:52,601 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@46f78ad2 - value "/Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log" substituted for "${user.home}/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log" 07:20:52,605 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1722631178 - No compression will be used 07:20:52,611 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1722631178 - Will use the pattern /Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log for the active file 07:20:52,625 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@660f7f27 - The date pattern is 'yyyy-MM-dd' from file name pattern '/Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log'. 07:20:52,625 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@660f7f27 - Roll-over at midnight. 07:20:52,628 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@660f7f27 - Setting initial period to 2025-05-20T11:20:27.079Z 07:20:52,628 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@660f7f27 - Direct use of either SizeAndTimeBasedFNATP or SizeAndTimeBasedFileNamingAndTriggeringPolicy 07:20:52,628 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@660f7f27 - is deprecated. Please use SizeAndTimeBasedRollingPolicy instead. 07:20:52,628 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@660f7f27 - For more information see https://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy 07:20:52,630 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 07:20:52,645 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /Users/sch/.owlplug/logs/owlplug.log 07:20:52,646 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Setting currentFileLength to 58570 for /Users/sch/.owlplug/logs/owlplug.log 07:20:52,647 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/Users/sch/.owlplug/logs/owlplug.log] 07:20:52,647 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [STDOUT] 07:20:52,647 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 07:20:52,649 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 07:20:52,649 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - BEWARE: Writing to the console can be very slow. Avoid logging to the 07:20:52,649 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - console in production environments, especially in high volume systems. 07:20:52,649 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also https://logback.qos.ch/codes.html#slowConsole 07:20:52,649 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [com.owlplug] to INFO 07:20:52,649 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [com.owlplug] to false 07:20:52,649 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[com.owlplug] 07:20:52,650 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[com.owlplug] 07:20:52,650 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.springframework] to INFO 07:20:52,650 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [org.springframework] to false 07:20:52,650 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[org.springframework] 07:20:52,650 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.hibernate.SQL] to INFO 07:20:52,650 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [org.hibernate.SQL] to false 07:20:52,650 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[org.hibernate.SQL] 07:20:52,650 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@14659b12 - End of configuration. 07:20:52,650 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@6ebe3256 - Registering current configuration as safe fallback point 07:20:52,650 |-INFO in ch.qos.logback.classic.util.ContextInitializer@7b1b7c2a - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 121 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

07:20:52,883 |-INFO in ConfigurationWatchList(mainURL=jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml, fileWatchList={}, urlWatchList=[}) - URL [jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml] is not of type file 07:20:52,887 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE] 07:20:52,887 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] 07:20:52,887 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@63ff2f5a - value "/Users/sch/.owlplug/logs/owlplug.log" substituted for "${user.home}/.owlplug/logs/owlplug.log" 07:20:52,887 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@63ff2f5a - value "/Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log" substituted for "${user.home}/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log" 07:20:52,887 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@2069364008 - No compression will be used 07:20:52,887 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@2069364008 - Will use the pattern /Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log for the active file 07:20:52,888 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@9d67648 - The date pattern is 'yyyy-MM-dd' from file name pattern '/Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log'. 07:20:52,888 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@9d67648 - Roll-over at midnight. 07:20:52,888 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@9d67648 - Setting initial period to 2025-05-20T11:20:27.079Z 07:20:52,888 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@9d67648 - Direct use of either SizeAndTimeBasedFNATP or SizeAndTimeBasedFileNamingAndTriggeringPolicy 07:20:52,888 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@9d67648 - is deprecated. Please use SizeAndTimeBasedRollingPolicy instead. 07:20:52,888 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@9d67648 - For more information see https://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy 07:20:52,888 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 07:20:52,888 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /Users/sch/.owlplug/logs/owlplug.log 07:20:52,889 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Setting currentFileLength to 58570 for /Users/sch/.owlplug/logs/owlplug.log 07:20:52,889 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/Users/sch/.owlplug/logs/owlplug.log] 07:20:52,889 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [STDOUT] 07:20:52,889 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 07:20:52,889 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 07:20:52,889 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - BEWARE: Writing to the console can be very slow. Avoid logging to the 07:20:52,889 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - console in production environments, especially in high volume systems. 07:20:52,889 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also https://logback.qos.ch/codes.html#slowConsole 07:20:52,889 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [com.owlplug] to INFO 07:20:52,889 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@4ed0d471 - Propagating INFO level on Logger[com.owlplug] onto the JUL framework 07:20:52,889 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [com.owlplug] to false 07:20:52,889 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[com.owlplug] 07:20:52,889 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[com.owlplug] 07:20:52,889 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.springframework] to INFO 07:20:52,889 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@4ed0d471 - Propagating INFO level on Logger[org.springframework] onto the JUL framework 07:20:52,889 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [org.springframework] to false 07:20:52,889 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[org.springframework] 07:20:52,890 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.hibernate.SQL] to INFO 07:20:52,890 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@4ed0d471 - Propagating INFO level on Logger[org.hibernate.SQL] onto the JUL framework 07:20:52,890 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [org.hibernate.SQL] to false 07:20:52,890 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[org.hibernate.SQL] 07:20:52,890 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@54cfb70e - End of configuration. 07:20:52,890 |-INFO in org.springframework.boot.logging.logback.SpringBootJoranConfigurator@1035be02 - Registering current configuration as safe fallback point


/ __ \ _ __ / / / _ \ / / __ __ ___ _ / // /| |/|/ / / / / / / / / // / / _ `/ _/ |,/ // // // _,/ _, / /__/

456 INFO o.s.boot.SpringApplication - Starting application using Java 21.0.7 with PID 3056 (/Applications/OwlPlug.app/Contents/app/owlplug.jar started by sch in /Users/sch/Music) 457 INFO o.s.boot.SpringApplication - No active profile set, falling back to 1 default profile: "default" 850 INFO o.s.d.r.c.RepositoryConfigurationDelegate - Bootstrapping Spring Data JPA repositories in DEFAULT mode. 927 INFO o.s.d.r.c.RepositoryConfigurationDelegate - Finished Spring Data repository scanning in 70 ms. Found 11 JPA repository interfaces. 1125 INFO c.o.c.c.ApplicationDefaults - Runtime Platform Resolved: RuntimePlatform [tag=mac, operatingSystem=MAC, arch=x64] 1523 INFO o.s.o.j.p.SpringPersistenceUnitInfo - No LoadTimeWeaver setup: ignoring JPA class transformer 3644 INFO o.s.o.j.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default' 3922 INFO o.s.d.j.r.q.QueryEnhancerFactory - Hibernate is in classpath; If applicable, HQL parser will be used. ANTLR Tool version 4.13.0 used for code generation does not match the current runtime version 4.10.1 ANTLR Runtime version 4.13.0 used for parser compilation does not match the current runtime version 4.10.1 ANTLR Tool version 4.13.0 used for code generation does not match the current runtime version 4.10.1 ANTLR Runtime version 4.13.0 used for parser compilation does not match the current runtime version 4.10.1 4332 INFO com.owlplug.host.io.LibraryLoader - Library /var/folders/kn/mr6m82qj71z_23rlxfrp4kgr0000gn/T//owlplug-host-1.4.0.dylib successfully loaded 4334 INFO c.o.core.services.NativeHostService - Native plugin loader set to owlplug-scanner 5495 INFO c.o.c.components.ApplicationMonitor - Application monitor started 5686 INFO o.s.boot.SpringApplication - Started application in 5.484 seconds (process running for 7.234) 21125 INFO c.owlplug.core.tasks.PluginSyncTask - Plugin Sync task started 24362 INFO c.owlplug.core.tasks.PluginSyncTask - 1484 plugins collected 86081 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 91684 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 112908 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output [Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 138905 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 149016 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 220093 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 287774 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 390603 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 390855 ERROR c.o.c.t.p.d.f.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.core.tasks.plugins.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.core.tasks.plugins.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:61) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:179) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 391267 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 392038 ERROR com.owlplug.host.io.LibraryLoader - No Plugin delimiter tag can be extracted from scanner output 392851 ERROR c.owlplug.core.tasks.PluginSyncTask - Plugins synchronization failed org.springframework.dao.DataIntegrityViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_COMPONENT(ID) ( /* key:0 / CAST(958 AS BIGINT), NULL, 'Fx|Dynamics', NULL, '/Library/Audio/Plug-ins/VST3/WaveShell1-VST3 14.25.vst3', 'Waves', 'Silk Vocal Live Mono', CAST('EFFECT' AS ENUM('EFFECT', 'INSTRUMENT')), '-797142074', '14.25.57.618', CAST(3506 AS BIGINT))"; SQL statement: insert into plugin_component (bundle_id,category,descriptive_name,identifier,manufacturer_name,name,plugin_id,type,uid,version,id) values (?,?,?,?,?,?,?,?,?,?,?) [23505-232]] [insert into plugin_component (bundle_id,category,descriptive_name,identifier,manufacturer_name,name,plugin_id,type,uid,version,id) values (?,?,?,?,?,?,?,?,?,?,?)]; SQL [insert into plugin_component (bundle_id,category,descriptive_name,identifier,manufacturer_name,name,plugin_id,type,uid,version,id) values (?,?,?,?,?,?,?,?,?,?,?)]; constraint [PRIMARY KEY] at org.springframework.orm.jpa.vendor.HibernateJpaDialect.convertHibernateAccessException(HibernateJpaDialect.java:290) at org.springframework.orm.jpa.vendor.HibernateJpaDialect.translateExceptionIfPossible(HibernateJpaDialect.java:241) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:566) at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:795) at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:758) at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:698) at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:416) at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.dao.support.PersistenceExceptionTranslationInterceptor.invoke(PersistenceExceptionTranslationInterceptor.java:138) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.data.jpa.repository.support.CrudMethodMetadataPostProcessor$CrudMethodMetadataPopulatingMethodInterceptor.invoke(CrudMethodMetadataPostProcessor.java:165) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:184) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:223) at jdk.proxy2/jdk.proxy2.$Proxy134.save(Unknown Source) at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:216) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: org.hibernate.exception.ConstraintViolationException: could not execute statement [Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_COMPONENT(ID) ( / key:0 / CAST(958 AS BIGINT), NULL, 'Fx|Dynamics', NULL, '/Library/Audio/Plug-ins/VST3/WaveShell1-VST3 14.25.vst3', 'Waves', 'Silk Vocal Live Mono', CAST('EFFECT' AS ENUM('EFFECT', 'INSTRUMENT')), '-797142074', '14.25.57.618', CAST(3506 AS BIGINT))"; SQL statement: insert into plugin_component (bundle_id,category,descriptive_name,identifier,manufacturer_name,name,plugin_id,type,uid,version,id) values (?,?,?,?,?,?,?,?,?,?,?) [23505-232]] [insert into plugin_component (bundle_id,category,descriptive_name,identifier,manufacturer_name,name,plugin_id,type,uid,version,id) values (?,?,?,?,?,?,?,?,?,?,?)] at org.hibernate.dialect.H2Dialect.lambda$buildSQLExceptionConversionDelegate$3(H2Dialect.java:759) at org.hibernate.exception.internal.StandardSQLExceptionConverter.convert(StandardSQLExceptionConverter.java:58) at org.hibernate.engine.jdbc.spi.SqlExceptionHelper.convert(SqlExceptionHelper.java:108) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:197) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.performNonBatchedMutation(AbstractMutationExecutor.java:134) at org.hibernate.engine.jdbc.mutation.internal.MutationExecutorSingleNonBatched.performNonBatchedOperations(MutationExecutorSingleNonBatched.java:55) at org.hibernate.engine.jdbc.mutation.internal.AbstractMutationExecutor.execute(AbstractMutationExecutor.java:55) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.doStaticInserts(InsertCoordinatorStandard.java:194) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.coordinateInsert(InsertCoordinatorStandard.java:132) at org.hibernate.persister.entity.mutation.InsertCoordinatorStandard.insert(InsertCoordinatorStandard.java:104) at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:110) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:644) at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:511) at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:414) at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:41) at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:127) at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1429) at org.hibernate.internal.SessionImpl.managedFlush(SessionImpl.java:491) at org.hibernate.internal.SessionImpl.flushBeforeTransactionCompletion(SessionImpl.java:2354) at org.hibernate.internal.SessionImpl.beforeTransactionCompletion(SessionImpl.java:1978) at org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl.beforeTransactionCompletion(JdbcCoordinatorImpl.java:439) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.beforeCompletionCallback(JdbcResourceLocalTransactionCoordinatorImpl.java:169) at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.commit(JdbcResourceLocalTransactionCoordinatorImpl.java:267) at org.hibernate.engine.transaction.internal.TransactionImpl.commit(TransactionImpl.java:101) at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:562) ... 20 common frames omitted Caused by: org.h2.jdbc.JdbcSQLIntegrityConstraintViolationException: Unique index or primary key violation: "PRIMARY KEY ON PUBLIC.PLUGIN_COMPONENT(ID) ( / key:0 */ CAST(958 AS BIGINT), NULL, 'Fx|Dynamics', NULL, '/Library/Audio/Plug-ins/VST3/WaveShell1-VST3 14.25.vst3', 'Waves', 'Silk Vocal Live Mono', CAST('EFFECT' AS ENUM('EFFECT', 'INSTRUMENT')), '-797142074', '14.25.57.618', CAST(3506 AS BIGINT))"; SQL statement: insert into plugin_component (bundle_id,category,descriptive_name,identifier,manufacturer_name,name,plugin_id,type,uid,version,id) values (?,?,?,?,?,?,?,?,?,?,?) [23505-232] at org.h2.message.DbException.getJdbcSQLException(DbException.java:520) at org.h2.message.DbException.getJdbcSQLException(DbException.java:489) at org.h2.message.DbException.get(DbException.java:223) at org.h2.message.DbException.get(DbException.java:199) at org.h2.mvstore.db.MVPrimaryIndex.add(MVPrimaryIndex.java:121) at org.h2.mvstore.db.MVTable.addRow(MVTable.java:517) at org.h2.command.dml.Insert.insertRows(Insert.java:174) at org.h2.command.dml.Insert.update(Insert.java:135) at org.h2.command.dml.DataChangeStatement.update(DataChangeStatement.java:74) at org.h2.command.CommandContainer.update(CommandContainer.java:139) at org.h2.command.Command.executeUpdate(Command.java:304) at org.h2.command.Command.executeUpdate(Command.java:248) at org.h2.jdbc.JdbcPreparedStatement.executeUpdateInternal(JdbcPreparedStatement.java:213) at org.h2.jdbc.JdbcPreparedStatement.executeUpdate(JdbcPreparedStatement.java:172) at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:194) ... 41 common frames omitted 392853 ERROR c.o.core.components.TaskRunner - Error while running task com.owlplug.core.tasks.TaskException: Plugins synchronization failed at com.owlplug.core.tasks.PluginSyncTask.start(PluginSyncTask.java:231) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source)

sixstringv avatar May 20 '25 11:05 sixstringv

@sixstringv Thank you again for all the details and your patience ! There is something deeper... My patches just lowered the probability of occurrences, but the problem remains. The good news is that I've found a way to reproduce, but I'm not ready to explain what's happening.

As you provided very valuable help, I want to put your name in the contributor list if you are ok. If yes, how do you want to appear in the list, as sixstringv, your real name, something else... ?

DropSnorz avatar May 21 '25 17:05 DropSnorz

That is good news! Good luck getting it ironed out. I wish I could do more but never got into any flavor of C, or Java, just stayed in the web side of code. Not enough hours in the day. I greatly appreciate the sentiment! It's really not necessary. Knowing I have helped in some slight way towards your excellent app you're giving away is enough. Reach out if you think I could do more, or possibly run it with different settings and collect the results. Thank you for OwlPlug.

sixstringv avatar May 22 '25 09:05 sixstringv

@sixstringv Good news ! I've finally found the root cause 🎉

I initially suspected the issue was with the OwlPlug code, but it became clear that the problem lay with the embedded H2 database used for data storage. I noticed that some inserted data was randomly disappearing, and other developers had reported similar behavior. Unfortunately, nobody manages to reproduce and provide explanations.

I spent several nights debugging the H2 code and managed to identified the root cause. As detailed in issue #322, the problem is on the database compaction logic, which can occasionally remove chunks of data that are still referenced in the database. This leads to file corruption and triggers silent rollbacks of database.

I'm waiting for the next H2 release. Thanks again for your logs and time !

DropSnorz avatar Jul 28 '25 19:07 DropSnorz

Excellent news. I really appreciate your time and look forward to the new release.

sixstringv avatar Jul 31 '25 13:07 sixstringv

@sixstringv Finally, the H2 fix is available !

I've just released OwlPlug 1.30.0, the scan should be far more stable now.

I was not able to reproduce the issue after hours of continuous intensive plugin and file scanning.

DropSnorz avatar Sep 27 '25 13:09 DropSnorz

Excellent work! Thank you! It ran for quite a while longer but alas had a problem. I tried using both with and without Native plugin discovery with the same result. Seems to be stopping on the same plugin each time, TAL-Vocoder-2.vst. Here's the log:

Oct 02, 2025 3:21:16 PM com.sun.javafx.application.PlatformImpl startup WARNING: Unsupported JavaFX configuration: classes were loaded from 'unnamed module @1d796ec' 15:21:17,580 |-INFO in ch.qos.logback.classic.LoggerContext[default] - This is logback-classic version 1.5.18 15:21:17,581 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - Here is a list of configurators discovered as a service, by rank: 15:21:17,582 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - org.springframework.boot.logging.logback.RootLogLevelConfigurator 15:21:17,582 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - They will be invoked in order until ExecutionStatus.DO_NOT_INVOKE_NEXT_IF_ANY is returned. 15:21:17,582 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - Constructed configurator of type class org.springframework.boot.logging.logback.RootLogLevelConfigurator 15:21:17,585 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - org.springframework.boot.logging.logback.RootLogLevelConfigurator.configure() call lasted 0 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 15:21:17,585 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - Trying to configure with ch.qos.logback.classic.joran.SerializedModelConfigurator 15:21:17,586 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - Constructed configurator of type class ch.qos.logback.classic.joran.SerializedModelConfigurator 15:21:17,586 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.scmo] 15:21:17,586 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.scmo] 15:21:17,586 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - ch.qos.logback.classic.joran.SerializedModelConfigurator.configure() call lasted 0 milliseconds. ExecutionStatus=INVOKE_NEXT_IF_ANY 15:21:17,586 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - Trying to configure with ch.qos.logback.classic.util.DefaultJoranConfigurator 15:21:17,587 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - Constructed configurator of type class ch.qos.logback.classic.util.DefaultJoranConfigurator 15:21:17,587 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 15:21:17,587 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml] 15:21:17,594 |-INFO in ConfigurationWatchList(mainURL=jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml, fileWatchList={}, urlWatchList=[}) - URL [jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml] is not of type file 15:21:17,671 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE] 15:21:17,671 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] 15:21:17,678 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@6d26b541 - value "/Users/sch/.owlplug/logs/owlplug.log" substituted for "${user.home}/.owlplug/logs/owlplug.log" 15:21:17,682 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@6d26b541 - value "/Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log" substituted for "${user.home}/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log" 15:21:17,686 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1115558158 - No compression will be used 15:21:17,695 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1115558158 - Will use the pattern /Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log for the active file 15:21:17,709 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@63c70968 - The date pattern is 'yyyy-MM-dd' from file name pattern '/Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log'. 15:21:17,709 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@63c70968 - Roll-over at midnight. 15:21:17,712 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@63c70968 - Setting initial period to 2025-10-02T19:19:36.838Z 15:21:17,713 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@63c70968 - Direct use of either SizeAndTimeBasedFNATP or SizeAndTimeBasedFileNamingAndTriggeringPolicy 15:21:17,713 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@63c70968 - is deprecated. Please use SizeAndTimeBasedRollingPolicy instead. 15:21:17,713 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@63c70968 - For more information see https://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy 15:21:17,715 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 15:21:17,735 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /Users/sch/.owlplug/logs/owlplug.log 15:21:17,737 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Setting currentFileLength to 98 for /Users/sch/.owlplug/logs/owlplug.log 15:21:17,737 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/Users/sch/.owlplug/logs/owlplug.log] 15:21:17,738 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [STDOUT] 15:21:17,738 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 15:21:17,739 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 15:21:17,739 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - BEWARE: Writing to the console can be very slow. Avoid logging to the 15:21:17,739 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - console in production environments, especially in high volume systems. 15:21:17,739 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also https://logback.qos.ch/codes.html#slowConsole 15:21:17,740 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [com.owlplug] to INFO 15:21:17,740 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [com.owlplug] to false 15:21:17,740 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[com.owlplug] 15:21:17,741 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[com.owlplug] 15:21:17,741 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.springframework] to INFO 15:21:17,741 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [org.springframework] to false 15:21:17,741 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[org.springframework] 15:21:17,741 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.hibernate.SQL] to INFO 15:21:17,741 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [org.hibernate.SQL] to false 15:21:17,741 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[org.hibernate.SQL] 15:21:17,741 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@7b2e8b2e - End of configuration. 15:21:17,741 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@23fab5b7 - Registering current configuration as safe fallback point 15:21:17,742 |-INFO in ch.qos.logback.classic.util.ContextInitializer@3842f6b5 - ch.qos.logback.classic.util.DefaultJoranConfigurator.configure() call lasted 154 milliseconds. ExecutionStatus=DO_NOT_INVOKE_NEXT_IF_ANY

15:21:17,975 |-INFO in ConfigurationWatchList(mainURL=jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml, fileWatchList={}, urlWatchList=[}) - URL [jar:nested:/Applications/OwlPlug.app/Contents/app/owlplug.jar/!BOOT-INF/classes/!/logback.xml] is not of type file 15:21:17,980 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [FILE] 15:21:17,980 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] 15:21:17,980 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@59f20141 - value "/Users/sch/.owlplug/logs/owlplug.log" substituted for "${user.home}/.owlplug/logs/owlplug.log" 15:21:17,980 |-INFO in ch.qos.logback.core.model.processor.ModelInterpretationContext@59f20141 - value "/Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log" substituted for "${user.home}/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log" 15:21:17,980 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1615798953 - No compression will be used 15:21:17,980 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1615798953 - Will use the pattern /Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log for the active file 15:21:17,981 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@56ac4552 - The date pattern is 'yyyy-MM-dd' from file name pattern '/Users/sch/.owlplug/logs/owlplug.%d{yyyy-MM-dd}.%i.log'. 15:21:17,981 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@56ac4552 - Roll-over at midnight. 15:21:17,981 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@56ac4552 - Setting initial period to 2025-10-02T19:19:36.838Z 15:21:17,981 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@56ac4552 - Direct use of either SizeAndTimeBasedFNATP or SizeAndTimeBasedFileNamingAndTriggeringPolicy 15:21:17,981 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@56ac4552 - is deprecated. Please use SizeAndTimeBasedRollingPolicy instead. 15:21:17,981 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFileNamingAndTriggeringPolicy@56ac4552 - For more information see https://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy 15:21:17,981 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 15:21:17,982 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file name: /Users/sch/.owlplug/logs/owlplug.log 15:21:17,982 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Setting currentFileLength to 98 for /Users/sch/.owlplug/logs/owlplug.log 15:21:17,982 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is set to [/Users/sch/.owlplug/logs/owlplug.log] 15:21:17,982 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - Processing appender named [STDOUT] 15:21:17,982 |-INFO in ch.qos.logback.core.model.processor.AppenderModelHandler - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 15:21:17,982 |-INFO in ch.qos.logback.core.model.processor.ImplicitModelHandler - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 15:21:17,982 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - BEWARE: Writing to the console can be very slow. Avoid logging to the 15:21:17,982 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - console in production environments, especially in high volume systems. 15:21:17,982 |-INFO in ch.qos.logback.core.ConsoleAppender[STDOUT] - See also https://logback.qos.ch/codes.html#slowConsole 15:21:17,982 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [com.owlplug] to INFO 15:21:17,982 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@1145031c - Propagating INFO level on Logger[com.owlplug] onto the JUL framework 15:21:17,983 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [com.owlplug] to false 15:21:17,983 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[com.owlplug] 15:21:17,983 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [FILE] to Logger[com.owlplug] 15:21:17,983 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.springframework] to INFO 15:21:17,983 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@1145031c - Propagating INFO level on Logger[org.springframework] onto the JUL framework 15:21:17,983 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [org.springframework] to false 15:21:17,983 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[org.springframework] 15:21:17,983 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting level of logger [org.hibernate.SQL] to INFO 15:21:17,983 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@1145031c - Propagating INFO level on Logger[org.hibernate.SQL] onto the JUL framework 15:21:17,983 |-INFO in ch.qos.logback.classic.model.processor.LoggerModelHandler - Setting additivity of logger [org.hibernate.SQL] to false 15:21:17,983 |-INFO in ch.qos.logback.core.model.processor.AppenderRefModelHandler - Attaching appender named [STDOUT] to Logger[org.hibernate.SQL] 15:21:17,983 |-INFO in ch.qos.logback.core.model.processor.DefaultProcessor@5874e07c - End of configuration. 15:21:17,983 |-INFO in org.springframework.boot.logging.logback.SpringBootJoranConfigurator@41b7dbb1 - Registering current configuration as safe fallback point


/ __ \ _ __ / / / _ \ / / __ __ ___ _ / // /| |/|/ / / / / / / / / // / / _ `/ _/ |,/ // // // _,/ _, / /__/

492 INFO o.s.boot.SpringApplication - Starting application using Java 21.0.8 with PID 32600 (/Applications/OwlPlug.app/Contents/app/owlplug.jar started by sch in /Users/sch/Music) 494 INFO o.s.boot.SpringApplication - No active profile set, falling back to 1 default profile: "default" 904 INFO o.s.d.r.c.RepositoryConfigurationDelegate - Bootstrapping Spring Data JPA repositories in DEFAULT mode. 980 INFO o.s.d.r.c.RepositoryConfigurationDelegate - Finished Spring Data repository scanning in 69 ms. Found 11 JPA repository interfaces. 1185 INFO c.o.c.c.RuntimePlatformResolver - Runtime Platform Resolved: RuntimePlatform [tag=mac-x64, operatingSystem=MAC, arch=x64] 1606 INFO o.s.o.j.p.SpringPersistenceUnitInfo - No LoadTimeWeaver setup: ignoring JPA class transformer 3291 INFO o.s.o.j.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default' 3580 INFO o.s.d.j.r.q.QueryEnhancerFactory - Hibernate is in classpath; If applicable, HQL parser will be used. ANTLR Tool version 4.13.0 used for code generation does not match the current runtime version 4.10.1 ANTLR Runtime version 4.13.0 used for parser compilation does not match the current runtime version 4.10.1 ANTLR Tool version 4.13.0 used for code generation does not match the current runtime version 4.10.1 ANTLR Runtime version 4.13.0 used for parser compilation does not match the current runtime version 4.10.1 3971 INFO com.owlplug.host.io.LibraryLoader - Library /var/folders/kn/mr6m82qj71z_23rlxfrp4kgr0000gn/T//owlplug-host-1.4.0.dylib successfully loaded 3972 INFO c.o.p.services.NativeHostService - Native plugin loader set to owlplug-scanner 4635 INFO c.o.c.components.ApplicationMonitor - Application monitor started 4832 INFO o.s.boot.SpringApplication - Started application in 4.599 seconds (process running for 6.314) 9126 ERROR c.o.plugin.services.UpdateService - Error retrieving latest owlplug version org.springframework.web.client.ResourceAccessException: I/O error on GET request for "http://hub.owlplug.com/releases/latest/version.json": hub.owlplug.com at org.springframework.web.client.RestTemplate.createResourceAccessException(RestTemplate.java:926) at org.springframework.web.client.RestTemplate.doExecute(RestTemplate.java:906) at org.springframework.web.client.RestTemplate.execute(RestTemplate.java:801) at org.springframework.web.client.RestTemplate.getForObject(RestTemplate.java:415) at com.owlplug.plugin.services.UpdateService.getLastVersion(UpdateService.java:58) at com.owlplug.plugin.services.UpdateService.isUpToDate(UpdateService.java:42) at com.owlplug.core.controllers.MainController$1.call(MainController.java:162) at com.owlplug.core.controllers.MainController$1.call(MainController.java:159) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: java.net.UnknownHostException: hub.owlplug.com at java.base/sun.nio.ch.NioSocketImpl.connect(Unknown Source) at java.base/java.net.Socket.connect(Unknown Source) at java.base/java.net.Socket.connect(Unknown Source) at java.base/sun.net.NetworkClient.doConnect(Unknown Source) at java.base/sun.net.www.http.HttpClient.openServer(Unknown Source) at java.base/sun.net.www.http.HttpClient.openServer(Unknown Source) at java.base/sun.net.www.http.HttpClient.(Unknown Source) at java.base/sun.net.www.http.HttpClient.New(Unknown Source) at java.base/sun.net.www.http.HttpClient.New(Unknown Source) at java.base/sun.net.www.protocol.http.HttpURLConnection.getNewHttpClient(Unknown Source) at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect0(Unknown Source) at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect(Unknown Source) at java.base/sun.net.www.protocol.http.HttpURLConnection.connect(Unknown Source) at org.springframework.http.client.SimpleClientHttpRequest.executeInternal(SimpleClientHttpRequest.java:79) at org.springframework.http.client.AbstractStreamingClientHttpRequest.executeInternal(AbstractStreamingClientHttpRequest.java:71) at org.springframework.http.client.AbstractClientHttpRequest.execute(AbstractClientHttpRequest.java:81) at org.springframework.web.client.RestTemplate.doExecute(RestTemplate.java:900) ... 9 common frames omitted 56863 INFO c.o.plugin.tasks.PluginSyncTask - Plugin Sync task started 60735 INFO c.o.plugin.tasks.PluginSyncTask - 1489 plugins collected [Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 112895 ERROR c.o.p.t.d.fileformats.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.plugin.tasks.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.plugin.tasks.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:60) at com.owlplug.plugin.tasks.PluginSyncTask.start(PluginSyncTask.java:182) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 189861 ERROR c.o.p.t.d.fileformats.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.plugin.tasks.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.plugin.tasks.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:60) at com.owlplug.plugin.tasks.PluginSyncTask.start(PluginSyncTask.java:182) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :30:5: The element type "string" must be terminated by the matching end-tag "". 190907 ERROR c.o.p.t.d.fileformats.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: The element type "string" must be terminated by the matching end-tag "". at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.plugin.tasks.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.plugin.tasks.discovery.fileformats.Vst3BundleFile.toPlugin(Vst3BundleFile.java:60) at com.owlplug.plugin.tasks.PluginSyncTask.start(PluginSyncTask.java:182) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) [Fatal Error] :33:28: An invalid XML character (Unicode: 0x12) was found in the element content of the document. 340138 ERROR c.o.p.t.d.fileformats.OsxPlistFile - Error while binding plugin properties from Plist file org.xml.sax.SAXParseException: An invalid XML character (Unicode: 0x12) was found in the element content of the document. at java.xml/com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(Unknown Source) at java.xml/com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(Unknown Source) at java.xml/javax.xml.parsers.DocumentBuilder.parse(Unknown Source) at com.dd.plist.XMLPropertyListParser.parse(XMLPropertyListParser.java:178) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:251) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:209) at com.dd.plist.PropertyListParser.parse(PropertyListParser.java:192) at com.owlplug.plugin.tasks.discovery.fileformats.OsxPlistFile.bindProperties(OsxPlistFile.java:49) at com.owlplug.plugin.tasks.discovery.fileformats.OsxVstFile.toPlugin(OsxVstFile.java:55) at com.owlplug.plugin.tasks.PluginSyncTask.start(PluginSyncTask.java:182) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 406289 INFO c.o.plugin.tasks.PluginSyncTask - Plugin Sync task complete 406289 INFO c.o.plugin.tasks.PluginSyncTask - Task Sync Plugins completed in 5m49s. 409616 INFO c.o.project.tasks.PluginLookupTask - Task Lookup DAW Plugins completed in 0m0s. 409640 INFO c.owlplug.plugin.tasks.FileSyncTask - Starting file sync task on directory /Library/Audio/Plug-ins/VST3 3418149 INFO c.owlplug.plugin.tasks.FileSyncTask - Completed file sync task on directory /Library/Audio/Plug-ins/VST3, computed length: 35574158409 3418149 INFO c.owlplug.plugin.tasks.FileSyncTask - Starting file sync task on directory /Library/Audio/Plug-ins/VST 4009868 ERROR c.owlplug.plugin.tasks.FileSyncTask - An error occurred during file sync task execution java.lang.NullPointerException: Cannot read the array length because "" is null at com.owlplug.plugin.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:98) at com.owlplug.plugin.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111) at com.owlplug.plugin.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111) at com.owlplug.plugin.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111) at com.owlplug.plugin.tasks.FileSyncTask.start(FileSyncTask.java:65) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) 4009869 ERROR c.o.core.components.TaskRunner - Error while running task com.owlplug.core.tasks.TaskException: java.lang.NullPointerException: Cannot read the array length because "" is null at com.owlplug.plugin.tasks.FileSyncTask.start(FileSyncTask.java:71) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:51) at com.owlplug.core.tasks.AbstractTask.call(AbstractTask.java:28) at javafx.concurrent.Task$TaskCallable.call(Task.java:1399) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) at java.base/java.util.concurrent.FutureTask.run(Unknown Source) at java.base/java.lang.Thread.run(Unknown Source) Caused by: java.lang.NullPointerException: Cannot read the array length because "" is null at com.owlplug.plugin.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:98) at com.owlplug.plugin.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111) at com.owlplug.plugin.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111) at com.owlplug.plugin.tasks.FileSyncTask.extractFolderSize(FileSyncTask.java:111) at com.owlplug.plugin.tasks.FileSyncTask.start(FileSyncTask.java:65) ... 7 common frames omitted 5160305 INFO c.o.c.components.ApplicationMonitor - Application monitor received shutdown event 5160352 INFO o.s.o.j.LocalContainerEntityManagerFactoryBean - Closing JPA EntityManagerFactory for persistence unit 'default'

sixstringv avatar Oct 02 '25 20:10 sixstringv

Hi @sixstringv ! Oh, that's bad error handling on OwlPlug side. This time I have no one else to blame but me 😆

Thanks for your feedback. I've created issue #376 , this should be quickly fixed.

DropSnorz avatar Oct 02 '25 21:10 DropSnorz

Hello @sixstringv, I've published a fix in OwlPlug 1.30.1

DropSnorz avatar Oct 05 '25 12:10 DropSnorz

YES!!! It ran to completion. Awesome job! Thank you for all of your hard work.

sixstringv avatar Oct 05 '25 21:10 sixstringv

Thanks again for all your time and tests ! You helped OwlPlug (and h2 project) to move forward !

As you provided very valuable help, I want to put your name in the contributor list if you are ok. If yes, how do you want to appear in the list, as sixstringv, your real name, something else... ?

If you change your mind on this at any time, don't hesitate to reach me 🙌

DropSnorz avatar Oct 06 '25 18:10 DropSnorz