· 6 years ago · Apr 01, 2020, 08:42 AM
1Connected to the target VM, address: '127.0.0.1:62729', transport: 'socket'
211:34:53.193 [main] DEBUG org.springframework.test.context.BootstrapUtils - Instantiating CacheAwareContextLoaderDelegate from class [org.springframework.test.context.cache.DefaultCacheAwareContextLoaderDelegate]
311:34:53.216 [main] DEBUG org.springframework.test.context.BootstrapUtils - Instantiating BootstrapContext using constructor [public org.springframework.test.context.support.DefaultBootstrapContext(java.lang.Class,org.springframework.test.context.CacheAwareContextLoaderDelegate)]
411:34:53.256 [main] DEBUG org.springframework.test.context.BootstrapUtils - Instantiating TestContextBootstrapper for test class [ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest] from class [org.springframework.boot.test.autoconfigure.orm.jpa.DataJpaTestContextBootstrapper]
511:34:53.296 [main] DEBUG org.springframework.test.context.support.AbstractContextLoader - Did not detect default resource location for test class [ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest]: class path resource [ru/tinkoff/bpm/meeteornotificationservice/service/impl/MessageServiceImplTest-context.xml] does not exist
611:34:53.297 [main] DEBUG org.springframework.test.context.support.AbstractContextLoader - Did not detect default resource location for test class [ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest]: class path resource [ru/tinkoff/bpm/meeteornotificationservice/service/impl/MessageServiceImplTestContext.groovy] does not exist
711:34:53.297 [main] INFO org.springframework.test.context.support.AbstractContextLoader - Could not detect default resource locations for test class [ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest]: no resource found for suffixes {-context.xml, Context.groovy}.
811:34:53.298 [main] DEBUG org.springframework.test.context.support.AnnotationConfigContextLoaderUtils - Ignoring class [ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest$Initializer]; it must be static, non-private, non-final, and annotated with @Configuration to be considered a default configuration class.
911:34:53.298 [main] INFO org.springframework.test.context.support.AnnotationConfigContextLoaderUtils - Could not detect default configuration classes for test class [ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest]: MessageServiceImplTest does not declare any static, non-private, non-final, nested classes annotated with @Configuration.
1011:34:53.372 [main] DEBUG org.springframework.test.context.support.ActiveProfilesUtils - Could not find an 'annotation declaring class' for annotation type [org.springframework.test.context.ActiveProfiles] and class [ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest]
1111:34:53.503 [main] DEBUG org.springframework.context.annotation.ClassPathScanningCandidateComponentProvider - Identified candidate component class: file [C:\Programming\Kotlin\meeteor-notification-service\meeteor-notification-service\out\production\classes\ru\tinkoff\bpm\meeteornotificationservice\MeeteorNotificationServiceApplication.class]
1211:34:53.505 [main] INFO org.springframework.boot.test.context.SpringBootTestContextBootstrapper - Found @SpringBootConfiguration ru.tinkoff.bpm.meeteornotificationservice.MeeteorNotificationServiceApplication for test class ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest
1311:34:53.507 [main] DEBUG org.springframework.boot.test.autoconfigure.orm.jpa.DataJpaTestContextBootstrapper - @TestExecutionListeners is not present for class [ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest]: using defaults.
1411:34:53.508 [main] INFO org.springframework.boot.test.autoconfigure.orm.jpa.DataJpaTestContextBootstrapper - Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.boot.test.autoconfigure.restdocs.RestDocsTestExecutionListener, org.springframework.boot.test.autoconfigure.web.client.MockRestServiceServerResetTestExecutionListener, org.springframework.boot.test.autoconfigure.web.servlet.MockMvcPrintOnlyOnFailureTestExecutionListener, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverTestExecutionListener, org.springframework.boot.test.mock.mockito.MockitoTestExecutionListener, org.springframework.boot.test.mock.mockito.ResetMocksTestExecutionListener, org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener, org.springframework.test.context.event.EventPublishingTestExecutionListener]
1511:34:53.537 [main] INFO org.springframework.boot.test.autoconfigure.orm.jpa.DataJpaTestContextBootstrapper - Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@3bd418e4, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@544820b7, org.springframework.boot.test.mock.mockito.MockitoTestExecutionListener@6b98a075, org.springframework.boot.test.autoconfigure.SpringBootDependencyInjectionTestExecutionListener@2e61d218, org.springframework.test.context.support.DirtiesContextTestExecutionListener@3569fc08, org.springframework.test.context.transaction.TransactionalTestExecutionListener@20b12f8a, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener@e84a8e1, org.springframework.test.context.event.EventPublishingTestExecutionListener@2e554a3b, org.springframework.boot.test.autoconfigure.restdocs.RestDocsTestExecutionListener@54a67a45, org.springframework.boot.test.autoconfigure.web.client.MockRestServiceServerResetTestExecutionListener@7d42c224, org.springframework.boot.test.autoconfigure.web.servlet.MockMvcPrintOnlyOnFailureTestExecutionListener@56aaaecd, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverTestExecutionListener@522a32b1, org.springframework.boot.test.mock.mockito.ResetMocksTestExecutionListener@35390ee3]
1611:34:53.543 [main] DEBUG org.springframework.test.context.support.AbstractDirtiesContextTestExecutionListener - Before test class: context [DefaultTestContext@6c5945a7 testClass = MessageServiceImplTest, testInstance = [null], testMethod = [null], testException = [null], mergedContextConfiguration = [MergedContextConfiguration@2f05be7f testClass = MessageServiceImplTest, locations = '{}', classes = '{class ru.tinkoff.bpm.meeteornotificationservice.MeeteorNotificationServiceApplication}', contextInitializerClasses = '[class ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest$Initializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{org.springframework.boot.test.autoconfigure.orm.jpa.DataJpaTestContextBootstrapper=true}', contextCustomizers = set[org.springframework.boot.test.autoconfigure.OverrideAutoConfigurationContextCustomizerFactory$DisableAutoConfigurationContextCustomizer@61eaec38, org.springframework.boot.test.autoconfigure.filter.TypeExcludeFiltersContextCustomizer@351584c0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@a7adaa7c, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@50dfbc58, [ImportsContextCustomizer@640f11a1 key = [ru.tinkoff.bpm.meeteornotificationservice.configuration.KafkaConfigurationTest, org.springframework.boot.autoconfigure.cache.CacheAutoConfiguration, org.springframework.boot.autoconfigure.data.jpa.JpaRepositoriesAutoConfiguration, org.springframework.boot.autoconfigure.flyway.FlywayAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.DataSourceAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.DataSourceTransactionManagerAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.JdbcTemplateAutoConfiguration, org.springframework.boot.autoconfigure.liquibase.LiquibaseAutoConfiguration, org.springframework.boot.autoconfigure.orm.jpa.HibernateJpaAutoConfiguration, org.springframework.boot.autoconfigure.transaction.TransactionAutoConfiguration, org.springframework.boot.test.autoconfigure.jdbc.TestDatabaseAutoConfiguration, org.springframework.boot.test.autoconfigure.orm.jpa.TestEntityManagerAutoConfiguration]], org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7fbdb894, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@6e005dc9, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0], contextLoader = 'org.springframework.boot.test.context.SpringBootContextLoader', parent = [null]], attributes = map[[empty]]], class annotated with @DirtiesContext [false] with mode [null].
1711:34:54.068 [main] DEBUG org.springframework.test.context.support.DependencyInjectionTestExecutionListener - Performing dependency injection for test context [[DefaultTestContext@6c5945a7 testClass = MessageServiceImplTest, testInstance = ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest@6a969fb8, testMethod = [null], testException = [null], mergedContextConfiguration = [MergedContextConfiguration@2f05be7f testClass = MessageServiceImplTest, locations = '{}', classes = '{class ru.tinkoff.bpm.meeteornotificationservice.MeeteorNotificationServiceApplication}', contextInitializerClasses = '[class ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest$Initializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{org.springframework.boot.test.autoconfigure.orm.jpa.DataJpaTestContextBootstrapper=true}', contextCustomizers = set[org.springframework.boot.test.autoconfigure.OverrideAutoConfigurationContextCustomizerFactory$DisableAutoConfigurationContextCustomizer@61eaec38, org.springframework.boot.test.autoconfigure.filter.TypeExcludeFiltersContextCustomizer@351584c0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@a7adaa7c, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@50dfbc58, [ImportsContextCustomizer@640f11a1 key = [ru.tinkoff.bpm.meeteornotificationservice.configuration.KafkaConfigurationTest, org.springframework.boot.autoconfigure.cache.CacheAutoConfiguration, org.springframework.boot.autoconfigure.data.jpa.JpaRepositoriesAutoConfiguration, org.springframework.boot.autoconfigure.flyway.FlywayAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.DataSourceAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.DataSourceTransactionManagerAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.JdbcTemplateAutoConfiguration, org.springframework.boot.autoconfigure.liquibase.LiquibaseAutoConfiguration, org.springframework.boot.autoconfigure.orm.jpa.HibernateJpaAutoConfiguration, org.springframework.boot.autoconfigure.transaction.TransactionAutoConfiguration, org.springframework.boot.test.autoconfigure.jdbc.TestDatabaseAutoConfiguration, org.springframework.boot.test.autoconfigure.orm.jpa.TestEntityManagerAutoConfiguration]], org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7fbdb894, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@6e005dc9, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0], contextLoader = 'org.springframework.boot.test.context.SpringBootContextLoader', parent = [null]], attributes = map[[empty]]]].
1811:34:54.227 [main] DEBUG org.springframework.test.context.support.TestPropertySourceUtils - Adding inlined properties to environment: {spring.jmx.enabled=false, org.springframework.boot.test.autoconfigure.orm.jpa.DataJpaTestContextBootstrapper=true, server.port=-1}
19{"timestamp":"2020-04-01T11:34:56.978+03:00","message":"Bean 'org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration' of type [org.springframework.cloud.autoconfigure.ConfigurationPropertiesRebinderAutoConfiguration] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)","logger":"org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker","thread":"main","level":"INFO","applicationName":"meeteor-notification-service"}
20
21 . ____ _ __ _ _
22 /\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \
23( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
24 \\/ ___)| |_)| | | | | || (_| | ) ) ) )
25 ' |____| .__|_| |_|_| |_\__, | / / / /
26 =========|_|==============|___/=/_/_/_/
27 :: Spring Boot :: (v2.2.2.RELEASE)
28
292020-04-01 11:34:58.568 [main] [] INFO o.t.d.DockerClientProviderStrategy - Loaded org.testcontainers.dockerclient.NpipeSocketClientProviderStrategy from ~/.testcontainers.properties, will try it first
302020-04-01 11:34:59.155 [main] [] INFO o.t.d.NpipeSocketClientProviderStrategy - Accessing docker with local Npipe socket (npipe:////./pipe/docker_engine)
312020-04-01 11:34:59.155 [main] [] INFO o.t.d.DockerClientProviderStrategy - Found Docker environment with local Npipe socket (npipe:////./pipe/docker_engine)
322020-04-01 11:34:59.290 [main] [] INFO org.testcontainers.DockerClientFactory - Docker host IP address is localhost
332020-04-01 11:34:59.315 [main] [] INFO org.testcontainers.DockerClientFactory - Connected to docker:
34 Server Version: 19.03.8
35 API Version: 1.40
36 Operating System: Docker Desktop
37 Total Memory: 1989 MB
382020-04-01 11:34:59.491 [main] [] INFO o.t.utility.RegistryAuthLocator - Credential helper/store (docker-credential-desktop) does not have credentials for quay.io
392020-04-01 11:34:59.859 [main] [] INFO org.testcontainers.DockerClientFactory - Ryuk started - will monitor and terminate Testcontainers containers on JVM exit
402020-04-01 11:34:59.859 [main] [] INFO org.testcontainers.DockerClientFactory - Checking the system...
412020-04-01 11:34:59.860 [main] [] INFO org.testcontainers.DockerClientFactory - ✔︎ Docker server version should be at least 1.6.0
422020-04-01 11:34:59.926 [main] [] INFO org.testcontainers.DockerClientFactory - ✔︎ Docker environment should have more than 2GB free disk space
432020-04-01 11:34:59.938 [main] [] INFO ? [postgres:9.6.12] - Creating container for image: postgres:9.6.12
442020-04-01 11:35:00.074 [main] [] INFO ? [postgres:9.6.12] - Starting container with ID: 259ae2c032731f6e3e468176622db83c98c53a0cc6b0ae66b3490b2f6ff1d7f3
452020-04-01 11:35:00.290 [main] [] INFO ? [postgres:9.6.12] - Container postgres:9.6.12 is starting: 259ae2c032731f6e3e468176622db83c98c53a0cc6b0ae66b3490b2f6ff1d7f3
462020-04-01 11:35:03.985 [main] [] INFO ? [postgres:9.6.12] - Container postgres:9.6.12 started in PT5.428S
472020-04-01 11:35:03.986 [main] [] INFO r.t.b.m.s.impl.MessageServiceImplTest - The following profiles are active: dev
482020-04-01 11:35:04.289 [main] [] INFO o.s.d.r.c.RepositoryConfigurationDelegate - Bootstrapping Spring Data JPA repositories in DEFAULT mode.
492020-04-01 11:35:04.507 [main] [] INFO o.s.d.r.c.RepositoryConfigurationDelegate - Finished Spring Data repository scanning in 211ms. Found 2 JPA repository interfaces.
502020-04-01 11:35:04.880 [main] [] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
512020-04-01 11:35:04.983 [main] [] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
522020-04-01 11:35:05.651 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM public.databasechangeloglock
532020-04-01 11:35:05.669 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - CREATE TABLE public.databasechangeloglock (ID INTEGER NOT NULL, LOCKED BOOLEAN NOT NULL, LOCKGRANTED TIMESTAMP WITHOUT TIME ZONE, LOCKEDBY VARCHAR(255), CONSTRAINT DATABASECHANGELOGLOCK_PKEY PRIMARY KEY (ID))
542020-04-01 11:35:05.672 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM public.databasechangeloglock
552020-04-01 11:35:05.675 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - DELETE FROM public.databasechangeloglock
562020-04-01 11:35:05.676 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - INSERT INTO public.databasechangeloglock (ID, LOCKED) VALUES (1, FALSE)
572020-04-01 11:35:05.679 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - SELECT LOCKED FROM public.databasechangeloglock WHERE ID=1
582020-04-01 11:35:05.686 [main] [] INFO l.lockservice.StandardLockService - Successfully acquired change log lock
592020-04-01 11:35:06.423 [main] [] INFO l.c.StandardChangeLogHistoryService - Creating database history table with name: public.databasechangelog
602020-04-01 11:35:06.423 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - CREATE TABLE public.databasechangelog (ID VARCHAR(255) NOT NULL, AUTHOR VARCHAR(255) NOT NULL, FILENAME VARCHAR(255) NOT NULL, DATEEXECUTED TIMESTAMP WITHOUT TIME ZONE NOT NULL, ORDEREXECUTED INTEGER NOT NULL, EXECTYPE VARCHAR(10) NOT NULL, MD5SUM VARCHAR(35), DESCRIPTION VARCHAR(255), COMMENTS VARCHAR(255), TAG VARCHAR(255), LIQUIBASE VARCHAR(20), CONTEXTS VARCHAR(255), LABELS VARCHAR(255), DEPLOYMENT_ID VARCHAR(10))
612020-04-01 11:35:06.426 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM public.databasechangelog
622020-04-01 11:35:06.428 [main] [] INFO l.c.StandardChangeLogHistoryService - Reading from public.databasechangelog
632020-04-01 11:35:06.428 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - SELECT * FROM public.databasechangelog ORDER BY DATEEXECUTED ASC, ORDEREXECUTED ASC
642020-04-01 11:35:06.430 [main] [] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM public.databasechangeloglock
652020-04-01 11:35:06.439 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::meeteor-notification-service-v1.0-tag::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - Tag 'meeteor-notification-service-v1.0' applied to database
662020-04-01 11:35:06.439 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::meeteor-notification-service-v1.0-tag::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - ChangeSet classpath:/db/changelog/v1.0/changelog.xml::meeteor-notification-service-v1.0-tag::ext.konstantinovskiy ran successfully in 0ms
672020-04-01 11:35:06.439 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::meeteor-notification-service-v1.0-tag::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - SELECT MAX(ORDEREXECUTED) FROM public.databasechangelog
682020-04-01 11:35:06.442 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::meeteor-notification-service-v1.0-tag::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - INSERT INTO public.databasechangelog (ID, AUTHOR, FILENAME, DATEEXECUTED, ORDEREXECUTED, MD5SUM, DESCRIPTION, COMMENTS, EXECTYPE, CONTEXTS, LABELS, LIQUIBASE, DEPLOYMENT_ID, TAG) VALUES ('meeteor-notification-service-v1.0-tag', 'ext.konstantinovskiy', 'classpath:/db/changelog/v1.0/changelog.xml', NOW(), 1, '8:ee8ca1e2577e7ac38ef6ddf4b03081e1', 'tagDatabase', '', 'EXECUTED', NULL, NULL, '3.8.0', '5730106431', 'meeteor-notification-service-v1.0')
692020-04-01 11:35:06.447 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-notification::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - CREATE TABLE notification
70(
71 id VARCHAR(200) PRIMARY KEY,
72 type VARCHAR(200) NOT NULL,
73 meeting_id VARCHAR(200) NOT NULL,
74 status VARCHAR(200) NOT NULL,
75 scheduled_date TIMESTAMP NOT NULL,
76 template VARCHAR(200),
77 details json
78)
792020-04-01 11:35:06.449 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-notification::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - CREATE INDEX idx_meeting_id ON notification (meeting_id)
802020-04-01 11:35:06.450 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-notification::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - SQL in file sql/CREATE_NOTIFICATION.sql executed
812020-04-01 11:35:06.451 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-notification::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - ChangeSet classpath:/db/changelog/v1.0/changelog.xml::create-notification::ext.konstantinovskiy ran successfully in 6ms
822020-04-01 11:35:06.452 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-notification::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - INSERT INTO public.databasechangelog (ID, AUTHOR, FILENAME, DATEEXECUTED, ORDEREXECUTED, MD5SUM, DESCRIPTION, COMMENTS, EXECTYPE, CONTEXTS, LABELS, LIQUIBASE, DEPLOYMENT_ID) VALUES ('create-notification', 'ext.konstantinovskiy', 'classpath:/db/changelog/v1.0/changelog.xml', NOW(), 2, '8:84342e97e9d6ea9d24e20813303ad97c', 'sqlFile', '', 'EXECUTED', NULL, NULL, '3.8.0', '5730106431')
832020-04-01 11:35:06.456 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-sending::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - CREATE TABLE sending
84(
85 id VARCHAR(200) PRIMARY KEY,
86 type VARCHAR(200) NOT NULL,
87 status VARCHAR(200) NOT NULL,
88 proceeded_date TIMESTAMP NOT NULL,
89 template VARCHAR(200),
90 details json,
91 notification_id VARCHAR(200) NOT NULL
92)
932020-04-01 11:35:06.458 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-sending::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - SQL in file sql/CREATE_SENDING.sql executed
942020-04-01 11:35:06.459 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-sending::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - ChangeSet classpath:/db/changelog/v1.0/changelog.xml::create-sending::ext.konstantinovskiy ran successfully in 4ms
952020-04-01 11:35:06.460 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.0/changelog.xml::create-sending::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - INSERT INTO public.databasechangelog (ID, AUTHOR, FILENAME, DATEEXECUTED, ORDEREXECUTED, MD5SUM, DESCRIPTION, COMMENTS, EXECTYPE, CONTEXTS, LABELS, LIQUIBASE, DEPLOYMENT_ID) VALUES ('create-sending', 'ext.konstantinovskiy', 'classpath:/db/changelog/v1.0/changelog.xml', NOW(), 3, '8:105b57cef9a3ff90fdcf4a2eb9bb48d0', 'sqlFile', '', 'EXECUTED', NULL, NULL, '3.8.0', '5730106431')
962020-04-01 11:35:06.462 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.1/changelog.xml::meeteor-notification-service-v1.1-tag::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - Tag 'meeteor-notification-service-v1.1' applied to database
972020-04-01 11:35:06.463 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.1/changelog.xml::meeteor-notification-service-v1.1-tag::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - ChangeSet classpath:/db/changelog/v1.1/changelog.xml::meeteor-notification-service-v1.1-tag::ext.konstantinovskiy ran successfully in 1ms
982020-04-01 11:35:06.464 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.1/changelog.xml::meeteor-notification-service-v1.1-tag::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - INSERT INTO public.databasechangelog (ID, AUTHOR, FILENAME, DATEEXECUTED, ORDEREXECUTED, MD5SUM, DESCRIPTION, COMMENTS, EXECTYPE, CONTEXTS, LABELS, LIQUIBASE, DEPLOYMENT_ID, TAG) VALUES ('meeteor-notification-service-v1.1-tag', 'ext.konstantinovskiy', 'classpath:/db/changelog/v1.1/changelog.xml', NOW(), 4, '8:4d2609b1dcb4e925449d0bcaa66d1e2b', 'tagDatabase', '', 'EXECUTED', NULL, NULL, '3.8.0', '5730106431', 'meeteor-notification-service-v1.1')
992020-04-01 11:35:06.467 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.1/changelog.xml::add-sending-columns::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - ALTER TABLE sending
100 ADD COLUMN meeting_id VARCHAR(200)
1012020-04-01 11:35:06.468 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.1/changelog.xml::add-sending-columns::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - SQL in file sql/ADD_SENDING_COLUMNS.sql executed
1022020-04-01 11:35:06.469 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.1/changelog.xml::add-sending-columns::ext.konstantinovskiy] INFO liquibase.changelog.ChangeSet - ChangeSet classpath:/db/changelog/v1.1/changelog.xml::add-sending-columns::ext.konstantinovskiy ran successfully in 3ms
1032020-04-01 11:35:06.470 [main] [databaseChangeLog=classpath:/db/changelog/changelog-master.xml, changeSet=classpath:/db/changelog/v1.1/changelog.xml::add-sending-columns::ext.konstantinovskiy] INFO liquibase.executor.jvm.JdbcExecutor - INSERT INTO public.databasechangelog (ID, AUTHOR, FILENAME, DATEEXECUTED, ORDEREXECUTED, MD5SUM, DESCRIPTION, COMMENTS, EXECTYPE, CONTEXTS, LABELS, LIQUIBASE, DEPLOYMENT_ID) VALUES ('add-sending-columns', 'ext.konstantinovskiy', 'classpath:/db/changelog/v1.1/changelog.xml', NOW(), 5, '8:982e9cfe144c2cb7ce9daf5d1ff3580a', 'sqlFile', '', 'EXECUTED', NULL, NULL, '3.8.0', '5730106431')
1042020-04-01 11:35:06.474 [main] [] INFO l.lockservice.StandardLockService - Successfully released change log lock
1052020-04-01 11:35:06.617 [main] [] INFO o.hibernate.jpa.internal.util.LogHelper - HHH000204: Processing PersistenceUnitInfo [name: default]
1062020-04-01 11:35:06.719 [main] [] INFO org.hibernate.Version - HHH000412: Hibernate Core {5.4.9.Final}
1072020-04-01 11:35:06.774 [main] [] INFO org.hibernate.annotations.common.Version - HCANN000001: Hibernate Commons Annotations {5.1.0.Final}
1082020-04-01 11:35:06.954 [main] [] INFO org.hibernate.dialect.Dialect - HHH000400: Using dialect: org.hibernate.dialect.PostgreSQL95Dialect
1092020-04-01 11:35:07.272 [main] [] WARN Hypersistence Optimizer - You should use Hypersistence Optimizer to speed up your Hibernate application!
1102020-04-01 11:35:07.272 [main] [] WARN Hypersistence Optimizer - For more details, go to https://vladmihalcea.com/hypersistence-optimizer/
1112020-04-01 11:35:07.272 [main] [] INFO Hypersistence Optimizer -
112 _ _ _ _
113| | | | (_) | |
114| |__| |_ _ _ __ ___ _ __ ___ _ ___| |_ ___ _ __ ___ ___
115| __ | | | | '_ \ / _ \ '__/ __| / __| __/ _ \ '_ \ / __/ _ \
116| | | | |_| | |_) | __/ | \__ \ \__ \ || __/ | | | (_| __/
117|_| |_|\__, | .__/ \___|_| |___/_|___/\__\___|_| |_|\___\___|
118 __/ | |
119 |___/|_|
120
121 ____ _ _ _
122 / __ \ | | (_) (_)
123 | | | |_ __ | |_ _ _ __ ___ _ _______ _ __
124 | | | | '_ \| __| | '_ ` _ \| |_ / _ \ '__|
125 | |__| | |_) | |_| | | | | | | |/ / __/ |
126 \____/| .__/ \__|_|_| |_| |_|_/___\___|_|
127 | |
128 |_|
129
1302020-04-01 11:35:07.684 [main] [] INFO o.h.e.t.j.p.i.JtaPlatformInitiator - HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
1312020-04-01 11:35:07.695 [main] [] INFO o.s.o.j.LocalContainerEntityManagerFactoryBean - Initialized JPA EntityManagerFactory for persistence unit 'default'
1322020-04-01 11:35:07.731 [main] [] INFO ? [confluentinc/cp-kafka:5.2.1] - Creating container for image: confluentinc/cp-kafka:5.2.1
1332020-04-01 11:35:07.834 [main] [] INFO ? [confluentinc/cp-kafka:5.2.1] - Reusing container with ID: 365e07785aac79403ecfaedb5f69cc3324552dc09588a7598f0cd3423b80bde1 and hash: 9af8ee6f774245e0fb539450e517574031c5bae2
1342020-04-01 11:35:07.834 [main] [] INFO ? [confluentinc/cp-kafka:5.2.1] - Container confluentinc/cp-kafka:5.2.1 is starting: 365e07785aac79403ecfaedb5f69cc3324552dc09588a7598f0cd3423b80bde1
1352020-04-01 11:35:07.925 [main] [] INFO ? [confluentinc/cp-kafka:5.2.1] - Container confluentinc/cp-kafka:5.2.1 started in PT0.194S
1362020-04-01 11:35:08.813 [main] [] INFO r.t.b.m.s.impl.MessageServiceImplTest - Started MessageServiceImplTest in 14.257 seconds (JVM running for 16.709)
137
1382020-04-01 11:35:08.838 [main] [] INFO o.s.t.c.transaction.TransactionContext - Began transaction (1) for test context [DefaultTestContext@6c5945a7 testClass = MessageServiceImplTest, testInstance = ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest@6a969fb8, testMethod = listen meeteor message@MessageServiceImplTest, testException = [null], mergedContextConfiguration = [MergedContextConfiguration@2f05be7f testClass = MessageServiceImplTest, locations = '{}', classes = '{class ru.tinkoff.bpm.meeteornotificationservice.MeeteorNotificationServiceApplication}', contextInitializerClasses = '[class ru.tinkoff.bpm.meeteornotificationservice.service.impl.MessageServiceImplTest$Initializer]', activeProfiles = '{}', propertySourceLocations = '{}', propertySourceProperties = '{org.springframework.boot.test.autoconfigure.orm.jpa.DataJpaTestContextBootstrapper=true}', contextCustomizers = set[org.springframework.boot.test.autoconfigure.OverrideAutoConfigurationContextCustomizerFactory$DisableAutoConfigurationContextCustomizer@61eaec38, org.springframework.boot.test.autoconfigure.filter.TypeExcludeFiltersContextCustomizer@351584c0, org.springframework.boot.test.autoconfigure.properties.PropertyMappingContextCustomizer@a7adaa7c, org.springframework.boot.test.autoconfigure.web.servlet.WebDriverContextCustomizerFactory$Customizer@50dfbc58, [ImportsContextCustomizer@640f11a1 key = [ru.tinkoff.bpm.meeteornotificationservice.configuration.KafkaConfigurationTest, org.springframework.boot.autoconfigure.cache.CacheAutoConfiguration, org.springframework.boot.autoconfigure.data.jpa.JpaRepositoriesAutoConfiguration, org.springframework.boot.autoconfigure.flyway.FlywayAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.DataSourceAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.DataSourceTransactionManagerAutoConfiguration, org.springframework.boot.autoconfigure.jdbc.JdbcTemplateAutoConfiguration, org.springframework.boot.autoconfigure.liquibase.LiquibaseAutoConfiguration, org.springframework.boot.autoconfigure.orm.jpa.HibernateJpaAutoConfiguration, org.springframework.boot.autoconfigure.transaction.TransactionAutoConfiguration, org.springframework.boot.test.autoconfigure.jdbc.TestDatabaseAutoConfiguration, org.springframework.boot.test.autoconfigure.orm.jpa.TestEntityManagerAutoConfiguration]], org.springframework.boot.test.context.filter.ExcludeFilterContextCustomizer@7fbdb894, org.springframework.boot.test.json.DuplicateJsonObjectContextCustomizerFactory$DuplicateJsonObjectContextCustomizer@6e005dc9, org.springframework.boot.test.mock.mockito.MockitoContextCustomizer@0], contextLoader = 'org.springframework.boot.test.context.SpringBootContextLoader', parent = [null]], attributes = map[[empty]]]; transaction manager [org.springframework.orm.jpa.JpaTransactionManager@747e0a31]; rollback [true]
1392020-04-01 11:35:18.891 [main] [] INFO o.a.k.clients.admin.AdminClientConfig - AdminClientConfig values:
140 bootstrap.servers = [PLAINTEXT://localhost:32874]
141 client.dns.lookup = default
142 client.id =
143 connections.max.idle.ms = 300000
144 metadata.max.age.ms = 300000
145 metric.reporters = []
146 metrics.num.samples = 2
147 metrics.recording.level = INFO
148 metrics.sample.window.ms = 30000
149 receive.buffer.bytes = 65536
150 reconnect.backoff.max.ms = 1000
151 reconnect.backoff.ms = 50
152 request.timeout.ms = 120000
153 retries = 5
154 retry.backoff.ms = 100
155 sasl.client.callback.handler.class = null
156 sasl.jaas.config = null
157 sasl.kerberos.kinit.cmd = /usr/bin/kinit
158 sasl.kerberos.min.time.before.relogin = 60000
159 sasl.kerberos.service.name = null
160 sasl.kerberos.ticket.renew.jitter = 0.05
161 sasl.kerberos.ticket.renew.window.factor = 0.8
162 sasl.login.callback.handler.class = null
163 sasl.login.class = null
164 sasl.login.refresh.buffer.seconds = 300
165 sasl.login.refresh.min.period.seconds = 60
166 sasl.login.refresh.window.factor = 0.8
167 sasl.login.refresh.window.jitter = 0.05
168 sasl.mechanism = GSSAPI
169 security.protocol = PLAINTEXT
170 send.buffer.bytes = 131072
171 ssl.cipher.suites = null
172 ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
173 ssl.endpoint.identification.algorithm = https
174 ssl.key.password = null
175 ssl.keymanager.algorithm = SunX509
176 ssl.keystore.location = null
177 ssl.keystore.password = null
178 ssl.keystore.type = JKS
179 ssl.protocol = TLS
180 ssl.provider = null
181 ssl.secure.random.implementation = null
182 ssl.trustmanager.algorithm = PKIX
183 ssl.truststore.location = null
184 ssl.truststore.password = null
185 ssl.truststore.type = JKS
186
1872020-04-01 11:35:18.986 [main] [] INFO o.a.kafka.common.utils.AppInfoParser - Kafka version: 2.3.1
1882020-04-01 11:35:18.986 [main] [] INFO o.a.kafka.common.utils.AppInfoParser - Kafka commitId: 18a913733fb71c01
1892020-04-01 11:35:18.986 [main] [] INFO o.a.kafka.common.utils.AppInfoParser - Kafka startTimeMs: 1585730118984
1902020-04-01 11:35:19.014 [main] [] INFO o.a.k.clients.producer.ProducerConfig - ProducerConfig values:
191 acks = 1
192 batch.size = 16384
193 bootstrap.servers = [PLAINTEXT://localhost:32874]
194 buffer.memory = 33554432
195 client.dns.lookup = default
196 client.id =
197 compression.type = none
198 connections.max.idle.ms = 540000
199 delivery.timeout.ms = 120000
200 enable.idempotence = false
201 interceptor.classes = []
202 key.serializer = class org.apache.kafka.common.serialization.StringSerializer
203 linger.ms = 0
204 max.block.ms = 60000
205 max.in.flight.requests.per.connection = 5
206 max.request.size = 1048576
207 metadata.max.age.ms = 300000
208 metric.reporters = []
209 metrics.num.samples = 2
210 metrics.recording.level = INFO
211 metrics.sample.window.ms = 30000
212 partitioner.class = class org.apache.kafka.clients.producer.internals.DefaultPartitioner
213 receive.buffer.bytes = 32768
214 reconnect.backoff.max.ms = 1000
215 reconnect.backoff.ms = 50
216 request.timeout.ms = 30000
217 retries = 2147483647
218 retry.backoff.ms = 100
219 sasl.client.callback.handler.class = null
220 sasl.jaas.config = null
221 sasl.kerberos.kinit.cmd = /usr/bin/kinit
222 sasl.kerberos.min.time.before.relogin = 60000
223 sasl.kerberos.service.name = null
224 sasl.kerberos.ticket.renew.jitter = 0.05
225 sasl.kerberos.ticket.renew.window.factor = 0.8
226 sasl.login.callback.handler.class = null
227 sasl.login.class = null
228 sasl.login.refresh.buffer.seconds = 300
229 sasl.login.refresh.min.period.seconds = 60
230 sasl.login.refresh.window.factor = 0.8
231 sasl.login.refresh.window.jitter = 0.05
232 sasl.mechanism = GSSAPI
233 security.protocol = PLAINTEXT
234 send.buffer.bytes = 131072
235 ssl.cipher.suites = null
236 ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
237 ssl.endpoint.identification.algorithm = https
238 ssl.key.password = null
239 ssl.keymanager.algorithm = SunX509
240 ssl.keystore.location = null
241 ssl.keystore.password = null
242 ssl.keystore.type = JKS
243 ssl.protocol = TLS
244 ssl.provider = null
245 ssl.secure.random.implementation = null
246 ssl.trustmanager.algorithm = PKIX
247 ssl.truststore.location = null
248 ssl.truststore.password = null
249 ssl.truststore.type = JKS
250 transaction.timeout.ms = 60000
251 transactional.id = null
252 value.serializer = class org.apache.kafka.common.serialization.StringSerializer
253
2542020-04-01 11:35:19.040 [main] [] INFO o.a.kafka.common.utils.AppInfoParser - Kafka version: 2.3.1
2552020-04-01 11:35:19.040 [main] [] INFO o.a.kafka.common.utils.AppInfoParser - Kafka commitId: 18a913733fb71c01
2562020-04-01 11:35:19.041 [main] [] INFO o.a.kafka.common.utils.AppInfoParser - Kafka startTimeMs: 1585730119040
2572020-04-01 11:35:19.166 [kafka-producer-network-thread | producer-1] [] INFO org.apache.kafka.clients.Metadata - [Producer clientId=producer-1] Cluster ID: b89ZASOQSfW_hTBCmNUfUg