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: 6332a4670def at timestamp: 1682804865755
[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 6332a4670def
[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
21:47:54.077 [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.
21:47:54.465 [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
21:47:54.606 [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.
21:47:54.614 [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
21:47:54.631 [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.
21:47:54.643 [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
21:47:54.702 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - STARTING TESTS OF it.tidalwave.datamanager.dao.impl.jpa.FingerprintEntityTest
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v3.0.5)
21:47:55.897 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Starting FingerprintEntityTest using Java 17.0.6 with PID 669022 (/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)
21:47:55.898 [main ] DEBUG i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Running with Spring Boot v3.0.5, Spring v6.0.7
21:47:55.898 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - The following 1 profile is active: "test"
21:47:55.926 [main ] TRACE o.s.boot.context.config.ConfigDataLoaders - Loading file [.] using loader org.springframework.boot.context.config.StandardConfigDataLoader
21:47:55.926 [main ] TRACE o.s.boot.context.config.ConfigDataLoaders - Loading class path resource [config/module-test.yml] using loader org.springframework.boot.context.config.StandardConfigDataLoader
21:47:55.926 [main ] TRACE o.s.boot.context.config.ConfigDataLoaders - Loading class path resource [config/module.yml] using loader org.springframework.boot.context.config.StandardConfigDataLoader
21:47:56.686 [main ] INFO o.s.d.r.config.RepositoryConfigurationDelegate - Bootstrapping Spring Data JPA repositories in DEFAULT mode.
21:47:56.799 [main ] INFO o.s.d.r.config.RepositoryConfigurationDelegate - Finished Spring Data repository scanning in 96 ms. Found 1 JPA repository interfaces.
21:47:57.407 [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
21:47:57.578 [main ] DEBUG org.jboss.logging - Logging Provider: org.jboss.logging.Slf4jLoggerProvider found via system property
21:47:57.724 [main ] INFO org.hibernate.jpa.internal.util.LogHelper - HHH000204: Processing PersistenceUnitInfo [name: default]
21:47:57.970 [main ] INFO org.hibernate.Version - HHH000412: Hibernate ORM core version 6.1.7.Final
21:47:58.626 [main ] DEBUG com.zaxxer.hikari.HikariConfig - HikariPool-1 - configuration:
21:47:58.629 [main ] DEBUG com.zaxxer.hikari.HikariConfig - allowPoolSuspension.............false
21:47:58.630 [main ] DEBUG com.zaxxer.hikari.HikariConfig - autoCommit......................true
21:47:58.630 [main ] DEBUG com.zaxxer.hikari.HikariConfig - catalog.........................none
21:47:58.630 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionInitSql...............none
21:47:58.631 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionTestQuery.............none
21:47:58.631 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionTimeout...............30000
21:47:58.631 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSource......................none
21:47:58.631 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceClassName.............none
21:47:58.631 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceJNDI..................none
21:47:58.632 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceProperties............{password=<masked>}
21:47:58.632 [main ] DEBUG com.zaxxer.hikari.HikariConfig - driverClassName................."com.p6spy.engine.spy.P6SpyDriver"
21:47:58.632 [main ] DEBUG com.zaxxer.hikari.HikariConfig - exceptionOverrideClassName......none
21:47:58.633 [main ] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckProperties...........{}
21:47:58.633 [main ] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckRegistry.............none
21:47:58.633 [main ] DEBUG com.zaxxer.hikari.HikariConfig - idleTimeout.....................600000
21:47:58.633 [main ] DEBUG com.zaxxer.hikari.HikariConfig - initializationFailTimeout.......1
21:47:58.633 [main ] DEBUG com.zaxxer.hikari.HikariConfig - isolateInternalQueries..........false
21:47:58.634 [main ] DEBUG com.zaxxer.hikari.HikariConfig - jdbcUrl.........................jdbc:p6spy:sqlite:target/test1.db
21:47:58.634 [main ] DEBUG com.zaxxer.hikari.HikariConfig - keepaliveTime...................0
21:47:58.634 [main ] DEBUG com.zaxxer.hikari.HikariConfig - leakDetectionThreshold..........0
21:47:58.634 [main ] DEBUG com.zaxxer.hikari.HikariConfig - maxLifetime.....................1800000
21:47:58.634 [main ] DEBUG com.zaxxer.hikari.HikariConfig - maximumPoolSize.................10
21:47:58.635 [main ] DEBUG com.zaxxer.hikari.HikariConfig - metricRegistry..................none
21:47:58.635 [main ] DEBUG com.zaxxer.hikari.HikariConfig - metricsTrackerFactory...........none
21:47:58.635 [main ] DEBUG com.zaxxer.hikari.HikariConfig - minimumIdle.....................10
21:47:58.635 [main ] DEBUG com.zaxxer.hikari.HikariConfig - password........................<masked>
21:47:58.635 [main ] DEBUG com.zaxxer.hikari.HikariConfig - poolName........................"HikariPool-1"
21:47:58.636 [main ] DEBUG com.zaxxer.hikari.HikariConfig - readOnly........................false
21:47:58.636 [main ] DEBUG com.zaxxer.hikari.HikariConfig - registerMbeans..................false
21:47:58.636 [main ] DEBUG com.zaxxer.hikari.HikariConfig - scheduledExecutor...............none
21:47:58.637 [main ] DEBUG com.zaxxer.hikari.HikariConfig - schema..........................none
21:47:58.637 [main ] DEBUG com.zaxxer.hikari.HikariConfig - threadFactory...................internal
21:47:58.637 [main ] DEBUG com.zaxxer.hikari.HikariConfig - transactionIsolation............default
21:47:58.637 [main ] DEBUG com.zaxxer.hikari.HikariConfig - username........................none
21:47:58.638 [main ] DEBUG com.zaxxer.hikari.HikariConfig - validationTimeout...............5000
21:47:58.638 [main ] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
21:47:59.031 [main ] INFO com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@2f19ab6
21:47:59.035 [main ] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
21:47:59.107 [main ] INFO SQL dialect - HHH000400: Using dialect: org.hibernate.community.dialect.SQLiteDialect
21:47:59.135 [riPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=1, active=1, idle=0, waiting=0)
21:47:59.141 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@52497a92
21:47:59.156 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@5c8e8eab
21:47:59.168 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@58b111e2
21:47:59.179 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@1db38490
21:47:59.190 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@437e05e
21:47:59.202 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@2c64dda5
21:47:59.213 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@7c0ae7ca
21:47:59.224 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@7d9c7bdf
21:47:59.235 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@46925122
21:47:59.246 [l-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - After adding stats (total=10, active=0, idle=10, waiting=0)
Hibernate: drop table if exists files
21:48:00.785 [main ] INFO p6spy - SQL: 1 nanos - drop table if exists files
Hibernate: drop table if exists fingerprints
21:48:00.787 [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))
21:48:00.853 [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))
21:48:00.914 [main ] INFO p6spy - SQL: 58 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))
21:48:00.922 [main ] INFO o.h.e.t.jta.platform.internal.JtaPlatformInitiator - HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
21:48:00.943 [main ] INFO o.s.orm.jpa.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default'
21:48:01.533 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - Started FingerprintEntityTest in 6.655 seconds (process running for 9.763)
21:48:01.570 [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
21:48:01.571 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:01.572 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1103244633<open>)] for JPA transaction
21:48:01.579 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@720907c9]
21:48:02.007 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - *******************************
21:48:02.007 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - TEST "test equals and hashcode"
21:48:02.008 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - *******************************
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
21:48:02.105 [main ] INFO p6spy - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('', '', '', '2023-04-29T21:48:02.015+0000', '', 'id')
21:48:02.168 [main ] INFO p6spy - SQL: 58 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=?
21:48:02.263 [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'
21:48:02.287 [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=?
21:48:02.293 [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'
21:48:02.295 [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=?
21:48:02.303 [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=?
21:48:02.306 [main ] INFO p6spy - SQL: 0 nanos - update fingerprints set algorithm='', file_id='', name='', timestamp='2023-04-29T21:48:02.015+0000', fingerprint='' where id='id'
21:48:02.309 [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=?
21:48:02.311 [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=?
21:48:02.313 [main ] INFO p6spy - SQL: 0 nanos - update fingerprints set algorithm='', file_id='', name='', timestamp='2023-04-29T21:48:02.015+0000', fingerprint='' where id='id'
21:48:02.313 [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=?
21:48:02.316 [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'
21:48:02.317 [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=?
21:48:02.319 [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'
21:48:02.321 [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=?
21:48:02.325 [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=?
21:48:02.328 [main ] INFO p6spy - SQL: 0 nanos - delete from fingerprints where id='id'
21:48:02.387 [main ] INFO p6spy - SQL: 54 nanos -
21:48:02.396 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest - TEST PASSED in 385 msec
21:48:02.397 [main ] INFO i.t.datamanager.dao.impl.jpa.FingerprintEntityTest -
21:48:02.407 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
21:48:02.407 [main ] WARN i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
21:48:02.407 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(1103244633<open>)]
21:48:02.409 [main ] INFO p6spy - SQL: 0 nanos -
21:48:02.412 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1103244633<open>)] after transaction
. ____ _ __ _ _
/\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
\\/ ___)| |_)| | | | | || (_| | ) ) ) )
' |____| .__|_| |_|_| |_\__, | / / / /
=========|_|==============|___/=/_/_/_/
:: Spring Boot :: (v3.0.5)
21:48:02.518 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Starting JpaDataManagerDaoTest using Java 17.0.6 with PID 669022 (/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)
21:48:02.519 [main ] DEBUG i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Running with Spring Boot v3.0.5, Spring v6.0.7
21:48:02.519 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - No active profile set, falling back to 1 default profile: "default"
21:48:02.523 [main ] TRACE o.s.boot.context.config.ConfigDataLoaders - Loading file [.] using loader org.springframework.boot.context.config.StandardConfigDataLoader
21:48:02.523 [main ] TRACE o.s.boot.context.config.ConfigDataLoaders - Loading class path resource [config/module-test.yml] using loader org.springframework.boot.context.config.StandardConfigDataLoader
21:48:02.523 [main ] TRACE o.s.boot.context.config.ConfigDataLoaders - Loading class path resource [config/module.yml] using loader org.springframework.boot.context.config.StandardConfigDataLoader
21:48:02.636 [main ] INFO o.s.d.r.config.RepositoryConfigurationDelegate - Bootstrapping Spring Data JPA repositories in DEFAULT mode.
21:48:02.653 [main ] INFO o.s.d.r.config.RepositoryConfigurationDelegate - Finished Spring Data repository scanning in 16 ms. Found 1 JPA repository interfaces.
21:48:02.735 [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
21:48:02.805 [main ] INFO org.hibernate.jpa.internal.util.LogHelper - HHH000204: Processing PersistenceUnitInfo [name: default]
21:48:02.820 [main ] DEBUG com.zaxxer.hikari.HikariConfig - HikariPool-2 - configuration:
21:48:02.821 [main ] DEBUG com.zaxxer.hikari.HikariConfig - allowPoolSuspension.............false
21:48:02.822 [main ] DEBUG com.zaxxer.hikari.HikariConfig - autoCommit......................true
21:48:02.822 [main ] DEBUG com.zaxxer.hikari.HikariConfig - catalog.........................none
21:48:02.822 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionInitSql...............none
21:48:02.823 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionTestQuery.............none
21:48:02.823 [main ] DEBUG com.zaxxer.hikari.HikariConfig - connectionTimeout...............30000
21:48:02.823 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSource......................none
21:48:02.828 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceClassName.............none
21:48:02.828 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceJNDI..................none
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - dataSourceProperties............{password=<masked>}
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - driverClassName................."com.p6spy.engine.spy.P6SpyDriver"
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - exceptionOverrideClassName......none
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckProperties...........{}
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - healthCheckRegistry.............none
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - idleTimeout.....................600000
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - initializationFailTimeout.......1
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - isolateInternalQueries..........false
21:48:02.829 [main ] DEBUG com.zaxxer.hikari.HikariConfig - jdbcUrl.........................jdbc:p6spy:sqlite:target/test1.db
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - keepaliveTime...................0
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - leakDetectionThreshold..........0
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - maxLifetime.....................1800000
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - maximumPoolSize.................10
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - metricRegistry..................none
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - metricsTrackerFactory...........none
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - minimumIdle.....................10
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - password........................<masked>
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - poolName........................"HikariPool-2"
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - readOnly........................false
21:48:02.830 [main ] DEBUG com.zaxxer.hikari.HikariConfig - registerMbeans..................false
21:48:02.831 [main ] DEBUG com.zaxxer.hikari.HikariConfig - scheduledExecutor...............none
21:48:02.831 [main ] DEBUG com.zaxxer.hikari.HikariConfig - schema..........................none
21:48:02.831 [main ] DEBUG com.zaxxer.hikari.HikariConfig - threadFactory...................internal
21:48:02.831 [main ] DEBUG com.zaxxer.hikari.HikariConfig - transactionIsolation............default
21:48:02.831 [main ] DEBUG com.zaxxer.hikari.HikariConfig - username........................none
21:48:02.831 [main ] DEBUG com.zaxxer.hikari.HikariConfig - validationTimeout...............5000
21:48:02.831 [main ] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-2 - Starting...
21:48:02.834 [main ] INFO com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@4b672ced
21:48:02.834 [main ] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-2 - Start completed.
21:48:02.836 [main ] INFO SQL dialect - HHH000400: Using dialect: org.hibernate.community.dialect.SQLiteDialect
21:48:02.935 [riPool-2 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Pool stats (total=1, active=0, idle=1, waiting=0)
Hibernate: drop table if exists files
21:48:02.939 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@4c88faae
21:48:02.951 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@424f0d4f
21:48:02.963 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@467091de
21:48:02.975 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@3720774
21:48:02.987 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@824c03e
21:48:02.999 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@32bb8100
21:48:03.011 [main ] INFO p6spy - SQL: 72 nanos - drop table if exists files
Hibernate: drop table if exists fingerprints
21:48:03.013 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@700718e8
21:48:03.024 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@635df83b
21:48:03.036 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - Added connection com.p6spy.engine.wrapper.ConnectionWrapper@4dd6e15e
21:48:03.047 [l-2 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-2 - After adding stats (total=10, active=1, idle=9, waiting=0)
21:48:03.074 [main ] INFO p6spy - SQL: 62 nanos - drop table if exists fingerprints
Hibernate: create table files (id varchar(36) not null, path text not null, primary key (id))
21:48:03.138 [main ] INFO p6spy - SQL: 61 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))
21:48:03.202 [main ] INFO p6spy - SQL: 53 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))
21:48:03.204 [main ] INFO o.h.e.t.jta.platform.internal.JtaPlatformInitiator - HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
21:48:03.210 [main ] INFO o.s.orm.jpa.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default'
21:48:03.361 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Started JpaDataManagerDaoTest in 0.938 seconds (process running for 11.591)
21:48:03.380 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - ****************************
21:48:03.380 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - TEST "test findManagedFiles"
21:48:03.380 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - ****************************
Hibernate: insert into files (path, id) values (?, ?)
21:48:03.440 [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 (?, ?, ?, ?, ?, ?)
21:48:03.446 [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 (?, ?, ?, ?, ?, ?)
21:48:03.447 [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 (?, ?, ?, ?, ?, ?)
21:48:03.448 [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 (?, ?, ?, ?, ?, ?)
21:48:03.449 [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 (?, ?, ?, ?, ?, ?)
21:48:03.451 [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 (?, ?, ?, ?, ?, ?)
21:48:03.452 [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 (?, ?, ?, ?, ?, ?)
21:48:03.454 [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 (?, ?)
21:48:03.455 [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 (?, ?, ?, ?, ?, ?)
21:48:03.457 [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 (?, ?, ?, ?, ?, ?)
21:48:03.458 [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 (?, ?)
21:48:03.462 [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 (?, ?, ?, ?, ?, ?)
21:48:03.463 [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 (?, ?, ?, ?, ?, ?)
21:48:03.464 [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 (?, ?, ?, ?, ?, ?)
21:48:03.467 [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 (?, ?, ?, ?, ?, ?)
21:48:03.471 [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 (?, ?)
21:48:03.472 [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 (?, ?, ?, ?, ?, ?)
21:48:03.472 [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 (?, ?, ?, ?, ?, ?)
21:48:03.473 [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 (?, ?, ?, ?, ?, ?)
21:48:03.474 [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 (?, ?, ?, ?, ?, ?)
21:48:03.474 [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 (?, ?)
21:48:03.475 [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 (?, ?, ?, ?, ?, ?)
21:48:03.475 [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 (?, ?, ?, ?, ?, ?)
21:48:03.476 [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 (?, ?, ?, ?, ?, ?)
21:48:03.477 [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 (?, ?, ?, ?, ?, ?)
21:48:03.480 [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 (?, ?, ?, ?, ?, ?)
21:48:03.482 [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 (?, ?, ?, ?, ?, ?)
21:48:03.483 [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 (?, ?)
21:48:03.484 [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 (?, ?, ?, ?, ?, ?)
21:48:03.486 [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 (?, ?, ?, ?, ?, ?)
21:48:03.488 [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 (?, ?, ?, ?, ?, ?)
21:48:03.489 [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 (?, ?, ?, ?, ?, ?)
21:48:03.491 [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 (?, ?, ?, ?, ?, ?)
21:48:03.493 [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 (?, ?)
21:48:03.494 [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 (?, ?, ?, ?, ?, ?)
21:48:03.499 [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 (?, ?, ?, ?, ?, ?)
21:48:03.500 [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 (?, ?, ?, ?, ?, ?)
21:48:03.500 [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 (?, ?, ?, ?, ?, ?)
21:48:03.501 [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 (?, ?)
21:48:03.501 [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 (?, ?, ?, ?, ?, ?)
21:48:03.502 [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 (?, ?)
21:48:03.502 [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 (?, ?, ?, ?, ?, ?)
21:48:03.503 [main ] INFO p6spy - SQL: 0 nanos - insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values ('md5', '00000029-0000-0000-0000-000000000000', '32cc', '2020-09-17T10:35:28.000+0000', 'b9046b121dcde0e58d9e335cb2f8d774', '0000002a-0000-0000-0000-000000000000')
Hibernate: insert into fingerprints (algorithm, file_id, name, timestamp, fingerprint, id) values (?, ?, ?, ?, ?, ?)
21:48:03.504 [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 (?, ?)
21:48:03.504 [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 (?, ?, ?, ?, ?, ?)
21:48:03.505 [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')
21:48:03.582 [main ] INFO p6spy - SQL: 68 nanos -
21:48:03.596 [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=[]))
21:48:03.625 [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
21:48:03.625 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.625 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(651092951<open>)] for JPA transaction
21:48:03.626 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@41d8e94]
21:48:03.631 [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 ?
21:48:03.812 [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
21:48:03.831 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 10 items
21:48:03.831 [main ] TRACE i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning [ManagedFileEntity@58ef8069(id=00000008-0000-0000-0000-000000000000, path=/foo/bar/2e10, fingerprints=not initialized), ManagedFileEntity@10706411(id=00000029-0000-0000-0000-000000000000, path=/foo/bar/32cc, fingerprints=not initialized), ManagedFileEntity@dcd6f19(id=00000022-0000-0000-0000-000000000000, path=/foo/bar/34c3, fingerprints=not initialized), ManagedFileEntity@df31866(id=00000010-0000-0000-0000-000000000000, path=/foo/bar/3f38, fingerprints=not initialized), ManagedFileEntity@68d27530(id=0000002c-0000-0000-0000-000000000000, path=/foo/bar/5252, fingerprints=not initialized), ManagedFileEntity@66e6bb8e(id=00000027-0000-0000-0000-000000000000, path=/foo/bar/5712, fingerprints=not initialized), ManagedFileEntity@185010b5(id=00000015-0000-0000-0000-000000000000, path=/foo/bar/67a2, fingerprints=not initialized), ManagedFileEntity@25f92ffd(id=0000000b-0000-0000-0000-000000000000, path=/foo/bar/7d46, fingerprints=not initialized), ManagedFileEntity@5a93dccc(id=00000000-0000-0000-0000-000000000000, path=/foo/bar/e047, fingerprints=not initialized), ManagedFileEntity@469a9010(id=0000001c-0000-0000-0000-000000000000, path=/foo/bar/f228, fingerprints=not initialized)]
21:48:03.835 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.836 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.836 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(651092951<open>)]
21:48:03.837 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.837 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(651092951<open>)] after transaction
21:48:03.844 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Asserting that lazy collection of fingerprints not fetched yet...
21:48:03.845 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Triggering lazy fetch...
21:48:03.846 [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
21:48:03.846 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.846 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(609601884<open>)] for JPA transaction
21:48:03.847 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@380d3099]
21:48:03.847 [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=?
21:48:03.848 [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
21:48:03.856 [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
21:48:03.859 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 2 items
21:48:03.859 [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)]
21:48:03.864 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.864 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.864 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(609601884<open>)]
21:48:03.865 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.865 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(609601884<open>)] after transaction
21:48:03.866 [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
21:48:03.867 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.867 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1204124943<open>)] for JPA transaction
21:48:03.867 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@7d6ec39c]
21:48:03.867 [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=?
21:48:03.868 [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
21:48:03.870 [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
21:48:03.871 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 2 items
21:48:03.871 [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)]
21:48:03.871 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.871 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.871 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1204124943<open>)]
21:48:03.872 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.872 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1204124943<open>)] after transaction
21:48:03.872 [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
21:48:03.872 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.872 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1640732477<open>)] for JPA transaction
21:48:03.872 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@3353d096]
21:48:03.873 [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=?
21:48:03.873 [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
21:48:03.874 [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
21:48:03.876 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 4 items
21:48:03.876 [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)]
21:48:03.876 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.876 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.876 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1640732477<open>)]
21:48:03.877 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.877 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1640732477<open>)] after transaction
21:48:03.878 [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
21:48:03.878 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.878 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1276416078<open>)] for JPA transaction
21:48:03.878 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@256088a7]
21:48:03.878 [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=?
21:48:03.879 [main ] INFO p6spy - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='00000010-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
21:48:03.880 [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
21:48:03.882 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 4 items
21:48:03.882 [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)]
21:48:03.882 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.882 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.882 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1276416078<open>)]
21:48:03.883 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.883 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1276416078<open>)] after transaction
21:48:03.883 [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
21:48:03.883 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.884 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(906929433<open>)] for JPA transaction
21:48:03.884 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@2e643cad]
21:48:03.884 [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=?
21:48:03.885 [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
21:48:03.886 [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
21:48:03.886 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 1 items
21:48:03.886 [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)]
21:48:03.886 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.887 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.887 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(906929433<open>)]
21:48:03.887 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.887 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(906929433<open>)] after transaction
21:48:03.888 [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
21:48:03.888 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.888 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(735996273<open>)] for JPA transaction
21:48:03.888 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@3f2054d]
21:48:03.888 [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=?
21:48:03.889 [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
21:48:03.890 [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
21:48:03.891 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 1 items
21:48:03.891 [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)]
21:48:03.891 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.891 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.891 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(735996273<open>)]
21:48:03.891 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.892 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(735996273<open>)] after transaction
21:48:03.892 [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
21:48:03.892 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.892 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1148816769<open>)] for JPA transaction
21:48:03.892 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@605d67f8]
21:48:03.892 [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=?
21:48:03.893 [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
21:48:03.894 [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
21:48:03.896 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 6 items
21:48:03.896 [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)]
21:48:03.897 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.897 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.897 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1148816769<open>)]
21:48:03.898 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.898 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1148816769<open>)] after transaction
21:48:03.899 [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
21:48:03.899 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.899 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(875077215<open>)] for JPA transaction
21:48:03.899 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@363843e]
21:48:03.899 [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=?
21:48:03.900 [main ] INFO p6spy - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='0000000b-0000-0000-0000-000000000000'
Hibernate: select f1_0.file_id,f1_0.id,f1_0.algorithm,f1_0.name,f1_0.timestamp,f1_0.fingerprint from fingerprints f1_0 where f1_0.file_id=? order by f1_0.timestamp asc
21:48:03.901 [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
21:48:03.903 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 4 items
21:48:03.903 [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)]
21:48:03.903 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.903 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.903 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(875077215<open>)]
21:48:03.904 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.904 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(875077215<open>)] after transaction
21:48:03.904 [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
21:48:03.904 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.904 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1022566764<open>)] for JPA transaction
21:48:03.905 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@5bc2dbcd]
21:48:03.905 [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=?
21:48:03.905 [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
21:48:03.907 [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
21:48:03.908 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 7 items
21:48:03.909 [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)]
21:48:03.909 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.909 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.909 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1022566764<open>)]
21:48:03.910 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.910 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1022566764<open>)] after transaction
21:48:03.910 [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
21:48:03.910 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.911 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1562550349<open>)] for JPA transaction
21:48:03.911 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@4e32e1f9]
21:48:03.911 [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=?
21:48:03.912 [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
21:48:03.913 [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
21:48:03.914 [main ] INFO i.t.u.spring.jpa.impl.DefaultFinderJpaRepository - >>>> returning 5 items
21:48:03.915 [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)]
21:48:03.915 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction commit
21:48:03.915 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: COMMIT
21:48:03.915 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Committing JPA transaction on EntityManager [SessionImpl(1562550349<open>)]
21:48:03.916 [main ] INFO p6spy - SQL: 0 nanos -
21:48:03.916 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1562550349<open>)] after transaction
21:48:03.916 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - Actual result:
21:48:03.916 [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)]))
21:48:03.920 [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)]))
21:48:03.920 [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)]))
21:48:03.920 [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)]))
21:48:03.920 [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)]))
21:48:03.920 [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)]))
21:48:03.920 [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)]))
21:48:03.920 [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)]))
21:48:03.920 [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)]))
21:48:03.921 [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)]))
21:48:03.933 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest - TEST PASSED in 548 msec
21:48:03.934 [main ] INFO i.t.datamanager.dao.impl.jpa.JpaDataManagerDaoTest -
21:48:03.943 [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
21:48:03.943 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:03.943 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1953058566<open>)] for JPA transaction
21:48:03.944 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@16c69c47]
21:48:03.945 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
21:48:03.945 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test equals and hashCode"
21:48:03.945 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
Hibernate: insert into files (path, id) values (?, ?)
21:48:03.949 [main ] INFO p6spy - SQL: 0 nanos - insert into files (path, id) values ('path', 'id')
21:48:03.994 [main ] INFO p6spy - SQL: 44 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
21:48:04.005 [main ] INFO p6spy - SQL: 1 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
21:48:04.007 [main ] INFO p6spy - SQL: 0 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
21:48:04.009 [main ] INFO p6spy - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
21:48:04.016 [main ] INFO p6spy - SQL: 0 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
21:48:04.019 [main ] INFO p6spy - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
21:48:04.023 [main ] INFO p6spy - SQL: 0 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
21:48:04.027 [main ] INFO p6spy - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
21:48:04.030 [main ] INFO p6spy - SQL: 0 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
21:48:04.032 [main ] INFO p6spy - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
21:48:04.033 [main ] INFO p6spy - SQL: 0 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
21:48:04.035 [main ] INFO p6spy - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id'
21:48:04.050 [main ] INFO p6spy - SQL: 0 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
21:48:04.060 [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=?
21:48:04.065 [main ] INFO p6spy - SQL: 0 nanos - delete from files where id='id'
21:48:04.125 [main ] INFO p6spy - SQL: 58 nanos -
21:48:04.128 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 181 msec
21:48:04.128 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest -
21:48:04.137 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
21:48:04.138 [main ] WARN i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
21:48:04.138 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(1953058566<open>)]
21:48:04.138 [main ] INFO p6spy - SQL: 0 nanos -
21:48:04.139 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1953058566<open>)] after transaction
21:48:04.142 [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
21:48:04.142 [main ] INFO i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: BEGIN - tx definition: PROPAGATION_REQUIRED,ISOLATION_DEFAULT
21:48:04.142 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Opened new EntityManager [SessionImpl(1397751331<open>)] for JPA transaction
21:48:04.142 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Exposing JPA transaction as JDBC [org.springframework.orm.jpa.vendor.HibernateJpaDialect$HibernateConnectionHandle@5f57cecd]
21:48:04.146 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
21:48:04.147 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test toString with proxy"
21:48:04.147 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - *******************************
Hibernate: insert into files (path, id) values (?, ?)
21:48:04.153 [main ] INFO p6spy - SQL: 0 nanos - insert into files (path, id) values ('path', 'id2')
21:48:04.226 [main ] INFO p6spy - SQL: 72 nanos -
Hibernate: select m1_0.id,m1_0.path from files m1_0 where m1_0.id=?
21:48:04.236 [main ] INFO p6spy - SQL: 0 nanos - select m1_0.id,m1_0.path from files m1_0 where m1_0.id='id2'
21:48:04.238 [main ] INFO p6spy - SQL: 0 nanos -
21:48:04.241 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 93 msec
21:48:04.241 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest -
21:48:04.247 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Initiating transaction rollback
21:48:04.248 [main ] WARN i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - SQL: ROLLBACK
21:48:04.250 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Rolling back JPA transaction on EntityManager [SessionImpl(1397751331<open>)]
21:48:04.250 [main ] INFO p6spy - SQL: 0 nanos -
21:48:04.251 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Closing JPA EntityManager [SessionImpl(1397751331<open>)] after transaction
21:48:04.259 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - **********************************
21:48:04.259 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST "test toString without proxy"
21:48:04.259 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - **********************************
21:48:04.268 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest - TEST PASSED in 8 msec
21:48:04.268 [main ] INFO i.t.datamanager.dao.impl.jpa.ManagedFileEntityTest -
21:48:04.272 [main ] DEBUG i.t.u.spring.jpa.impl.LoggingJpaTransactionManager - Should roll back transaction but cannot - no transaction available
21:48:04.275 [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: 11.809 s - in TestSuite
21:48:04.496 [licationShutdownHook] INFO o.s.orm.jpa.LocalContainerEntityManagerFactoryBean - Closing JPA EntityManagerFactory for persistence unit 'default'
21:48:04.499 [licationShutdownHook] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Shutdown initiated...
21:48:04.499 [licationShutdownHook] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Before shutdown stats (total=10, active=0, idle=10, waiting=0)
[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.6332a4670def.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.6332a4670def-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.6332a4670def.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.6332a4670def-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: 6332a4670def at timestamp: 1682804885427
[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 6332a4670def
[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 [ 5.171 s]
[INFO] SolidBlue III (modules) ............................ SUCCESS [ 1.225 s]
[INFO] SolidBlue III :: Commons ........................... SUCCESS [ 5.104 s]
[INFO] SolidBlue III :: Model ............................. SUCCESS [ 11.444 s]
[INFO] SolidBlue III :: Dao ............................... SUCCESS [ 25.786 s]
[INFO] SolidBlue III :: Application no GUI ................ SUCCESS [ 16.604 s]
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 01:12 min
[INFO] Finished at: 2023-04-29T21:48:30Z
[INFO] ------------------------------------------------------------------------
[WARNING] The requested profile "installers" could not be activated because it does not exist.
![[Jenkins]](/ci/static/0840cea4/images/svgs/logo.svg){kind=logo}
