Console Output

Started calculate disk usage of build
Finished Calculation of disk usage of build in 0 seconds
Started calculate disk usage of workspace
Finished Calculation of disk usage of workspace in 0 seconds
[INFO] 
[INFO] ---------------< it.tidalwave.solidblue3:solidblue3-dao >---------------
[INFO] Building SolidBlue III :: Dao 1.1-SNAPSHOT                         [5/6]
[INFO]   from modules/Dao/pom.xml
[INFO] --------------------------------[ jar ]---------------------------------
[INFO] 
[INFO] --- clean:3.2.0:clean (default-clean) @ solidblue3-dao ---
[INFO] 
[INFO] --- buildnumber:3.0.0:create (default) @ solidblue3-dao ---
[INFO] ShortRevision tag detected. The value is '12'.
[INFO] Executing: /bin/sh -c cd '/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao' && 'git' 'rev-parse' '--verify' '--short=12' 'HEAD'
[INFO] Working directory: /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao
[INFO] Storing buildNumber: 9990138857e0 at timestamp: 1682571500710
[WARNING] Cannot get the branch information from the git repository: 
Detecting the current branch failed: fatal: ref HEAD is not a symbolic ref

[INFO] ShortRevision tag detected. The value is '12'.
[INFO] Executing: /bin/sh -c cd '/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao' && 'git' 'rev-parse' '--verify' '--short=12' 'HEAD'
[INFO] Working directory: /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao
[INFO] Storing buildScmBranch: UNKNOWN
[INFO] 
[INFO] --- enforcer:3.3.0:enforce (enforce-maven) @ solidblue3-dao ---
[INFO] Rule 0: org.apache.maven.enforcer.rules.dependency.DependencyConvergence passed
[INFO] Rule 3: org.apache.maven.enforcer.rules.RequirePluginVersions passed
[INFO] 
[INFO] --- enforcer:3.3.0:enforce (enforce-banned-dependencies) @ solidblue3-dao ---
[INFO] Rule 0: org.apache.maven.enforcer.rules.dependency.BannedDependencies passed
[INFO] 
[INFO] --- antrun:3.1.0:run (generate-and-print-build-description) @ solidblue3-dao ---
[INFO] Executing tasks
[INFO]      [echo] DESCRIPTION: origin/master 1.1-SNAPSHOT 9990138857e0
[INFO]      [echo] Java Version: 17.0.6 -source 17 -target 17 -release 17
[INFO] Executed tasks
[INFO] 
[INFO] --- jacoco:0.8.9:prepare-agent (prepare-agent) @ solidblue3-dao ---
[INFO] tft.test.jacoco.argLine set to -javaagent:/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace@tmp/repository/org/jacoco/org.jacoco.agent/0.8.9/org.jacoco.agent-0.8.9-runtime.jar=destfile=/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/jacoco.exec
[INFO] 
[INFO] --- resources:3.3.1:resources (default-resources) @ solidblue3-dao ---
[INFO] Copying 2 resources from src/main/resources to target/classes
[INFO] 
[INFO] --- compiler:3.11.0:compile (default-compile) @ solidblue3-dao ---
[INFO] Changes detected - recompiling the module! :dependency
[INFO] Compiling 4 source files with javac [forked debug deprecation release 17] to target/classes
[WARNING] No processor claimed any of these annotations: /jakarta.persistence.OrderBy,/jakarta.persistence.Column,/jakarta.persistence.OneToMany,/jakarta.persistence.Table,/jakarta.persistence.Entity,/org.springframework.stereotype.Component,/jakarta.annotation.Nonnull,/org.hibernate.annotations.Cascade,/jakarta.transaction.Transactional,/edu.umd.cs.findbugs.annotations.SuppressFBWarnings,/jakarta.persistence.Id
[INFO] 
[INFO] --- resources:3.3.1:testResources (default-testResources) @ solidblue3-dao ---
[INFO] Copying 2 resources from src/test/resources to target/test-classes
[INFO] 
[INFO] --- compiler:3.11.0:testCompile (default-testCompile) @ solidblue3-dao ---
[INFO] Changes detected - recompiling the module! :dependency
[INFO] Compiling 5 source files with javac [forked debug deprecation release 17] to target/test-classes
[INFO] 
[INFO] --- surefire:3.0.0:test (default-test) @ solidblue3-dao ---
[INFO] Using auto detected provider org.apache.maven.surefire.testng.TestNGProvider
[INFO] 
[INFO] -------------------------------------------------------
[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running TestSuite
04:58:45.916 [main                ] INFO  o.s.t.c.support.AnnotationConfigContextLoaderUtils - Could not detect default configuration classes for test class [it.tidalwave.datamanager.dao.impl.jpa.FingerprintEntityTest]: FingerprintEntityTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
04:58:46.743 [main                ] INFO  o.s.b.t.context.SpringBootTestContextBootstrapper  - Found @SpringBootConfiguration it.tidalwave.datamanager.dao.impl.jpa.TestConfiguration for test class it.tidalwave.datamanager.dao.impl.jpa.FingerprintEntityTest
04:58:47.252 [main                ] INFO  o.s.t.c.support.AnnotationConfigContextLoaderUtils - Could not detect default configuration classes for test class [it.tidalwave.datamanager.dao.impl.jpa.JpaDataManagerDaoTest]: JpaDataManagerDaoTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
04:58:47.276 [main                ] INFO  o.s.b.t.context.SpringBootTestContextBootstrapper  - Found @SpringBootConfiguration it.tidalwave.datamanager.dao.impl.jpa.TestConfiguration for test class it.tidalwave.datamanager.dao.impl.jpa.JpaDataManagerDaoTest
04:58:47.372 [main                ] INFO  o.s.t.c.support.AnnotationConfigContextLoaderUtils - Could not detect default configuration classes for test class [it.tidalwave.datamanager.dao.impl.jpa.ManagedFileEntityTest]: ManagedFileEntityTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
04:58:47.382 [main                ] INFO  o.s.b.t.context.SpringBootTestContextBootstrapper  - Found @SpringBootConfiguration it.tidalwave.datamanager.dao.impl.jpa.TestConfiguration for test class it.tidalwave.datamanager.dao.impl.jpa.ManagedFileEntityTest
04:58:47.579 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - STARTING TESTS OF it.tidalwave.datamanager.dao.impl.jpa.FingerprintEntityTest

  .   ____          _            __ _ _
 /\\ / ___'_ __ _ _(_)_ __  __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
 \\/  ___)| |_)| | | | | || (_| |  ) ) ) )
  '  |____| .__|_| |_|_| |_\__, | / / / /
 =========|_|==============|___/=/_/_/_/
 :: Spring Boot ::                (v3.0.5)

04:58:51.159 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Starting FingerprintEntityTest using Java 17.0.6 with PID 647404 (/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/test-classes started by jenkins in /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao)
04:58:51.160 [main                ] DEBUG i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Running with Spring Boot v3.0.5, Spring v6.0.7
04:58:51.169 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - The following 1 profile is active: "test"
04:58:51.251 [main                ] TRACE o.s.boot.context.config.ConfigDataLoaders          - Loading file [.] using loader org.springframework.boot.context.config.StandardConfigDataLoader
04:58:51.251 [main                ] TRACE o.s.boot.context.config.ConfigDataLoaders          - Loading class path resource [config/module-test.yml] using loader org.springframework.boot.context.config.StandardConfigDataLoader
04:58:51.251 [main                ] TRACE o.s.boot.context.config.ConfigDataLoaders          - Loading class path resource [config/module.yml] using loader org.springframework.boot.context.config.StandardConfigDataLoader
04:58:52.989 [main                ] INFO  o.s.d.r.config.RepositoryConfigurationDelegate     - Bootstrapping Spring Data JPA repositories in DEFAULT mode.
04:58:53.288 [main                ] INFO  o.s.d.r.config.RepositoryConfigurationDelegate     - Finished Spring Data repository scanning in 235 ms. Found 1 JPA repository interfaces.
04:58:55.524 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - Driver class com.p6spy.engine.spy.P6SpyDriver found in Thread context class loader jdk.internal.loader.ClassLoaders$AppClassLoader@251a69d7
04:58:55.938 [main                ] DEBUG org.jboss.logging                                  - Logging Provider: org.jboss.logging.Slf4jLoggerProvider found via system property
04:58:56.277 [main                ] INFO  org.hibernate.jpa.internal.util.LogHelper          - HHH000204: Processing PersistenceUnitInfo [name: default]
04:58:56.778 [main                ] INFO  org.hibernate.Version                              - HHH000412: Hibernate ORM core version 6.1.7.Final
04:58:59.154 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - HikariPool-1 - configuration:
04:58:59.186 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - allowPoolSuspension.............false
04:58:59.187 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - autoCommit......................true
04:58:59.187 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - catalog.........................none
04:58:59.188 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - connectionInitSql...............none
04:58:59.198 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - connectionTestQuery.............none
04:58:59.198 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - connectionTimeout...............30000
04:58:59.199 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - dataSource......................none
04:58:59.199 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - dataSourceClassName.............none
04:58:59.199 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - dataSourceJNDI..................none
04:58:59.200 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - dataSourceProperties............{password=<masked>}
04:58:59.200 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - driverClassName................."com.p6spy.engine.spy.P6SpyDriver"
04:58:59.200 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - exceptionOverrideClassName......none
04:58:59.201 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - healthCheckProperties...........{}
04:58:59.201 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - healthCheckRegistry.............none
04:58:59.201 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - idleTimeout.....................600000
04:58:59.201 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - initializationFailTimeout.......1
04:58:59.201 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - isolateInternalQueries..........false
04:58:59.202 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - jdbcUrl.........................jdbc:p6spy:sqlite:target/test1.db
04:58:59.202 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - keepaliveTime...................0
04:58:59.214 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - leakDetectionThreshold..........0
04:58:59.215 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - maxLifetime.....................1800000
04:58:59.215 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - maximumPoolSize.................10
04:58:59.215 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - metricRegistry..................none
04:58:59.215 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - metricsTrackerFactory...........none
04:58:59.216 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - minimumIdle.....................10
04:58:59.216 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - password........................<masked>
04:58:59.216 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - poolName........................"HikariPool-1"
04:58:59.216 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - readOnly........................false
04:58:59.217 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - registerMbeans..................false
04:58:59.217 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - scheduledExecutor...............none
04:58:59.217 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - schema..........................none
04:58:59.217 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - threadFactory...................internal
04:58:59.217 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - transactionIsolation............default
04:58:59.217 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - username........................none
04:58:59.218 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - validationTimeout...............5000
04:58:59.218 [main                ] INFO  com.zaxxer.hikari.HikariDataSource                 - HikariPool-1 - Starting...
04:59:00.601 [main                ] INFO  com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@48a2fb11
04:59:00.605 [main                ] INFO  com.zaxxer.hikari.HikariDataSource                 - HikariPool-1 - Start completed.
04:59:00.706 [riPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Pool stats (total=1, active=1, idle=0, waiting=0)
04:59:00.730 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@7e256e5b
04:59:00.741 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@70e29fef
04:59:00.753 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@74dd052b
04:59:00.764 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@31df95d4
04:59:00.775 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@64dd6202
04:59:00.787 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@248491
04:59:00.798 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@1ccc2de3
04:59:00.810 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@51f06a9b
04:59:00.835 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@5e32dfd5
04:59:00.836 [main                ] INFO  SQL dialect                                        - HHH000400: Using dialect: org.hibernate.community.dialect.SQLiteDialect
04:59:00.846 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-1 - After adding stats (total=10, active=1, idle=9, waiting=0)
Hibernate: drop table if exists files
04:59:06.664 [main                ] INFO  p6spy                                              - SQL: 13 nanos - drop table if exists files
Hibernate: drop table if exists fingerprints
04:59:06.668 [main                ] INFO  p6spy                                              - SQL: 0 nanos - drop table if exists fingerprints
Hibernate: create table files (id varchar(36) not null, path text not null, primary key (id))
04:59:06.752 [main                ] INFO  p6spy                                              - SQL: 57 nanos - create table files (id varchar(36) not null, path text not null, primary key (id))
Hibernate: create table fingerprints (id varchar(36) not null, algorithm varchar(16) not null, file_id varchar(36) not null, name text not null, timestamp timestamp not null, fingerprint varchar(32) not null, primary key (id))
04:59:06.804 [main                ] INFO  p6spy                                              - SQL: 50 nanos - create table fingerprints (id varchar(36) not null, algorithm varchar(16) not null, file_id varchar(36) not null, name text not null, timestamp timestamp not null, fingerprint varchar(32) not null, primary key (id))
04:59:06.807 [main                ] INFO  o.h.e.t.jta.platform.internal.JtaPlatformInitiator - HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
04:59:06.862 [main                ] INFO  o.s.orm.jpa.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default'
04:59:08.935 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Started FingerprintEntityTest in 20.949 seconds (process running for 28.884)
04:59:09.057 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.datamanager.dao.impl.jpa.FingerprintEntityTest.test_equals_and_hashcode]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:09.074 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:09.075 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(190995200<open>)] for JPA transaction
04:59:09.105 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@4a9f02f4]
04:59:10.128 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - *******************************
04:59:10.135 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - TEST "test equals and hashcode"
04:59:10.135 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - *******************************
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:10.427 [main                ] INFO  p6spy                                              - SQL: 1 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('', '', '', '2023-04-27T04:59:10.156+0000', '', 'id')
04:59:10.508 [main                ] INFO  p6spy                                              - SQL: 55 nanos - 
Hibernate: select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id=?
04:59:10.763 [main                ] INFO  p6spy                                              - SQL: 13 nanos - select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id='id'
04:59:10.859 [main                ] INFO  p6spy                                              - SQL: 12 nanos - 
Hibernate: select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id=?
04:59:10.868 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id='id'
04:59:10.870 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id=?
04:59:10.890 [main                ] INFO  p6spy                                              - SQL: 1 nanos - select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id='id'
Hibernate: update fingerprints set algorithm=?, file_id=?, name=?, timestamp=?, fingerprint=? where id=?
04:59:10.898 [main                ] INFO  p6spy                                              - SQL: 0 nanos - update fingerprints set algorithm='', file_id='', name='', timestamp='2023-04-27T04:59:10.156+0000', fingerprint='' where id='id'
04:59:10.900 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id=?
04:59:10.903 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id='id'
Hibernate: update fingerprints set algorithm=?, file_id=?, name=?, timestamp=?, fingerprint=? where id=?
04:59:10.905 [main                ] INFO  p6spy                                              - SQL: 0 nanos - update fingerprints set algorithm='', file_id='', name='', timestamp='2023-04-27T04:59:10.156+0000', fingerprint='' where id='id'
04:59:10.905 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id=?
04:59:10.908 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id='id'
04:59:10.909 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id=?
04:59:10.911 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id='id'
04:59:10.912 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id=?
04:59:10.916 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.id,f1_0.algorithm,f1_0.file_id,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.id='id'
Hibernate: delete from fingerprints where id=?
04:59:10.919 [main                ] INFO  p6spy                                              - SQL: 0 nanos - delete from fingerprints where id='id'
04:59:10.973 [main                ] INFO  p6spy                                              - SQL: 52 nanos - 
04:59:10.981 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - TEST PASSED in 848 msec
04:59:10.981 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - 
04:59:10.992 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
04:59:10.993 [main                ] WARN  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
04:59:10.993 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(190995200<open>)]
04:59:10.993 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:10.995 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(190995200<open>)] after transaction

  .   ____          _            __ _ _
 /\\ / ___'_ __ _ _(_)_ __  __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
 \\/  ___)| |_)| | | | | || (_| |  ) ) ) )
  '  |____| .__|_| |_|_| |_\__, | / / / /
 =========|_|==============|___/=/_/_/_/
 :: Spring Boot ::                (v3.0.5)

04:59:11.120 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Starting JpaDataManagerDaoTest using Java 17.0.6 with PID 647404 (/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/test-classes started by jenkins in /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao)
04:59:11.120 [main                ] DEBUG i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Running with Spring Boot v3.0.5, Spring v6.0.7
04:59:11.120 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - No active profile set, falling back to 1 default profile: "default"
04:59:11.139 [main                ] TRACE o.s.boot.context.config.ConfigDataLoaders          - Loading file [.] using loader org.springframework.boot.context.config.StandardConfigDataLoader
04:59:11.139 [main                ] TRACE o.s.boot.context.config.ConfigDataLoaders          - Loading class path resource [config/module-test.yml] using loader org.springframework.boot.context.config.StandardConfigDataLoader
04:59:11.140 [main                ] TRACE o.s.boot.context.config.ConfigDataLoaders          - Loading class path resource [config/module.yml] using loader org.springframework.boot.context.config.StandardConfigDataLoader
04:59:11.540 [main                ] INFO  o.s.d.r.config.RepositoryConfigurationDelegate     - Bootstrapping Spring Data JPA repositories in DEFAULT mode.
04:59:11.603 [main                ] INFO  o.s.d.r.config.RepositoryConfigurationDelegate     - Finished Spring Data repository scanning in 62 ms. Found 1 JPA repository interfaces.
04:59:11.884 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - Driver class com.p6spy.engine.spy.P6SpyDriver found in Thread context class loader jdk.internal.loader.ClassLoaders$AppClassLoader@251a69d7
04:59:12.087 [main                ] INFO  org.hibernate.jpa.internal.util.LogHelper          - HHH000204: Processing PersistenceUnitInfo [name: default]
04:59:12.135 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - HikariPool-2 - configuration:
04:59:12.142 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - allowPoolSuspension.............false
04:59:12.143 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - autoCommit......................true
04:59:12.143 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - catalog.........................none
04:59:12.149 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - connectionInitSql...............none
04:59:12.150 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - connectionTestQuery.............none
04:59:12.150 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - connectionTimeout...............30000
04:59:12.150 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - dataSource......................none
04:59:12.160 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - dataSourceClassName.............none
04:59:12.160 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - dataSourceJNDI..................none
04:59:12.160 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - dataSourceProperties............{password=<masked>}
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - driverClassName................."com.p6spy.engine.spy.P6SpyDriver"
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - exceptionOverrideClassName......none
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - healthCheckProperties...........{}
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - healthCheckRegistry.............none
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - idleTimeout.....................600000
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - initializationFailTimeout.......1
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - isolateInternalQueries..........false
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - jdbcUrl.........................jdbc:p6spy:sqlite:target/test1.db
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - keepaliveTime...................0
04:59:12.161 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - leakDetectionThreshold..........0
04:59:12.162 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - maxLifetime.....................1800000
04:59:12.162 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - maximumPoolSize.................10
04:59:12.162 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - metricRegistry..................none
04:59:12.162 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - metricsTrackerFactory...........none
04:59:12.162 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - minimumIdle.....................10
04:59:12.162 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - password........................<masked>
04:59:12.162 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - poolName........................"HikariPool-2"
04:59:12.167 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - readOnly........................false
04:59:12.168 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - registerMbeans..................false
04:59:12.168 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - scheduledExecutor...............none
04:59:12.168 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - schema..........................none
04:59:12.168 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - threadFactory...................internal
04:59:12.168 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - transactionIsolation............default
04:59:12.168 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - username........................none
04:59:12.168 [main                ] DEBUG com.zaxxer.hikari.HikariConfig                     - validationTimeout...............5000
04:59:12.171 [main                ] INFO  com.zaxxer.hikari.HikariDataSource                 - HikariPool-2 - Starting...
04:59:12.180 [main                ] INFO  com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@3265e21a
04:59:12.181 [main                ] INFO  com.zaxxer.hikari.HikariDataSource                 - HikariPool-2 - Start completed.
04:59:12.182 [main                ] INFO  SQL dialect                                        - HHH000400: Using dialect: org.hibernate.community.dialect.SQLiteDialect
04:59:12.281 [riPool-2 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Pool stats (total=1, active=0, idle=1, waiting=0)
04:59:12.297 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@461126c3
04:59:12.318 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@48d6d071
04:59:12.329 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@4ce94db3
04:59:12.340 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@9ebda4a
04:59:12.351 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@4603d28a
04:59:12.362 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@3828d763
04:59:12.374 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@3e2a8100
04:59:12.385 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@69c42505
04:59:12.396 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@310b3d35
Hibernate: drop table if exists files
04:59:12.407 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool                  - HikariPool-2 - After adding stats (total=10, active=1, idle=9, waiting=0)
04:59:12.491 [main                ] INFO  p6spy                                              - SQL: 84 nanos - drop table if exists files
Hibernate: drop table if exists fingerprints
04:59:12.559 [main                ] INFO  p6spy                                              - SQL: 67 nanos - drop table if exists fingerprints
Hibernate: create table files (id varchar(36) not null, path text not null, primary key (id))
04:59:12.625 [main                ] INFO  p6spy                                              - SQL: 65 nanos - create table files (id varchar(36) not null, path text not null, primary key (id))
Hibernate: create table fingerprints (id varchar(36) not null, algorithm varchar(16) not null, file_id varchar(36) not null, name text not null, timestamp timestamp not null, fingerprint varchar(32) not null, primary key (id))
04:59:12.689 [main                ] INFO  p6spy                                              - SQL: 62 nanos - create table fingerprints (id varchar(36) not null, algorithm varchar(16) not null, file_id varchar(36) not null, name text not null, timestamp timestamp not null, fingerprint varchar(32) not null, primary key (id))
04:59:12.690 [main                ] INFO  o.h.e.t.jta.platform.internal.JtaPlatformInitiator - HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
04:59:12.690 [main                ] INFO  o.s.orm.jpa.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default'
04:59:13.011 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Started JpaDataManagerDaoTest in 1.987 seconds (process running for 32.96)
04:59:13.048 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - ****************************
04:59:13.048 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - TEST "test findManagedFiles"
04:59:13.048 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - ****************************
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.228 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/e047', '00000000-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.246 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000000-0000-0000-0000-000000000000', 'e047', '2020-07-27T07:30:09.000+0000', '80fe035fe88f37471862c5ba5013b472', '00000007-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.255 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000000-0000-0000-0000-000000000000', 'e047', '2020-12-11T03:09:52.000+0000', '80fe035fe88f37471862c5ba5013b472', '00000002-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.263 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000000-0000-0000-0000-000000000000', 'e047', '2021-05-04T09:55:19.000+0000', '80fe035fe88f37471862c5ba5013b472', '00000004-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.268 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000000-0000-0000-0000-000000000000', 'e047', '2022-06-09T18:18:35.000+0000', '80fe035fe88f37471862c5ba5013b472', '00000006-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.275 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000000-0000-0000-0000-000000000000', 'e047', '2022-08-13T14:25:32.000+0000', '80fe035fe88f37471862c5ba5013b472', '00000005-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.279 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000000-0000-0000-0000-000000000000', 'e047', '2022-10-01T14:34:25.000+0000', '80fe035fe88f37471862c5ba5013b472', '00000003-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.293 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000000-0000-0000-0000-000000000000', 'e047', '2023-03-15T07:41:36.000+0000', '80fe035fe88f37471862c5ba5013b472', '00000001-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.303 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/2e10', '00000008-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.310 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000008-0000-0000-0000-000000000000', '2e10', '2022-02-07T16:20:06.000+0000', 'c6043614de10faba15b20b12b72fae53', '00000009-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.323 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000008-0000-0000-0000-000000000000', '2e10', '2022-07-23T22:36:25.000+0000', 'c6043614de10faba15b20b12b72fae53', '0000000a-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.329 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/7d46', '0000000b-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.330 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000000b-0000-0000-0000-000000000000', '7d46', '2021-01-07T11:49:15.000+0000', '7f00331093dfc89ac1ec7525c049fa38', '0000000c-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.355 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000000b-0000-0000-0000-000000000000', '7d46', '2021-02-04T21:40:37.000+0000', '7f00331093dfc89ac1ec7525c049fa38', '0000000f-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.362 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000000b-0000-0000-0000-000000000000', '7d46', '2021-11-30T12:16:29.000+0000', '7f00331093dfc89ac1ec7525c049fa38', '0000000d-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.375 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000000b-0000-0000-0000-000000000000', '7d46', '2022-10-12T19:07:44.000+0000', '7f00331093dfc89ac1ec7525c049fa38', '0000000e-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.383 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/3f38', '00000010-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.395 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000010-0000-0000-0000-000000000000', '3f38', '2020-11-27T20:40:07.000+0000', 'acadf7563f2831cab3dbbaeb8afe000f', '00000013-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.399 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000010-0000-0000-0000-000000000000', '3f38', '2021-05-21T01:26:15.000+0000', 'acadf7563f2831cab3dbbaeb8afe000f', '00000011-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.403 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000010-0000-0000-0000-000000000000', '3f38', '2023-04-18T18:11:45.000+0000', 'acadf7563f2831cab3dbbaeb8afe000f', '00000014-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.415 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000010-0000-0000-0000-000000000000', '3f38', '2023-12-21T13:01:22.000+0000', 'acadf7563f2831cab3dbbaeb8afe000f', '00000012-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.416 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/67a2', '00000015-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.421 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000015-0000-0000-0000-000000000000', '67a2', '2020-03-09T17:18:15.000+0000', '0988f9a2700d7d5748715bcd29ada8d4', '0000001a-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.430 [main                ] INFO  p6spy                                              - SQL: 1 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000015-0000-0000-0000-000000000000', '67a2', '2021-05-26T11:37:52.000+0000', '0988f9a2700d7d5748715bcd29ada8d4', '00000016-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.438 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000015-0000-0000-0000-000000000000', '67a2', '2021-06-28T06:23:37.000+0000', '0988f9a2700d7d5748715bcd29ada8d4', '00000018-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.442 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000015-0000-0000-0000-000000000000', '67a2', '2022-09-04T23:44:40.000+0000', '0988f9a2700d7d5748715bcd29ada8d4', '00000017-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.449 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000015-0000-0000-0000-000000000000', '67a2', '2023-04-05T18:47:37.000+0000', '0988f9a2700d7d5748715bcd29ada8d4', '00000019-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.451 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000015-0000-0000-0000-000000000000', '67a2', '2023-04-28T12:13:47.000+0000', '0988f9a2700d7d5748715bcd29ada8d4', '0000001b-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.458 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/f228', '0000001c-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.463 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000001c-0000-0000-0000-000000000000', 'f228', '2020-02-15T22:59:25.000+0000', 'f5545c7b0ee25c471665b0f4a57014f2', '00000021-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.464 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000001c-0000-0000-0000-000000000000', 'f228', '2020-04-28T10:10:30.000+0000', 'f5545c7b0ee25c471665b0f4a57014f2', '0000001d-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.467 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000001c-0000-0000-0000-000000000000', 'f228', '2020-12-29T17:06:31.000+0000', 'f5545c7b0ee25c471665b0f4a57014f2', '0000001f-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.472 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000001c-0000-0000-0000-000000000000', 'f228', '2022-09-26T04:15:21.000+0000', 'f5545c7b0ee25c471665b0f4a57014f2', '0000001e-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.477 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000001c-0000-0000-0000-000000000000', 'f228', '2022-10-13T07:09:57.000+0000', 'f5545c7b0ee25c471665b0f4a57014f2', '00000020-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.477 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/34c3', '00000022-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.487 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000022-0000-0000-0000-000000000000', '34c3', '2020-06-13T05:07:08.000+0000', 'fc1435e7e4fa8c63894d9f8029f9be2c', '00000025-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.488 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000022-0000-0000-0000-000000000000', '34c3', '2020-09-02T21:37:36.000+0000', 'fc1435e7e4fa8c63894d9f8029f9be2c', '00000023-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.489 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000022-0000-0000-0000-000000000000', '34c3', '2023-09-15T00:33:11.000+0000', 'fc1435e7e4fa8c63894d9f8029f9be2c', '00000026-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.490 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000022-0000-0000-0000-000000000000', '34c3', '2023-09-19T15:15:10.000+0000', 'fc1435e7e4fa8c63894d9f8029f9be2c', '00000024-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.498 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/5712', '00000027-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.500 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000027-0000-0000-0000-000000000000', '5712', '2020-08-22T00:07:21.000+0000', '4590a18f904908454f0d55f2593688dd', '00000028-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.501 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/32cc', '00000029-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.503 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000029-0000-0000-0000-000000000000', '32cc', '2020-09-17T10:35:28.000+0000', 'b9046b121dcde0e58d9e335cb2f8d774', '0000002a-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.511 [main                ] INFO  p6spy                                              - SQL: 7 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000029-0000-0000-0000-000000000000', '32cc', '2021-04-26T20:52:42.000+0000', 'b9046b121dcde0e58d9e335cb2f8d774', '0000002b-0000-0000-0000-000000000000')
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.515 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('/foo/bar/5252', '0000002c-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:13.517 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '0000002c-0000-0000-0000-000000000000', '5252', '2022-07-24T13:37:41.000+0000', '169a61a24c952f0945d4382dee97bb51', '0000002d-0000-0000-0000-000000000000')
04:59:13.594 [main                ] INFO  p6spy                                              - SQL: 73 nanos - 
04:59:13.616 [main                ] TRACE it.tidalwave.util.spi.HierarchicFinderSupport      - HierarchicFinderSupport(HierarchicFinderSupport(name=it.tidalwave.datamanager.dao.impl.jpa.JpaDataManagerDao$JpaManagedFileFinder, firstResult=0, maxResults=2147483647, contexts=[], sorters=[]), HierarchicFinderSupport(name=it.tidalwave.util.spring.jpa.JpaRepositoryFinder, firstResult=0, maxResults=2147483647, contexts=[], sorters=[]))
04:59:13.684 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.findAll]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:13.685 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:13.686 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1782098044<open>)] for JPA transaction
04:59:13.686 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@5938638f]
04:59:13.704 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - findAll(0, 2147483647, [JpaSortCriterion(path, ASCENDING)])
Hibernate: select m1_0.id,m1_0.path from files m1_0 order by m1_0.path asc limit ? offset ?
04:59:14.404 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 order by m1_0.path asc limit 2147483647 offset 0
04:59:14.491 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 10 items
04:59:14.491 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [ManagedFileEntity@4d5aa20b(id=00000008-0000-0000-0000-000000000000, path=/foo/bar/2e10, fingerprints=not initialized), ManagedFileEntity@60e2370e(id=00000029-0000-0000-0000-000000000000, path=/foo/bar/32cc, fingerprints=not initialized), ManagedFileEntity@189738f4(id=00000022-0000-0000-0000-000000000000, path=/foo/bar/34c3, fingerprints=not initialized), ManagedFileEntity@57fb7ccc(id=00000010-0000-0000-0000-000000000000, path=/foo/bar/3f38, fingerprints=not initialized), ManagedFileEntity@5a23d4d8(id=0000002c-0000-0000-0000-000000000000, path=/foo/bar/5252, fingerprints=not initialized), ManagedFileEntity@736d26f1(id=00000027-0000-0000-0000-000000000000, path=/foo/bar/5712, fingerprints=not initialized), ManagedFileEntity@5c0b05f4(id=00000015-0000-0000-0000-000000000000, path=/foo/bar/67a2, fingerprints=not initialized), ManagedFileEntity@58ef8069(id=0000000b-0000-0000-0000-000000000000, path=/foo/bar/7d46, fingerprints=not initialized), ManagedFileEntity@10706411(id=00000000-0000-0000-0000-000000000000, path=/foo/bar/e047, fingerprints=not initialized), ManagedFileEntity@dcd6f19(id=0000001c-0000-0000-0000-000000000000, path=/foo/bar/f228, fingerprints=not initialized)]
04:59:14.496 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.496 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.497 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1782098044<open>)]
04:59:14.503 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.503 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1782098044<open>)] after transaction
04:59:14.526 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Asserting that lazy collection of fingerprints not fetched yet...
04:59:14.544 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Triggering lazy fetch...
04:59:14.545 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.545 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.545 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(2072210678<open>)] for JPA transaction
04:59:14.546 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@59412c]
04:59:14.554 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=00000008-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.558 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='00000008-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.598 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='00000008-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.601 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 2 items
04:59:14.602 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=00000009-0000-0000-0000-000000000000, name=2e10, algorithm=md5, value=c6043614de10faba15b20b12b72fae53, timestamp=2022-02-07T16:20:06, fileId=00000008-0000-0000-0000-000000000000), FingerprintEntity(id=0000000a-0000-0000-0000-000000000000, name=2e10, algorithm=md5, value=c6043614de10faba15b20b12b72fae53, timestamp=2022-07-23T22:36:25, fileId=00000008-0000-0000-0000-000000000000)]
04:59:14.629 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.629 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.629 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(2072210678<open>)]
04:59:14.630 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.631 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(2072210678<open>)] after transaction
04:59:14.632 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.632 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.633 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(356377759<open>)] for JPA transaction
04:59:14.633 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@18b36b93]
04:59:14.633 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=00000029-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.634 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='00000029-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.654 [main                ] INFO  p6spy                                              - SQL: 8 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='00000029-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.656 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 2 items
04:59:14.658 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=0000002a-0000-0000-0000-000000000000, name=32cc, algorithm=md5, value=b9046b121dcde0e58d9e335cb2f8d774, timestamp=2020-09-17T10:35:28, fileId=00000029-0000-0000-0000-000000000000), FingerprintEntity(id=0000002b-0000-0000-0000-000000000000, name=32cc, algorithm=md5, value=b9046b121dcde0e58d9e335cb2f8d774, timestamp=2021-04-26T20:52:42, fileId=00000029-0000-0000-0000-000000000000)]
04:59:14.659 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.659 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.659 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(356377759<open>)]
04:59:14.660 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.660 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(356377759<open>)] after transaction
04:59:14.660 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.660 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.660 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(952812537<open>)] for JPA transaction
04:59:14.661 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@642bd75c]
04:59:14.661 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=00000022-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.662 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='00000022-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.671 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='00000022-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.682 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 4 items
04:59:14.682 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=00000025-0000-0000-0000-000000000000, name=34c3, algorithm=md5, value=fc1435e7e4fa8c63894d9f8029f9be2c, timestamp=2020-06-13T05:07:08, fileId=00000022-0000-0000-0000-000000000000), FingerprintEntity(id=00000023-0000-0000-0000-000000000000, name=34c3, algorithm=md5, value=fc1435e7e4fa8c63894d9f8029f9be2c, timestamp=2020-09-02T21:37:36, fileId=00000022-0000-0000-0000-000000000000), FingerprintEntity(id=00000026-0000-0000-0000-000000000000, name=34c3, algorithm=md5, value=fc1435e7e4fa8c63894d9f8029f9be2c, timestamp=2023-09-15T00:33:11, fileId=00000022-0000-0000-0000-000000000000), FingerprintEntity(id=00000024-0000-0000-0000-000000000000, name=34c3, algorithm=md5, value=fc1435e7e4fa8c63894d9f8029f9be2c, timestamp=2023-09-19T15:15:10, fileId=00000022-0000-0000-0000-000000000000)]
04:59:14.683 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.683 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.683 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(952812537<open>)]
04:59:14.684 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.684 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(952812537<open>)] after transaction
04:59:14.684 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.684 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.684 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(2052403172<open>)] for JPA transaction
04:59:14.689 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@23258315]
04:59:14.689 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=00000010-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.695 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='00000010-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.696 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='00000010-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.707 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 4 items
04:59:14.707 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=00000013-0000-0000-0000-000000000000, name=3f38, algorithm=md5, value=acadf7563f2831cab3dbbaeb8afe000f, timestamp=2020-11-27T20:40:07, fileId=00000010-0000-0000-0000-000000000000), FingerprintEntity(id=00000011-0000-0000-0000-000000000000, name=3f38, algorithm=md5, value=acadf7563f2831cab3dbbaeb8afe000f, timestamp=2021-05-21T01:26:15, fileId=00000010-0000-0000-0000-000000000000), FingerprintEntity(id=00000014-0000-0000-0000-000000000000, name=3f38, algorithm=md5, value=acadf7563f2831cab3dbbaeb8afe000f, timestamp=2023-04-18T18:11:45, fileId=00000010-0000-0000-0000-000000000000), FingerprintEntity(id=00000012-0000-0000-0000-000000000000, name=3f38, algorithm=md5, value=acadf7563f2831cab3dbbaeb8afe000f, timestamp=2023-12-21T13:01:22, fileId=00000010-0000-0000-0000-000000000000)]
04:59:14.707 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.707 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.707 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(2052403172<open>)]
04:59:14.708 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.708 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(2052403172<open>)] after transaction
04:59:14.709 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.709 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.709 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1276416078<open>)] for JPA transaction
04:59:14.709 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@256088a7]
04:59:14.710 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=0000002c-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.711 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='0000002c-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.712 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='0000002c-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.713 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 1 items
04:59:14.713 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=0000002d-0000-0000-0000-000000000000, name=5252, algorithm=md5, value=169a61a24c952f0945d4382dee97bb51, timestamp=2022-07-24T13:37:41, fileId=0000002c-0000-0000-0000-000000000000)]
04:59:14.713 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.713 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.713 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1276416078<open>)]
04:59:14.722 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.722 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1276416078<open>)] after transaction
04:59:14.724 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.724 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.724 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1042701661<open>)] for JPA transaction
04:59:14.725 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@452ba1c9]
04:59:14.725 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=00000027-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.726 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='00000027-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.728 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='00000027-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.729 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 1 items
04:59:14.729 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=00000028-0000-0000-0000-000000000000, name=5712, algorithm=md5, value=4590a18f904908454f0d55f2593688dd, timestamp=2020-08-22T00:07:21, fileId=00000027-0000-0000-0000-000000000000)]
04:59:14.729 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.729 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.729 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1042701661<open>)]
04:59:14.730 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.754 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1042701661<open>)] after transaction
04:59:14.755 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.755 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.755 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1106066730<open>)] for JPA transaction
04:59:14.755 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@52e494a2]
04:59:14.756 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=00000015-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.757 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='00000015-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.768 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='00000015-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.771 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 6 items
04:59:14.771 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=0000001a-0000-0000-0000-000000000000, name=67a2, algorithm=md5, value=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2020-03-09T17:18:15, fileId=00000015-0000-0000-0000-000000000000), FingerprintEntity(id=00000016-0000-0000-0000-000000000000, name=67a2, algorithm=md5, value=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2021-05-26T11:37:52, fileId=00000015-0000-0000-0000-000000000000), FingerprintEntity(id=00000018-0000-0000-0000-000000000000, name=67a2, algorithm=md5, value=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2021-06-28T06:23:37, fileId=00000015-0000-0000-0000-000000000000), FingerprintEntity(id=00000017-0000-0000-0000-000000000000, name=67a2, algorithm=md5, value=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2022-09-04T23:44:40, fileId=00000015-0000-0000-0000-000000000000), FingerprintEntity(id=00000019-0000-0000-0000-000000000000, name=67a2, algorithm=md5, value=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2023-04-05T18:47:37, fileId=00000015-0000-0000-0000-000000000000), FingerprintEntity(id=0000001b-0000-0000-0000-000000000000, name=67a2, algorithm=md5, value=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2023-04-28T12:13:47, fileId=00000015-0000-0000-0000-000000000000)]
04:59:14.771 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.771 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.771 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1106066730<open>)]
04:59:14.772 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.772 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1106066730<open>)] after transaction
04:59:14.773 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.773 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.773 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1148816769<open>)] for JPA transaction
04:59:14.773 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@605d67f8]
04:59:14.774 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=0000000b-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.789 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='0000000b-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.797 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='0000000b-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.806 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 4 items
04:59:14.806 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=0000000c-0000-0000-0000-000000000000, name=7d46, algorithm=md5, value=7f00331093dfc89ac1ec7525c049fa38, timestamp=2021-01-07T11:49:15, fileId=0000000b-0000-0000-0000-000000000000), FingerprintEntity(id=0000000f-0000-0000-0000-000000000000, name=7d46, algorithm=md5, value=7f00331093dfc89ac1ec7525c049fa38, timestamp=2021-02-04T21:40:37, fileId=0000000b-0000-0000-0000-000000000000), FingerprintEntity(id=0000000d-0000-0000-0000-000000000000, name=7d46, algorithm=md5, value=7f00331093dfc89ac1ec7525c049fa38, timestamp=2021-11-30T12:16:29, fileId=0000000b-0000-0000-0000-000000000000), FingerprintEntity(id=0000000e-0000-0000-0000-000000000000, name=7d46, algorithm=md5, value=7f00331093dfc89ac1ec7525c049fa38, timestamp=2022-10-12T19:07:44, fileId=0000000b-0000-0000-0000-000000000000)]
04:59:14.807 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.807 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.807 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1148816769<open>)]
04:59:14.807 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.808 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1148816769<open>)] after transaction
04:59:14.808 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.808 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.808 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1357627251<open>)] for JPA transaction
04:59:14.809 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@72435def]
04:59:14.809 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=00000000-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.817 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='00000000-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.835 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='00000000-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.837 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 7 items
04:59:14.839 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=00000007-0000-0000-0000-000000000000, name=e047, algorithm=md5, value=80fe035fe88f37471862c5ba5013b472, timestamp=2020-07-27T07:30:09, fileId=00000000-0000-0000-0000-000000000000), FingerprintEntity(id=00000002-0000-0000-0000-000000000000, name=e047, algorithm=md5, value=80fe035fe88f37471862c5ba5013b472, timestamp=2020-12-11T03:09:52, fileId=00000000-0000-0000-0000-000000000000), FingerprintEntity(id=00000004-0000-0000-0000-000000000000, name=e047, algorithm=md5, value=80fe035fe88f37471862c5ba5013b472, timestamp=2021-05-04T09:55:19, fileId=00000000-0000-0000-0000-000000000000), FingerprintEntity(id=00000006-0000-0000-0000-000000000000, name=e047, algorithm=md5, value=80fe035fe88f37471862c5ba5013b472, timestamp=2022-06-09T18:18:35, fileId=00000000-0000-0000-0000-000000000000), FingerprintEntity(id=00000005-0000-0000-0000-000000000000, name=e047, algorithm=md5, value=80fe035fe88f37471862c5ba5013b472, timestamp=2022-08-13T14:25:32, fileId=00000000-0000-0000-0000-000000000000), FingerprintEntity(id=00000003-0000-0000-0000-000000000000, name=e047, algorithm=md5, value=80fe035fe88f37471862c5ba5013b472, timestamp=2022-10-01T14:34:25, fileId=00000000-0000-0000-0000-000000000000), FingerprintEntity(id=00000001-0000-0000-0000-000000000000, name=e047, algorithm=md5, value=80fe035fe88f37471862c5ba5013b472, timestamp=2023-03-15T07:41:36, fileId=00000000-0000-0000-0000-000000000000)]
04:59:14.839 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.840 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.840 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1357627251<open>)]
04:59:14.841 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.842 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1357627251<open>)] after transaction
04:59:14.842 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.util.spring.jpa.impl.DefaultFinderJpaRepository.fetch]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.858 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.858 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1539496909<open>)] for JPA transaction
04:59:14.859 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@18f45d62]
04:59:14.859 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - fetch(ManagedFileEntity, id=0000001c-0000-0000-0000-000000000000)
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:14.860 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='0000001c-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
04:59:14.862 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id='0000001c-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:14.863 [main                ] INFO  i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning 5 items
04:59:14.863 [main                ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository   - >>>> returning [FingerprintEntity(id=00000021-0000-0000-0000-000000000000, name=f228, algorithm=md5, value=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2020-02-15T22:59:25, fileId=0000001c-0000-0000-0000-000000000000), FingerprintEntity(id=0000001d-0000-0000-0000-000000000000, name=f228, algorithm=md5, value=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2020-04-28T10:10:30, fileId=0000001c-0000-0000-0000-000000000000), FingerprintEntity(id=0000001f-0000-0000-0000-000000000000, name=f228, algorithm=md5, value=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2020-12-29T17:06:31, fileId=0000001c-0000-0000-0000-000000000000), FingerprintEntity(id=0000001e-0000-0000-0000-000000000000, name=f228, algorithm=md5, value=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2022-09-26T04:15:21, fileId=0000001c-0000-0000-0000-000000000000), FingerprintEntity(id=00000020-0000-0000-0000-000000000000, name=f228, algorithm=md5, value=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2022-10-13T07:09:57, fileId=0000001c-0000-0000-0000-000000000000)]
04:59:14.863 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.863 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.864 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1539496909<open>)]
04:59:14.864 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:14.864 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1539496909<open>)] after transaction
04:59:14.865 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Actual result:
04:59:14.880 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=00000008-0000-0000-0000-000000000000, path=/foo/bar/2e10, fingerprints=LazySupplier(ref=[Fingerprint(id=00000009-0000-0000-0000-000000000000, name=2e10, algorithm=md5, fingerprint=c6043614de10faba15b20b12b72fae53, timestamp=2022-02-07T16:20:06), Fingerprint(id=0000000a-0000-0000-0000-000000000000, name=2e10, algorithm=md5, fingerprint=c6043614de10faba15b20b12b72fae53, timestamp=2022-07-23T22:36:25)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=00000029-0000-0000-0000-000000000000, path=/foo/bar/32cc, fingerprints=LazySupplier(ref=[Fingerprint(id=0000002a-0000-0000-0000-000000000000, name=32cc, algorithm=md5, fingerprint=b9046b121dcde0e58d9e335cb2f8d774, timestamp=2020-09-17T10:35:28), Fingerprint(id=0000002b-0000-0000-0000-000000000000, name=32cc, algorithm=md5, fingerprint=b9046b121dcde0e58d9e335cb2f8d774, timestamp=2021-04-26T20:52:42)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=00000022-0000-0000-0000-000000000000, path=/foo/bar/34c3, fingerprints=LazySupplier(ref=[Fingerprint(id=00000025-0000-0000-0000-000000000000, name=34c3, algorithm=md5, fingerprint=fc1435e7e4fa8c63894d9f8029f9be2c, timestamp=2020-06-13T05:07:08), Fingerprint(id=00000023-0000-0000-0000-000000000000, name=34c3, algorithm=md5, fingerprint=fc1435e7e4fa8c63894d9f8029f9be2c, timestamp=2020-09-02T21:37:36), Fingerprint(id=00000026-0000-0000-0000-000000000000, name=34c3, algorithm=md5, fingerprint=fc1435e7e4fa8c63894d9f8029f9be2c, timestamp=2023-09-15T00:33:11), Fingerprint(id=00000024-0000-0000-0000-000000000000, name=34c3, algorithm=md5, fingerprint=fc1435e7e4fa8c63894d9f8029f9be2c, timestamp=2023-09-19T15:15:10)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=00000010-0000-0000-0000-000000000000, path=/foo/bar/3f38, fingerprints=LazySupplier(ref=[Fingerprint(id=00000013-0000-0000-0000-000000000000, name=3f38, algorithm=md5, fingerprint=acadf7563f2831cab3dbbaeb8afe000f, timestamp=2020-11-27T20:40:07), Fingerprint(id=00000011-0000-0000-0000-000000000000, name=3f38, algorithm=md5, fingerprint=acadf7563f2831cab3dbbaeb8afe000f, timestamp=2021-05-21T01:26:15), Fingerprint(id=00000014-0000-0000-0000-000000000000, name=3f38, algorithm=md5, fingerprint=acadf7563f2831cab3dbbaeb8afe000f, timestamp=2023-04-18T18:11:45), Fingerprint(id=00000012-0000-0000-0000-000000000000, name=3f38, algorithm=md5, fingerprint=acadf7563f2831cab3dbbaeb8afe000f, timestamp=2023-12-21T13:01:22)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=0000002c-0000-0000-0000-000000000000, path=/foo/bar/5252, fingerprints=LazySupplier(ref=[Fingerprint(id=0000002d-0000-0000-0000-000000000000, name=5252, algorithm=md5, fingerprint=169a61a24c952f0945d4382dee97bb51, timestamp=2022-07-24T13:37:41)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=00000027-0000-0000-0000-000000000000, path=/foo/bar/5712, fingerprints=LazySupplier(ref=[Fingerprint(id=00000028-0000-0000-0000-000000000000, name=5712, algorithm=md5, fingerprint=4590a18f904908454f0d55f2593688dd, timestamp=2020-08-22T00:07:21)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=00000015-0000-0000-0000-000000000000, path=/foo/bar/67a2, fingerprints=LazySupplier(ref=[Fingerprint(id=0000001a-0000-0000-0000-000000000000, name=67a2, algorithm=md5, fingerprint=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2020-03-09T17:18:15), Fingerprint(id=00000016-0000-0000-0000-000000000000, name=67a2, algorithm=md5, fingerprint=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2021-05-26T11:37:52), Fingerprint(id=00000018-0000-0000-0000-000000000000, name=67a2, algorithm=md5, fingerprint=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2021-06-28T06:23:37), Fingerprint(id=00000017-0000-0000-0000-000000000000, name=67a2, algorithm=md5, fingerprint=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2022-09-04T23:44:40), Fingerprint(id=00000019-0000-0000-0000-000000000000, name=67a2, algorithm=md5, fingerprint=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2023-04-05T18:47:37), Fingerprint(id=0000001b-0000-0000-0000-000000000000, name=67a2, algorithm=md5, fingerprint=0988f9a2700d7d5748715bcd29ada8d4, timestamp=2023-04-28T12:13:47)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=0000000b-0000-0000-0000-000000000000, path=/foo/bar/7d46, fingerprints=LazySupplier(ref=[Fingerprint(id=0000000c-0000-0000-0000-000000000000, name=7d46, algorithm=md5, fingerprint=7f00331093dfc89ac1ec7525c049fa38, timestamp=2021-01-07T11:49:15), Fingerprint(id=0000000f-0000-0000-0000-000000000000, name=7d46, algorithm=md5, fingerprint=7f00331093dfc89ac1ec7525c049fa38, timestamp=2021-02-04T21:40:37), Fingerprint(id=0000000d-0000-0000-0000-000000000000, name=7d46, algorithm=md5, fingerprint=7f00331093dfc89ac1ec7525c049fa38, timestamp=2021-11-30T12:16:29), Fingerprint(id=0000000e-0000-0000-0000-000000000000, name=7d46, algorithm=md5, fingerprint=7f00331093dfc89ac1ec7525c049fa38, timestamp=2022-10-12T19:07:44)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=00000000-0000-0000-0000-000000000000, path=/foo/bar/e047, fingerprints=LazySupplier(ref=[Fingerprint(id=00000007-0000-0000-0000-000000000000, name=e047, algorithm=md5, fingerprint=80fe035fe88f37471862c5ba5013b472, timestamp=2020-07-27T07:30:09), Fingerprint(id=00000002-0000-0000-0000-000000000000, name=e047, algorithm=md5, fingerprint=80fe035fe88f37471862c5ba5013b472, timestamp=2020-12-11T03:09:52), Fingerprint(id=00000004-0000-0000-0000-000000000000, name=e047, algorithm=md5, fingerprint=80fe035fe88f37471862c5ba5013b472, timestamp=2021-05-04T09:55:19), Fingerprint(id=00000006-0000-0000-0000-000000000000, name=e047, algorithm=md5, fingerprint=80fe035fe88f37471862c5ba5013b472, timestamp=2022-06-09T18:18:35), Fingerprint(id=00000005-0000-0000-0000-000000000000, name=e047, algorithm=md5, fingerprint=80fe035fe88f37471862c5ba5013b472, timestamp=2022-08-13T14:25:32), Fingerprint(id=00000003-0000-0000-0000-000000000000, name=e047, algorithm=md5, fingerprint=80fe035fe88f37471862c5ba5013b472, timestamp=2022-10-01T14:34:25), Fingerprint(id=00000001-0000-0000-0000-000000000000, name=e047, algorithm=md5, fingerprint=80fe035fe88f37471862c5ba5013b472, timestamp=2023-03-15T07:41:36)]))
04:59:14.885 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -     ManagedFile(id=0000001c-0000-0000-0000-000000000000, path=/foo/bar/f228, fingerprints=LazySupplier(ref=[Fingerprint(id=00000021-0000-0000-0000-000000000000, name=f228, algorithm=md5, fingerprint=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2020-02-15T22:59:25), Fingerprint(id=0000001d-0000-0000-0000-000000000000, name=f228, algorithm=md5, fingerprint=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2020-04-28T10:10:30), Fingerprint(id=0000001f-0000-0000-0000-000000000000, name=f228, algorithm=md5, fingerprint=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2020-12-29T17:06:31), Fingerprint(id=0000001e-0000-0000-0000-000000000000, name=f228, algorithm=md5, fingerprint=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2022-09-26T04:15:21), Fingerprint(id=00000020-0000-0000-0000-000000000000, name=f228, algorithm=md5, fingerprint=f5545c7b0ee25c471665b0f4a57014f2, timestamp=2022-10-13T07:09:57)]))
04:59:14.925 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - TEST PASSED in 1877 msec
04:59:14.925 [main                ] INFO  i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - 
04:59:14.959 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.datamanager.dao.impl.jpa.ManagedFileEntityTest.test_equals_and_hashCode]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.959 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.959 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(166534975<open>)] for JPA transaction
04:59:14.959 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@4a256169]
04:59:14.961 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
04:59:14.961 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test equals and hashCode"
04:59:14.961 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
Hibernate: insert into files (path, id) values (?, ?)
04:59:14.974 [main                ] INFO  p6spy                                              - SQL: 1 nanos - insert into files (path, id) values ('path', 'id')
04:59:15.059 [main                ] INFO  p6spy                                              - SQL: 82 nanos - 
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.063 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
04:59:15.064 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.066 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
04:59:15.075 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.077 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
04:59:15.099 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.101 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
04:59:15.107 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.113 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
04:59:15.114 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.123 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
04:59:15.128 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.144 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
Hibernate: delete from files where id=?
04:59:15.163 [main                ] INFO  p6spy                                              - SQL: 0 nanos - delete from files where id='id'
04:59:15.221 [main                ] INFO  p6spy                                              - SQL: 53 nanos - 
04:59:15.222 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 261 msec
04:59:15.223 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - 
04:59:15.226 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
04:59:15.226 [main                ] WARN  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
04:59:15.226 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(166534975<open>)]
04:59:15.226 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:15.229 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(166534975<open>)] after transaction
04:59:15.247 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Creating new transaction with name [it.tidalwave.datamanager.dao.impl.jpa.ManagedFileEntityTest.test_toString_with_proxy]: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.248 [main                ] INFO  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.248 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1392120680<open>)] for JPA transaction
04:59:15.248 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@be96f52]
04:59:15.261 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
04:59:15.261 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test toString with proxy"
04:59:15.261 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
Hibernate: insert into files (path, id) values (?, ?)
04:59:15.283 [main                ] INFO  p6spy                                              - SQL: 0 nanos - insert into files (path, id) values ('path', 'id2')
04:59:15.345 [main                ] INFO  p6spy                                              - SQL: 54 nanos - 
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.347 [main                ] INFO  p6spy                                              - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id2'
04:59:15.348 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:15.350 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 89 msec
04:59:15.350 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - 
04:59:15.353 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
04:59:15.353 [main                ] WARN  i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
04:59:15.353 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(1392120680<open>)]
04:59:15.354 [main                ] INFO  p6spy                                              - SQL: 0 nanos - 
04:59:15.354 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1392120680<open>)] after transaction
04:59:15.378 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - **********************************
04:59:15.379 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test toString without proxy"
04:59:15.379 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - **********************************
04:59:15.390 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 3 msec
04:59:15.390 [main                ] INFO  i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - 
04:59:15.394 [main                ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Should roll back transaction but cannot - no transaction available
04:59:15.408 [main                ] INFO  i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - FINISHED TESTS OF it.tidalwave.datamanager.dao.impl.jpa.FingerprintEntityTest
[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 34.06 s - in TestSuite
04:59:15.933 [licationShutdownHook] INFO  o.s.orm.jpa.LocalContainerEntityManagerFactoryBean - Closing JPA EntityManagerFactory for persistence unit 'default'
[INFO] 
[INFO] Results:
[INFO] 
[INFO] Tests run: 5, Failures: 0, Errors: 0, Skipped: 0
[INFO] 
[JENKINS] Recording test results
[INFO] 
[INFO] --- jacoco:0.8.9:report (report) @ solidblue3-dao ---
[INFO] Loading execution data file /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/jacoco.exec
[INFO] Analyzed bundle 'SolidBlue III :: Dao' with 4 classes
[INFO] 
[INFO] --- jar:3.3.0:jar (default-jar) @ solidblue3-dao ---
[INFO] Building jar: /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/solidblue3-dao-1.1-SNAPSHOT.9990138857e0.jar
[INFO] 
[INFO] --- jar:3.3.0:test-jar (default-test-jar) @ solidblue3-dao ---
[INFO] Building jar: /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/solidblue3-dao-1.1-SNAPSHOT.9990138857e0-tests.jar
[INFO] 
[INFO] --- install:3.1.1:install (default-install) @ solidblue3-dao ---
[INFO] Installing /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/pom.xml to /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace@tmp/repository/it/tidalwave/solidblue3/solidblue3-dao/1.1-SNAPSHOT/solidblue3-dao-1.1-SNAPSHOT.pom
[INFO] Installing /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/solidblue3-dao-1.1-SNAPSHOT.9990138857e0.jar to /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace@tmp/repository/it/tidalwave/solidblue3/solidblue3-dao/1.1-SNAPSHOT/solidblue3-dao-1.1-SNAPSHOT.jar
[INFO] Installing /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/solidblue3-dao-1.1-SNAPSHOT.9990138857e0-tests.jar to /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace@tmp/repository/it/tidalwave/solidblue3/solidblue3-dao/1.1-SNAPSHOT/solidblue3-dao-1.1-SNAPSHOT-tests.jar
[INFO] 
[INFO] >>> dependency:3.5.0:analyze (default-cli) > test-compile @ solidblue3-dao >>>
[INFO] 
[INFO] --- buildnumber:3.0.0:create (default) @ solidblue3-dao ---
[INFO] ShortRevision tag detected. The value is '12'.
[INFO] Executing: /bin/sh -c cd '/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao' && 'git' 'rev-parse' '--verify' '--short=12' 'HEAD'
[INFO] Working directory: /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao
[INFO] Storing buildNumber: 9990138857e0 at timestamp: 1682571557681
[WARNING] Cannot get the branch information from the git repository: 
Detecting the current branch failed: fatal: ref HEAD is not a symbolic ref

[INFO] ShortRevision tag detected. The value is '12'.
[INFO] Executing: /bin/sh -c cd '/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao' && 'git' 'rev-parse' '--verify' '--short=12' 'HEAD'
[INFO] Working directory: /var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao
[INFO] Storing buildScmBranch: UNKNOWN
[INFO] 
[INFO] --- enforcer:3.3.0:enforce (enforce-maven) @ solidblue3-dao ---
[INFO] Rule 0: org.apache.maven.enforcer.rules.dependency.DependencyConvergence passed
[INFO] Rule 3: org.apache.maven.enforcer.rules.RequirePluginVersions passed
[INFO] 
[INFO] --- enforcer:3.3.0:enforce (enforce-banned-dependencies) @ solidblue3-dao ---
[INFO] Rule 0: org.apache.maven.enforcer.rules.dependency.BannedDependencies passed
[INFO] 
[INFO] --- antrun:3.1.0:run (generate-and-print-build-description) @ solidblue3-dao ---
[INFO] Executing tasks
[INFO]      [echo] DESCRIPTION: origin/master 1.1-SNAPSHOT 9990138857e0
[INFO]      [echo] Java Version: 17.0.6 -source 17 -target 17 -release 17
[INFO] Executed tasks
[INFO] 
[INFO] --- jacoco:0.8.9:prepare-agent (prepare-agent) @ solidblue3-dao ---
[INFO] tft.test.jacoco.argLine set to -javaagent:/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace@tmp/repository/org/jacoco/org.jacoco.agent/0.8.9/org.jacoco.agent-0.8.9-runtime.jar=destfile=/var/jenkins_home/jobs/SolidBlue3_Metrics/workspace/modules/Dao/target/jacoco.exec
[INFO] 
[INFO] --- resources:3.3.1:resources (default-resources) @ solidblue3-dao ---
[INFO] Copying 2 resources from src/main/resources to target/classes
[INFO] 
[INFO] --- compiler:3.11.0:compile (default-compile) @ solidblue3-dao ---
[INFO] Changes detected - recompiling the module! :dependency
[INFO] Compiling 4 source files with javac [forked debug deprecation release 17] to target/classes
[WARNING] No processor claimed any of these annotations: /jakarta.persistence.OrderBy,/jakarta.persistence.Column,/jakarta.persistence.OneToMany,/jakarta.persistence.Table,/jakarta.persistence.Entity,/org.springframework.stereotype.Component,/jakarta.annotation.Nonnull,/org.hibernate.annotations.Cascade,/jakarta.transaction.Transactional,/edu.umd.cs.findbugs.annotations.SuppressFBWarnings,/jakarta.persistence.Id
[INFO] 
[INFO] --- resources:3.3.1:testResources (default-testResources) @ solidblue3-dao ---
[INFO] Copying 2 resources from src/test/resources to target/test-classes
[INFO] 
[INFO] --- compiler:3.11.0:testCompile (default-testCompile) @ solidblue3-dao ---
[INFO] Changes detected - recompiling the module! :dependency
[INFO] Compiling 5 source files with javac [forked debug deprecation release 17] to target/test-classes
[WARNING] Failed to getClass for org.apache.maven.plugins.dependency.analyze.AnalyzeMojo
[INFO] 
[INFO] <<< dependency:3.5.0:analyze (default-cli) < test-compile @ solidblue3-dao <<<
[INFO] 
[INFO] 
[INFO] --- dependency:3.5.0:analyze (default-cli) @ solidblue3-dao ---
[WARNING] Used undeclared dependencies found:
[WARNING]    org.slf4j:slf4j-api:jar:2.0.7:compile
[WARNING]    org.springframework.boot:spring-boot:jar:3.0.5:compile
[WARNING]    org.springframework.data:spring-data-jpa:jar:3.0.4:compile
[WARNING]    org.springframework.boot:spring-boot-autoconfigure:jar:3.0.5:compile
[WARNING]    org.hamcrest:hamcrest:jar:2.2:test
[WARNING]    org.springframework:spring-test:jar:6.0.7:test
[WARNING]    jakarta.persistence:jakarta.persistence-api:jar:3.1.0:compile
[WARNING]    org.springframework.boot:spring-boot-test-autoconfigure:jar:3.0.5:test
[WARNING]    org.springframework:spring-orm:jar:6.0.7:compile
[WARNING]    jakarta.transaction:jakarta.transaction-api:jar:2.0.1:compile
[WARNING]    org.springframework:spring-context:jar:6.0.7:compile
[WARNING]    jakarta.inject:jakarta.inject-api:jar:2.0.0:compile
[WARNING]    org.hibernate.orm:hibernate-core:jar:6.1.7.Final:compile
[WARNING] Unused declared dependencies found:
[WARNING]    org.springframework.boot:spring-boot-starter-data-jpa:jar:3.0.5:compile
[WARNING]    org.hibernate.orm:hibernate-community-dialects:jar:6.1.7.Final:runtime
[WARNING]    p6spy:p6spy:jar:3.9.1:runtime
[WARNING]    org.xerial:sqlite-jdbc:jar:3.41.2.1:runtime
[WARNING]    org.springframework.boot:spring-boot-starter-test:jar:3.0.5:test
[WARNING]    org.projectlombok:lombok:jar:1.18.24:provided
[WARNING]    org.slf4j:jcl-over-slf4j:jar:2.0.7:runtime
[WARNING]    org.slf4j:jul-to-slf4j:jar:2.0.7:runtime
[WARNING]    it.tidalwave.thesefoolishthings:it-tidalwave-util-test:jar:3.2-ALPHA-21:test
[WARNING]    org.hamcrest:hamcrest-all:jar:1.3:test
[WARNING]    org.mockito:mockito-core:jar:4.8.1:test
[WARNING]    ch.qos.logback:logback-classic:jar:1.4.7:test
[WARNING] Non-test scoped test only dependencies found:
[WARNING]    org.springframework.boot:spring-boot:jar:3.0.5:compile
[WARNING]    org.springframework.data:spring-data-jpa:jar:3.0.4:compile
[WARNING]    org.springframework.boot:spring-boot-autoconfigure:jar:3.0.5:compile
[WARNING]    org.springframework:spring-orm:jar:6.0.7:compile
[WARNING]    jakarta.inject:jakarta.inject-api:jar:2.0.0:compile
[JENKINS] Archiving disabled
Started calculate disk usage of build
Finished Calculation of disk usage of build in 0 seconds
Started calculate disk usage of workspace
Finished Calculation of disk usage of workspace in 0 seconds
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary for SolidBlue III 1.1-SNAPSHOT:
[INFO] 
[INFO] SolidBlue III ...................................... SUCCESS [  8.590 s]
[INFO] SolidBlue III (modules) ............................ SUCCESS [  1.732 s]
[INFO] SolidBlue III :: Commons ........................... SUCCESS [  9.426 s]
[INFO] SolidBlue III :: Model ............................. SUCCESS [ 32.181 s]
[INFO] SolidBlue III :: Dao ............................... SUCCESS [01:15 min]
[INFO] SolidBlue III :: Application no GUI ................ SUCCESS [ 48.610 s]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time:  03:08 min
[INFO] Finished at: 2023-04-27T05:00:26Z
[INFO] ------------------------------------------------------------------------
[WARNING] The requested profile "installers" could not be activated because it does not exist.
[JENKINS] Archiving disabled