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: d9a7d70e7240 at timestamp: 1682744306358
[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 d9a7d70e7240
[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:46.876 [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:47.591 [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.923 [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.957 [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:48.021 [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:48.063 [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:48.201 [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.579 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Starting FingerprintEntityTest using Java 17.0.6 with PID 476157 (/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.580 [main ] DEBUG i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Running with Spring Boot v3.0.5, Spring v6.0.7
04:58:51.581 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - The following 1 profile is active: "test"
04:58:51.653 [main ] TRACE o.s.boot.context.config.ConfigDataLoaders - Loading file [.] using loader org.springframework.boot.context.config.StandardConfigDataLoader
04:58:51.654 [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.655 [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:53.526 [main ] INFO o.s.d.r.config.RepositoryConfigurationDelegate - Bootstrapping Spring Data JPA repositories in DEFAULT mode.
04:58:53.853 [main ] INFO o.s.d.r.config.RepositoryConfigurationDelegate - Finished Spring Data repository scanning in 285 ms. Found 1 JPA repository interfaces.
04:58:55.889 [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:56.212 [main ] DEBUG org.jboss.logging - Logging Provider: org.jboss.logging.Slf4jLoggerProvider found via system property
04:58:56.532 [main ] INFO org.hibernate.jpa.internal.util.LogHelper - HHH000204: Processing PersistenceUnitInfo [name: default]
04:58:57.082 [main ] INFO org.hibernate.Version - HHH000412: Hibernate ORM core version 6.1.7.Final
04:58:59.238 [main ] DEBUG com.zaxxer.hikari.HikariConfig - HikariPool-1 - configuration:
04:58:59.261 [main ] DEBUG com.zaxxer.hikari.HikariConfig - allowPoolSuspension.............false
04:58:59.262 [main ] DEBUG com.zaxxer.hikari.HikariConfig - autoCommit......................true
04:58:59.268 [main ] DEBUG com.zaxxer.hikari.HikariConfig - catalog.........................none
04:58:59.268 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionInitSql...............none
04:58:59.269 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionTestQuery.............none
04:58:59.269 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionTimeout...............30000
04:58:59.269 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSource......................none
04:58:59.269 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceClassName.............none
04:58:59.269 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceJNDI..................none
04:58:59.270 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceProperties............{password=<masked>}
04:58:59.270 [main ] DEBUG com.zaxxer.hikari.HikariConfig - driverClassName................."com.p6spy.engine.spy.P6SpyDriver"
04:58:59.271 [main ] DEBUG com.zaxxer.hikari.HikariConfig - exceptionOverrideClassName......none
04:58:59.279 [main ] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckProperties...........{}
04:58:59.280 [main ] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckRegistry.............none
04:58:59.280 [main ] DEBUG com.zaxxer.hikari.HikariConfig - idleTimeout.....................600000
04:58:59.280 [main ] DEBUG com.zaxxer.hikari.HikariConfig - initializationFailTimeout.......1
04:58:59.281 [main ] DEBUG com.zaxxer.hikari.HikariConfig - isolateInternalQueries..........false
04:58:59.288 [main ] DEBUG com.zaxxer.hikari.HikariConfig - jdbcUrl.........................jdbc:p6spy:sqlite:target/test1.db
04:58:59.291 [main ] DEBUG com.zaxxer.hikari.HikariConfig - keepaliveTime...................0
04:58:59.291 [main ] DEBUG com.zaxxer.hikari.HikariConfig - leakDetectionThreshold..........0
04:58:59.291 [main ] DEBUG com.zaxxer.hikari.HikariConfig - maxLifetime.....................1800000
04:58:59.291 [main ] DEBUG com.zaxxer.hikari.HikariConfig - maximumPoolSize.................10
04:58:59.291 [main ] DEBUG com.zaxxer.hikari.HikariConfig - metricRegistry..................none
04:58:59.292 [main ] DEBUG com.zaxxer.hikari.HikariConfig - metricsTrackerFactory...........none
04:58:59.296 [main ] DEBUG com.zaxxer.hikari.HikariConfig - minimumIdle.....................10
04:58:59.297 [main ] DEBUG com.zaxxer.hikari.HikariConfig - password........................<masked>
04:58:59.297 [main ] DEBUG com.zaxxer.hikari.HikariConfig - poolName........................"HikariPool-1"
04:58:59.297 [main ] DEBUG com.zaxxer.hikari.HikariConfig - readOnly........................false
04:58:59.297 [main ] DEBUG com.zaxxer.hikari.HikariConfig - registerMbeans..................false
04:58:59.298 [main ] DEBUG com.zaxxer.hikari.HikariConfig - scheduledExecutor...............none
04:58:59.300 [main ] DEBUG com.zaxxer.hikari.HikariConfig - schema..........................none
04:58:59.300 [main ] DEBUG com.zaxxer.hikari.HikariConfig - threadFactory...................internal
04:58:59.300 [main ] DEBUG com.zaxxer.hikari.HikariConfig - transactionIsolation............default
04:58:59.300 [main ] DEBUG com.zaxxer.hikari.HikariConfig - username........................none
04:58:59.301 [main ] DEBUG com.zaxxer.hikari.HikariConfig - validationTimeout...............5000
04:58:59.301 [main ] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
04:59:00.310 [main ] INFO com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@33544cc5
04:59:00.336 [main ] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
04:59:00.425 [riPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=1, active=1, idle=0, waiting=0)
04:59:00.459 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@205fac2f
04:59:00.470 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@2e984654
04:59:00.482 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@2aa7c75f
04:59:00.493 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@6fa54c6f
04:59:00.520 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@32c6ab60
04:59:00.525 [main ] INFO SQL dialect - HHH000400: Using dialect: org.hibernate.community.dialect.SQLiteDialect
04:59:00.531 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@5e80e18a
04:59:00.542 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@4a09583a
04:59:00.553 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@f8ab320
04:59:00.565 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@810941a
04:59:00.575 [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:07.027 [main ] INFO p6spy - SQL: 1 nanos - drop table if exists files
Hibernate: drop table if exists fingerprints
04:59:07.030 [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:07.118 [main ] INFO p6spy - SQL: 44 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:07.170 [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:07.173 [main ] INFO o.h.e.t.jta.platform.internal.JtaPlatformInitiator - HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
04:59:07.277 [main ] INFO o.s.orm.jpa.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default'
04:59:09.579 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Started FingerprintEntityTest in 20.822 seconds (process running for 28.389)
04:59:09.772 [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.780 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:09.784 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(168919324<open>)] for JPA transaction
04:59:09.812 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@4aa0b026]
04:59:10.847 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - *******************************
04:59:10.848 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - TEST "test equals and hashcode"
04:59:10.848 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - *******************************
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
04:59:11.191 [main ] INFO p6spy - SQL: 16 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('', '', '', '2023-04-29T04:59:10.872+0000', '', 'id')
04:59:11.247 [main ] INFO p6spy - SQL: 51 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:11.439 [main ] INFO p6spy - SQL: 7 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:11.481 [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:11.498 [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:11.508 [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:11.531 [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:11.534 [main ] INFO p6spy - SQL: 0 nanos - update fingerprints set algorithm='', file_id='', name='', timestamp='2023-04-29T04:59:10.872+0000', fingerprint='' where id='id'
04:59:11.537 [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:11.550 [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:11.553 [main ] INFO p6spy - SQL: 0 nanos - update fingerprints set algorithm='', file_id='', name='', timestamp='2023-04-29T04:59:10.872+0000', fingerprint='' where id='id'
04:59:11.554 [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:11.557 [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:11.562 [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:11.568 [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:11.569 [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:11.580 [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:11.584 [main ] INFO p6spy - SQL: 0 nanos - delete from fingerprints where id='id'
04:59:11.653 [main ] INFO p6spy - SQL: 66 nanos -
04:59:11.659 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - TEST PASSED in 808 msec
04:59:11.660 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest -
04:59:11.688 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
04:59:11.689 [main ] WARN i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
04:59:11.689 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(168919324<open>)]
04:59:11.690 [main ] INFO p6spy - SQL: 0 nanos -
04:59:11.694 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(168919324<open>)] after transaction
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v3.0.5)
04:59:11.894 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Starting JpaDataManagerDaoTest using Java 17.0.6 with PID 476157 (/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.895 [main ] DEBUG i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Running with Spring Boot v3.0.5, Spring v6.0.7
04:59:11.895 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - No active profile set, falling back to 1 default profile: "default"
04:59:11.904 [main ] TRACE o.s.boot.context.config.ConfigDataLoaders - Loading file [.] using loader org.springframework.boot.context.config.StandardConfigDataLoader
04:59:11.905 [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.907 [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:12.199 [main ] INFO o.s.d.r.config.RepositoryConfigurationDelegate - Bootstrapping Spring Data JPA repositories in DEFAULT mode.
04:59:12.243 [main ] INFO o.s.d.r.config.RepositoryConfigurationDelegate - Finished Spring Data repository scanning in 43 ms. Found 1 JPA repository interfaces.
04:59:12.483 [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.628 [main ] INFO org.hibernate.jpa.internal.util.LogHelper - HHH000204: Processing PersistenceUnitInfo [name: default]
04:59:12.663 [main ] DEBUG com.zaxxer.hikari.HikariConfig - HikariPool-2 - configuration:
04:59:12.672 [main ] DEBUG com.zaxxer.hikari.HikariConfig - allowPoolSuspension.............false
04:59:12.673 [main ] DEBUG com.zaxxer.hikari.HikariConfig - autoCommit......................true
04:59:12.673 [main ] DEBUG com.zaxxer.hikari.HikariConfig - catalog.........................none
04:59:12.673 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionInitSql...............none
04:59:12.674 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionTestQuery.............none
04:59:12.675 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionTimeout...............30000
04:59:12.675 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSource......................none
04:59:12.679 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceClassName.............none
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceJNDI..................none
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceProperties............{password=<masked>}
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - driverClassName................."com.p6spy.engine.spy.P6SpyDriver"
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - exceptionOverrideClassName......none
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckProperties...........{}
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckRegistry.............none
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - idleTimeout.....................600000
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - initializationFailTimeout.......1
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - isolateInternalQueries..........false
04:59:12.680 [main ] DEBUG com.zaxxer.hikari.HikariConfig - jdbcUrl.........................jdbc:p6spy:sqlite:target/test1.db
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - keepaliveTime...................0
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - leakDetectionThreshold..........0
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - maxLifetime.....................1800000
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - maximumPoolSize.................10
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - metricRegistry..................none
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - metricsTrackerFactory...........none
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - minimumIdle.....................10
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - password........................<masked>
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - poolName........................"HikariPool-2"
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - readOnly........................false
04:59:12.681 [main ] DEBUG com.zaxxer.hikari.HikariConfig - registerMbeans..................false
04:59:12.682 [main ] DEBUG com.zaxxer.hikari.HikariConfig - scheduledExecutor...............none
04:59:12.682 [main ] DEBUG com.zaxxer.hikari.HikariConfig - schema..........................none
04:59:12.682 [main ] DEBUG com.zaxxer.hikari.HikariConfig - threadFactory...................internal
04:59:12.682 [main ] DEBUG com.zaxxer.hikari.HikariConfig - transactionIsolation............default
04:59:12.682 [main ] DEBUG com.zaxxer.hikari.HikariConfig - username........................none
04:59:12.684 [main ] DEBUG com.zaxxer.hikari.HikariConfig - validationTimeout...............5000
04:59:12.684 [main ] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-2 - Starting...
04:59:12.686 [main ] INFO com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@285836c9
04:59:12.686 [main ] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-2 - Start completed.
04:59:12.686 [main ] INFO SQL dialect - HHH000400: Using dialect: org.hibernate.community.dialect.SQLiteDialect
04:59:12.786 [riPool-2 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Pool stats (total=1, active=0, idle=1, waiting=0)
04:59:12.794 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@266ef254
04:59:12.814 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@28a908e9
04:59:12.826 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@2c969924
04:59:12.837 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@699402d2
04:59:12.848 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@3839b1e6
04:59:12.859 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@58370848
04:59:12.874 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@4070e5d3
04:59:12.885 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@9bbfd9d
04:59:12.897 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@7c78cbcd
04:59:12.907 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - After adding stats (total=10, active=0, idle=10, waiting=0)
Hibernate: drop table if exists files
04:59:13.025 [main ] INFO p6spy - SQL: 60 nanos - drop table if exists files
Hibernate: drop table if exists fingerprints
04:59:13.072 [main ] INFO p6spy - SQL: 46 nanos - drop table if exists fingerprints
Hibernate: create table files (id varchar(36) not null, path text not null, primary key (id))
04:59:13.116 [main ] INFO p6spy - SQL: 42 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:13.178 [main ] INFO p6spy - SQL: 61 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:13.179 [main ] INFO o.h.e.t.jta.platform.internal.JtaPlatformInitiator - HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
04:59:13.179 [main ] INFO o.s.orm.jpa.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default'
04:59:13.539 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Started JpaDataManagerDaoTest in 1.823 seconds (process running for 32.349)
04:59:13.583 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - ****************************
04:59:13.583 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - TEST "test findManagedFiles"
04:59:13.583 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - ****************************
Hibernate: insert into files (path, id) values (?, ?)
04:59:13.769 [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.785 [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.797 [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.799 [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.805 [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.811 [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.819 [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.822 [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.823 [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.835 [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.840 [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.845 [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.847 [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.852 [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.861 [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.867 [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.874 [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.891 [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.900 [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.903 [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.906 [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.915 [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.919 [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.920 [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-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.925 [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.926 [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.933 [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.942 [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.947 [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.983 [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.984 [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.984 [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.985 [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.986 [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.988 [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.993 [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.993 [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.999 [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:14.005 [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:14.006 [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:14.010 [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:14.011 [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:14.012 [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:14.022 [main ] INFO p6spy - SQL: 0 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:14.027 [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:14.028 [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:14.114 [main ] INFO p6spy - SQL: 82 nanos -
04:59:14.149 [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:14.210 [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:14.221 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:14.221 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1214557610<open>)] for JPA transaction
04:59:14.222 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@38d87d]
04:59:14.239 [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.909 [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.952 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 10 items
04:59:14.953 [main ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning [ManagedFileEntity@a362681(id=00000008-0000-0000-0000-000000000000, path=/foo/bar/2e10, fingerprints=not initialized), ManagedFileEntity@38f005ee(id=00000029-0000-0000-0000-000000000000, path=/foo/bar/32cc, fingerprints=not initialized), ManagedFileEntity@4465567c(id=00000022-0000-0000-0000-000000000000, path=/foo/bar/34c3, fingerprints=not initialized), ManagedFileEntity@3bd1d3ae(id=00000010-0000-0000-0000-000000000000, path=/foo/bar/3f38, fingerprints=not initialized), ManagedFileEntity@4900e064(id=0000002c-0000-0000-0000-000000000000, path=/foo/bar/5252, fingerprints=not initialized), ManagedFileEntity@4c3584c2(id=00000027-0000-0000-0000-000000000000, path=/foo/bar/5712, fingerprints=not initialized), ManagedFileEntity@61018d1c(id=00000015-0000-0000-0000-000000000000, path=/foo/bar/67a2, fingerprints=not initialized), ManagedFileEntity@1b8336b6(id=0000000b-0000-0000-0000-000000000000, path=/foo/bar/7d46, fingerprints=not initialized), ManagedFileEntity@3b5c6eee(id=00000000-0000-0000-0000-000000000000, path=/foo/bar/e047, fingerprints=not initialized), ManagedFileEntity@47120b41(id=0000001c-0000-0000-0000-000000000000, path=/foo/bar/f228, fingerprints=not initialized)]
04:59:14.973 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:14.973 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:14.974 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1214557610<open>)]
04:59:14.994 [main ] INFO p6spy - SQL: 0 nanos -
04:59:14.995 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1214557610<open>)] after transaction
04:59:15.020 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Asserting that lazy collection of fingerprints not fetched yet...
04:59:15.021 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Triggering lazy fetch...
04:59:15.022 [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:15.023 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.023 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(49424644<open>)] for JPA transaction
04:59:15.023 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@7ac71b01]
04:59:15.023 [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:15.025 [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:15.045 [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:15.088 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 2 items
04:59:15.088 [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:15.104 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.115 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.115 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(49424644<open>)]
04:59:15.116 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.117 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(49424644<open>)] after transaction
04:59:15.122 [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:15.122 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.122 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(566048876<open>)] for JPA transaction
04:59:15.124 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@33581a91]
04:59:15.124 [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:15.125 [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:15.132 [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='00000029-0000-0000-0000-000000000000' order by f1_0.timestamp asc
04:59:15.134 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 2 items
04:59:15.134 [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:15.135 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.135 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.135 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(566048876<open>)]
04:59:15.143 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.143 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(566048876<open>)] after transaction
04:59:15.147 [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:15.147 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.147 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(162102530<open>)] for JPA transaction
04:59:15.148 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@8976a3c]
04:59:15.148 [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:15.149 [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:15.157 [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:15.165 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 4 items
04:59:15.165 [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:15.165 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.166 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.166 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(162102530<open>)]
04:59:15.174 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.175 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(162102530<open>)] after transaction
04:59:15.175 [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:15.175 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.175 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(335796066<open>)] for JPA transaction
04:59:15.181 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@4de665b7]
04:59:15.181 [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:15.184 [main ] INFO p6spy - SQL: 2 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:15.204 [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:15.209 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 4 items
04:59:15.209 [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:15.209 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.210 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.210 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(335796066<open>)]
04:59:15.212 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.213 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(335796066<open>)] after transaction
04:59:15.214 [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:15.214 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.214 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1985913260<open>)] for JPA transaction
04:59:15.214 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@38cac3f9]
04:59:15.220 [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:15.222 [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:15.224 [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:15.229 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 1 items
04:59:15.229 [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:15.230 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.230 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.230 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1985913260<open>)]
04:59:15.231 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.232 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1985913260<open>)] after transaction
04:59:15.233 [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:15.233 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.234 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(373408086<open>)] for JPA transaction
04:59:15.234 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@1db89221]
04:59:15.234 [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:15.235 [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:15.241 [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:15.242 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 1 items
04:59:15.247 [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:15.248 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.248 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.248 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(373408086<open>)]
04:59:15.249 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.250 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(373408086<open>)] after transaction
04:59:15.250 [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:15.251 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.251 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(2133672993<open>)] for JPA transaction
04:59:15.254 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@48a8a298]
04:59:15.255 [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:15.260 [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:15.262 [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:15.284 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 6 items
04:59:15.285 [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:15.285 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.285 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.285 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(2133672993<open>)]
04:59:15.287 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.287 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(2133672993<open>)] after transaction
04:59:15.288 [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:15.288 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.288 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(991060461<open>)] for JPA transaction
04:59:15.288 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@23fd9be1]
04:59:15.289 [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:15.295 [main ] INFO p6spy - SQL: 4 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:15.299 [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:15.307 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 4 items
04:59:15.307 [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:15.307 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.307 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.307 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(991060461<open>)]
04:59:15.319 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.320 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(991060461<open>)] after transaction
04:59:15.320 [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:15.320 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.321 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1831718271<open>)] for JPA transaction
04:59:15.322 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@41ed3d2a]
04:59:15.322 [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:15.323 [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:15.325 [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:15.352 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 7 items
04:59:15.352 [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:15.352 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.352 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.352 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1831718271<open>)]
04:59:15.356 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.357 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1831718271<open>)] after transaction
04:59:15.360 [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:15.360 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.360 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1148816769<open>)] for JPA transaction
04:59:15.360 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@605d67f8]
04:59:15.360 [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:15.362 [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:15.373 [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:15.379 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 5 items
04:59:15.379 [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:15.379 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
04:59:15.379 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
04:59:15.379 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1148816769<open>)]
04:59:15.385 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.385 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1148816769<open>)] after transaction
04:59:15.385 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Actual result:
04:59:15.388 [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:15.408 [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:15.408 [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:15.408 [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:15.408 [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:15.408 [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:15.408 [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:15.408 [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:15.408 [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:15.408 [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:15.444 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - TEST PASSED in 1861 msec
04:59:15.444 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -
04:59:15.502 [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:15.502 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.502 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(785445868<open>)] for JPA transaction
04:59:15.510 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@64ea9235]
04:59:15.514 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
04:59:15.515 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test equals and hashCode"
04:59:15.515 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
Hibernate: insert into files (path, id) values (?, ?)
04:59:15.531 [main ] INFO p6spy - SQL: 0 nanos - insert into files (path, id) values ('path', 'id')
04:59:15.589 [main ] INFO p6spy - SQL: 53 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.591 [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.592 [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.594 [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.595 [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.596 [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.602 [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.603 [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.619 [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.620 [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.621 [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.622 [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.628 [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.637 [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.651 [main ] INFO p6spy - SQL: 5 nanos - delete from files where id='id'
04:59:15.707 [main ] INFO p6spy - SQL: 53 nanos -
04:59:15.708 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 194 msec
04:59:15.708 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest -
04:59:15.713 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
04:59:15.713 [main ] WARN i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
04:59:15.713 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(785445868<open>)]
04:59:15.713 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.713 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(785445868<open>)] after transaction
04:59:15.723 [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.724 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
04:59:15.724 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(419534865<open>)] for JPA transaction
04:59:15.724 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@5639a80c]
04:59:15.734 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
04:59:15.734 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test toString with proxy"
04:59:15.734 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
Hibernate: insert into files (path, id) values (?, ?)
04:59:15.751 [main ] INFO p6spy - SQL: 0 nanos - insert into files (path, id) values ('path', 'id2')
04:59:15.803 [main ] INFO p6spy - SQL: 51 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
04:59:15.805 [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.807 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.810 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 74 msec
04:59:15.810 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest -
04:59:15.826 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
04:59:15.827 [main ] WARN i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
04:59:15.827 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(419534865<open>)]
04:59:15.827 [main ] INFO p6spy - SQL: 0 nanos -
04:59:15.835 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(419534865<open>)] after transaction
04:59:15.842 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - **********************************
04:59:15.842 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test toString without proxy"
04:59:15.842 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - **********************************
04:59:15.850 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 6 msec
04:59:15.850 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest -
04:59:15.860 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Should roll back transaction but cannot - no transaction available
04:59:15.874 [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: 33.438 s - in TestSuite
04:59:16.369 [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.d9a7d70e7240.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.d9a7d70e7240-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.d9a7d70e7240.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.d9a7d70e7240-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: d9a7d70e7240 at timestamp: 1682744358313
[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 d9a7d70e7240
[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
[JENKINS] Archiving disabled
[INFO] ------------------------------------------------------------------------
[INFO] Reactor Summary for SolidBlue III 1.1-SNAPSHOT:
[INFO]
[INFO] SolidBlue III ...................................... SUCCESS [ 7.936 s]
[INFO] SolidBlue III (modules) ............................ SUCCESS [ 1.912 s]
[INFO] SolidBlue III :: Commons ........................... SUCCESS [ 10.563 s]
[INFO] SolidBlue III :: Model ............................. SUCCESS [ 27.689 s]
[INFO] SolidBlue III :: Dao ............................... SUCCESS [01:07 min]
[INFO] SolidBlue III :: Application no GUI ................ SUCCESS [ 42.413 s]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 02:47 min
[INFO] Finished at: 2023-04-29T05:00:18Z
[INFO] ------------------------------------------------------------------------
[WARNING] The requested profile "installers" could not be activated because it does not exist.