Message Title

I’m experiencing an eerily similar issue with both 5.3.9 and 5.3.13, which was /not/ experienced with 5.1.

Hibernate itself has no issue inserting new rows:

 
                                                                20200108:175931.764 DEBUG [                 SQL]
    select
        next value for dbo.seq_configuration_feature_id
20200108:175931.769 DEBUG [                 SQL]
    /* insert com.REDACTED.entities.ConfigurationFeature
        */ insert
        into
            dbo.configuration_features
            (feature_id, value, configuration_id, configuration_feature_id)
        values
            (?, ?, ?, ?)
20200108:175931.769 TRACE [         BasicBinder] binding parameter [1] as [BIGINT] - [38]
20200108:175931.769 TRACE [         BasicBinder] binding parameter [2] as [VARCHAR] - [SOME_TEXT]
20200108:175931.770 TRACE [         BasicBinder] binding parameter [3] as [BIGINT] - [3]
20200108:175931.770 TRACE [         BasicBinder] binding parameter [4] as [BIGINT] - [82] 
                                                            

Now, Envers enters the scene as it attempts to audit. Revision is created:

 
                                                                20200108:175931.775 DEBUG [                 SQL]
    select
        next value for dbo.seq_rev
20200108:175931.777 DEBUG [                 SQL]
    /* insert com.REDACTED.entities.Revinfo
        */ insert
        into
            dbo.revinfo
            (timestamp, user_id, rev)
        values
            (?, ?, ?)
20200108:175931.778 TRACE [         BasicBinder] binding parameter [1] as [TIMESTAMP] - [Wed Jan 08 17:59:31 UTC 2020]
20200108:175931.778 TRACE [         BasicBinder] binding parameter [2] as [BIGINT] - [0]
20200108:175931.778 TRACE [         BasicBinder] binding parameter [3] as [BIGINT] - [59] 
                                                            

Then... oddity when trying to create an audit entry for the above entity change (new/insert):

 
                                                                20200108:175931.781 DEBUG [                 SQL]
    /* insert com.REDACTED.entities.ConfigurationFeature_aud
        */ insert
        into
            dbo.configuration_features_aud
            (revtype, value, feature_id, configuration_id, configuration_feature_id, rev)
        values
            (?, ?, ?, ?, ?, ?)
20200108:175931.781 TRACE [         BasicBinder] binding parameter [1] as [INTEGER] - [0]
20200108:175931.781 TRACE [         BasicBinder] binding parameter [2] as [VARCHAR] - [SOME_TEXT]
20200108:175931.781 TRACE [         BasicBinder] binding parameter [3] as [BIGINT] - [Feature [id=38, name=NAME_OF_THE_FEATURE]]
20200108:175931.782 ERROR [    AssertionFailure] HHH000099: an assertion failure occurred (this may indicate a bug in Hibernate, but is more likely due to unsafe use of the session): java.lang.ClassCastException: com.REDACTED.entities.Feature cannot be cast to java.lang.Long
..
Caused by: java.lang.ClassCastException: com.REDACTED.entities.Feature cannot be cast to java.lang.Long
        at org.hibernate.type.descriptor.java.LongTypeDescriptor.unwrap(LongTypeDescriptor.java:19)
        at org.hibernate.type.descriptor.sql.BigIntTypeDescriptor$1.doBind(BigIntTypeDescriptor.java:46)
        at org.hibernate.type.descriptor.sql.BasicBinder.bind(BasicBinder.java:74)
        at org.hibernate.type.AbstractStandardBasicType.nullSafeSet(AbstractStandardBasicType.java:276)
        at org.hibernate.type.AbstractStandardBasicType.nullSafeSet(AbstractStandardBasicType.java:271)
        at org.hibernate.type.AbstractSingleColumnStandardBasicType.nullSafeSet(AbstractSingleColumnStandardBasicType.java:39)
        at org.hibernate.persister.entity.AbstractEntityPersister.dehydrate(AbstractEntityPersister.java:2871)
        at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:3165)
        at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:3688)
        at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:90)
        at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:604)
        at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:478)
        at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:356)
        at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:39)
        at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1453)
        at org.hibernate.internal.SessionImpl.flush(SessionImpl.java:1439)
        at org.hibernate.envers.internal.synchronization.AuditProcess.doBeforeTransactionCompletion(AuditProcess.java:177)
        at org.hibernate.envers.internal.synchronization.AuditProcessManager$1.doBeforeTransactionCompletion(AuditProcessManager.java:47)
        at org.hibernate.engine.spi.ActionQueue$BeforeTransactionCompletionProcessQueue.beforeTransactionCompletion(ActionQueue.java:954)
        ... 117 more 
                                                            

Updates to entities do not have this issue:

 
                                                                20200108:183826.414 DEBUG [                 SQL]
    /* update
        com.REDACTED.entities.ConfigurationFeature */ update
            dbo.configuration_features
        set
            feature_id=?,
            value=?,
            configuration_id=?
        where
            configuration_feature_id=?
20200108:183826.414 TRACE [         BasicBinder] binding parameter [1] as [BIGINT] - [3]
20200108:183826.414 TRACE [         BasicBinder] binding parameter [2] as [VARCHAR] - [CAKEPLZ]
20200108:183826.414 TRACE [         BasicBinder] binding parameter [3] as [BIGINT] - [3]
20200108:183826.414 TRACE [         BasicBinder] binding parameter [4] as [BIGINT] - [19]
20200108:183826.420 DEBUG [                 SQL]
    select
        next value for dbo.seq_rev
20200108:183826.421 DEBUG [                 SQL]
    /* insert com.REDACTED.entities.Revinfo
        */ insert
        into
            dbo.revinfo
            (timestamp, user_id, rev)
        values
            (?, ?, ?)
20200108:183826.422 TRACE [         BasicBinder] binding parameter [1] as [TIMESTAMP] - [Wed Jan 08 18:38:26 UTC 2020]
20200108:183826.422 TRACE [         BasicBinder] binding parameter [2] as [BIGINT] - [0]
20200108:183826.422 TRACE [         BasicBinder] binding parameter [3] as [BIGINT] - [62]
20200108:183826.423 DEBUG [                 SQL]
    /* insert com.REDACTED.entities.ConfigurationFeature_aud
        */ insert
        into
            dbo.configuration_features_aud
            (revtype, value, feature_id, configuration_id, configuration_feature_id, rev)
        values
            (?, ?, ?, ?, ?, ?)
20200108:183826.423 TRACE [         BasicBinder] binding parameter [1] as [INTEGER] - [1]
20200108:183826.423 TRACE [         BasicBinder] binding parameter [2] as [VARCHAR] - [CAKEPLZ]
20200108:183826.423 TRACE [         BasicBinder] binding parameter [3] as [BIGINT] - [3]
20200108:183826.423 TRACE [         BasicBinder] binding parameter [4] as [BIGINT] - [3]
20200108:183826.423 TRACE [         BasicBinder] binding parameter [5] as [BIGINT] - [19]
20200108:183826.423 TRACE [         BasicBinder] binding parameter [6] as [BIGINT] - [62]
 
                                                            

Add Comment

Get Jira notifications on your phone! Download the Jira Cloud app for Android or iOS

This message was sent by Atlassian Jira