Summit-Sync / backend

0 stars 0 forks source link

Irgend ein "scheduled Task" stirbt von alleine im Backend #62

Open Flavia-de-Luce opened 5 months ago

Flavia-de-Luce commented 5 months ago

Wollte eigentlich gerade eine Gruppe erstellen, aber dann sehe ich im Augenwinkel den Docker eskalieren... Habe keinen Call abgesetzt um das auszulösen!

api-1 | 2024-06-11T07:59:59.907Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select a1_0.course_course_id,a1_0.application_id,a1_0.accepted,g1_0.group_id,g1_0.acronym,g1_0 .cancelled,g1_0.contact_contact_id,g1_0.description,g1_0.duration,g1_0.group_number,l1_0.location_id,l1_0.city,l1_0.country,l1_0.email,l1_0.maps_url,l1_0.phone,l1_0.post_code,l1_0.street,l1_0.title,g1_0. meeting_point,g1_0.notes,g1_0.number_of_dates,g1_0.number_participants,g1_0.participants_per_trainer,g1_0.price_per_participant,g1_0.title,g1_0.total_price,g1_0.trainer_price_per_hour,t1_0.trainer_id,t1_ 0.subject_id from ss_trainer_application a1_0 left join ss_group g1_0 on g1_0.group_id=a1_0.group_group_id left join ss_location l1_0 on l1_0.location_id=g1_0.location_location_id left join ss_trainer t1_0 on t1_0.trainer_id=a1_0.trainer_trainer_id where a1_0.course_course_id=? api-1 | 2024-06-11T07:59:59.908Z TRACE 1 --- [ scheduling-1] org.hibernate.orm.jdbc.bind : binding parameter (1:BIGINT) <- [1] api-1 | 2024-06-11T07:59:59.912Z ERROR 1 --- [ scheduling-1] o.s.s.s.TaskUtils$LoggingErrorHandler : Unexpected error occurred in scheduled task api-1 | api-1 | org.hibernate.LazyInitializationException: failed to lazily initialize a collection of role: com.summitsync.api.course.Course.participants: could not initialize proxy - no Session api-1 | at org.hibernate.collection.spi.AbstractPersistentCollection.throwLazyInitializationException(AbstractPersistentCollection.java:634) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at org.hibernate.collection.spi.AbstractPersistentCollection.withTemporarySessionIfNeeded(AbstractPersistentCollection.java:217) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at org.hibernate.collection.spi.AbstractPersistentCollection.readSize(AbstractPersistentCollection.java:148) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at org.hibernate.collection.spi.PersistentBag.size(PersistentBag.java:355) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at com.summitsync.api.utility.ScheduledServices.lambda$cancelCoursesAutomatically$2(ScheduledServices.java:50) ~[!/:0.0.1-SNAPSHOT] api-1 | at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:178) ~[na:na] api-1 | at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) ~[na:na] api-1 | at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) ~[na:na] api-1 | at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) ~[na:na] api-1 | at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:575) ~[na:na] api-1 | at java.base/java.util.stream.AbstractPipeline.evaluateToArrayNode(AbstractPipeline.java:260) ~[na:na] api-1 | at java.base/java.util.stream.ReferencePipeline.toArray(ReferencePipeline.java:616) ~[na:na] api-1 | at java.base/java.util.stream.ReferencePipeline.toArray(ReferencePipeline.java:622) ~[na:na] api-1 | at java.base/java.util.stream.ReferencePipeline.toList(ReferencePipeline.java:627) ~[na:na] api-1 | at com.summitsync.api.utility.ScheduledServices.cancelCoursesAutomatically(ScheduledServices.java:50) ~[!/:0.0.1-SNAPSHOT] api-1 | at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) ~[na:na] api-1 | at java.base/java.lang.reflect.Method.invoke(Method.java:580) ~[na:na] api-1 | at org.springframework.scheduling.support.ScheduledMethodRunnable.runInternal(ScheduledMethodRunnable.java:130) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at org.springframework.scheduling.support.ScheduledMethodRunnable.lambda$run$2(ScheduledMethodRunnable.java:124) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at io.micrometer.observation.Observation.observe(Observation.java:499) ~[micrometer-observation-1.12.2.jar!/:1.12.2] api-1 | at org.springframework.scheduling.support.ScheduledMethodRunnable.run(ScheduledMethodRunnable.java:124) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at org.springframework.scheduling.concurrent.ReschedulingRunnable.run(ReschedulingRunnable.java:96) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:572) ~[na:na] api-1 | at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) ~[na:na] api-1 | at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304) ~[na:na] api-1 | at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) ~[na:na] api-1 | at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ~[na:na] api-1 | at java.base/java.lang.Thread.run(Thread.java:1583) ~[na:na] api-1 | api-1 | 2024-06-11T07:59:59.918Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select c1_0.course_id,c1_0.acronym,c1_0.cancelled,c1_0.course_number,c1_0.description,c1_0.duration,c1_0.finished,c1_0.location_location_id,c1_0.meeting_point,c1_0.notes,c1_0.number_participants,c1_0.number_trainer,c1_0.number_waitlist,c1_0.title,c1_0.visible from ss_course c1_0 api-1 | 2024-06-11T07:59:59.919Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select l1_0.location_id,l1_0.city,l1_0.country,l1_0.email,l1_0.maps_url,l1_0.phone,l1_0.post_code,l1_0.street,l1_0.title from ss_location l1_0 where l1_0.location_id=? api-1 | 2024-06-11T07:59:59.920Z TRACE 1 --- [ scheduling-1] org.hibernate.orm.jdbc.bind : binding parameter (1:BIGINT) <- [1] api-1 | 2024-06-11T07:59:59.923Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select t1_0.course_id,t1_1.trainer_id,t1_1.subject_id from ss_course_trainer_join t1_0 join ss_trainer t1_1 on t1_1.trainer_id=t1_0.trainer_id where t1_0.course_id=? api-1 | 2024-06-11T07:59:59.923Z TRACE 1 --- [ scheduling-1] org.hibernate.orm.jdbc.bind : binding parameter (1:BIGINT) <- [1] api-1 | 2024-06-11T07:59:59.925Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select q1_0.trainerid,q1_1.qualification_id,q1_1.name from ss_trainer_qualification_join q1_0 join ss_qualification q1_1 on q1_1.qualification_id=q1_0.qualification_id where q1_0.trainerid=? api-1 | 2024-06-11T07:59:59.926Z TRACE 1 --- [ scheduling-1] org.hibernate.orm.jdbc.bind : binding parameter (1:BIGINT) <- [2] api-1 | 2024-06-11T07:59:59.927Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select rq1_0.course_id,rq1_1.qualification_id,rq1_1.name from ss_course_required_qualifications_join rq1_0 join ss_qualification rq1_1 on rq1_1.qualification_id=rq1_0.qualification_id where rq1_0.course_id=? api-1 | 2024-06-11T07:59:59.927Z TRACE 1 --- [ scheduling-1] org.hibernate.orm.jdbc.bind : binding parameter (1:BIGINT) <- [1] api-1 | 2024-06-11T07:59:59.929Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select d1_0.course_course_id,d1_1.event_date_id,d1_1.course_course_id,d1_1.duration_in_minutes,d1_1.group_group_id,d1_1.start_time from ss_course_dates d1_0 join ss_event_date d1_1 on d1_1.event_date_id=d1_0.dates_event_date_id where d1_0.course_course_id=? api-1 | 2024-06-11T07:59:59.929Z TRACE 1 --- [ scheduling-1] org.hibernate.orm.jdbc.bind : binding parameter (1:BIGINT) <- [1] api-1 | 2024-06-11T07:59:59.930Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select ct1_0.course_course_id,ct1_0.course_trainer_id,s1_0.status_id,s1_0.text,ct1_0.trainer_trainer_id from ss_course_trainer ct1_0 left join ss_status s1_0 on s1_0.status_id=ct1_0.status_status_id where ct1_0.course_course_id=? api-1 | 2024-06-11T07:59:59.931Z TRACE 1 --- [ scheduling-1] org.hibernate.orm.jdbc.bind : binding parameter (1:BIGINT) <- [1] api-1 | 2024-06-11T07:59:59.932Z DEBUG 1 --- [ scheduling-1] org.hibernate.SQL : select a1_0.course_course_id,a1_0.application_id,a1_0.accepted,g1_0.group_id,g1_0.acronym,g1_0 .cancelled,g1_0.contact_contact_id,g1_0.description,g1_0.duration,g1_0.group_number,l1_0.location_id,l1_0.city,l1_0.country,l1_0.email,l1_0.maps_url,l1_0.phone,l1_0.post_code,l1_0.street,l1_0.title,g1_0. meeting_point,g1_0.notes,g1_0.number_of_dates,g1_0.number_participants,g1_0.participants_per_trainer,g1_0.price_per_participant,g1_0.title,g1_0.total_price,g1_0.trainer_price_per_hour,t1_0.trainer_id,t1_ 0.subject_id from ss_trainer_application a1_0 left join ss_group g1_0 on g1_0.group_id=a1_0.group_group_id left join ss_location l1_0 on l1_0.location_id=g1_0.location_location_id left join ss_trainer t1_0 on t1_0.trainer_id=a1_0.trainer_trainer_id where a1_0.course_course_id=? api-1 | 2024-06-11T07:59:59.932Z TRACE 1 --- [ scheduling-1] org.hibernate.orm.jdbc.bind : binding parameter (1:BIGINT) <- [1] api-1 | 2024-06-11T07:59:59.934Z DEBUG 1 --- [ scheduling-1] c.s.api.keycloak.KeycloakRestService : New keycloak request to uri: https://keycloak.summitsync.meschter.me/admin/realms/summit-sync/users/4dd8a7fc-356c-43f2-b467-c2dd8e5026fc (GET) api-1 | 2024-06-11T08:00:00.041Z DEBUG 1 --- [ scheduling-1] o.s.web.client.DefaultRestClient : Reading to [com.summitsync.api.keycloak.dto.KeycloakUser] api-1 | 2024-06-11T08:00:00.041Z ERROR 1 --- [ scheduling-1] o.s.s.s.TaskUtils$LoggingErrorHandler : Unexpected error occurred in scheduled task api-1 | api-1 | org.hibernate.LazyInitializationException: failed to lazily initialize a collection of role: com.summitsync.api.course.Course.participants: could not initialize proxy - no Session api-1 | at org.hibernate.collection.spi.AbstractPersistentCollection.throwLazyInitializationException(AbstractPersistentCollection.java:634) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at org.hibernate.collection.spi.AbstractPersistentCollection.withTemporarySessionIfNeeded(AbstractPersistentCollection.java:217) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at org.hibernate.collection.spi.AbstractPersistentCollection.initialize(AbstractPersistentCollection.java:613) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at org.hibernate.collection.spi.AbstractPersistentCollection.read(AbstractPersistentCollection.java:136) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at org.hibernate.collection.spi.PersistentBag.iterator(PersistentBag.java:371) ~[hibernate-core-6.4.1.Final.jar!/:6.4.1.Final] api-1 | at com.summitsync.api.mail.MailServiceImpl.sendCourseReminderMailForParticipants(MailServiceImpl.java:353) ~[!/:0.0.1-SNAPSHOT] api-1 | at com.summitsync.api.mail.MailServiceImpl.sendCourseReminderMail(MailServiceImpl.java:244) ~[!/:0.0.1-SNAPSHOT] api-1 | at com.summitsync.api.utility.ScheduledServices.lambda$sendReminderMailForCourses$0(ScheduledServices.java:37) ~[!/:0.0.1-SNAPSHOT] api-1 | at java.base/java.lang.Iterable.forEach(Iterable.java:75) ~[na:na] api-1 | at com.summitsync.api.utility.ScheduledServices.sendReminderMailForCourses(ScheduledServices.java:37) ~[!/:0.0.1-SNAPSHOT] api-1 | at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) ~[na:na] api-1 | at java.base/java.lang.reflect.Method.invoke(Method.java:580) ~[na:na] api-1 | at org.springframework.scheduling.support.ScheduledMethodRunnable.runInternal(ScheduledMethodRunnable.java:130) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at org.springframework.scheduling.support.ScheduledMethodRunnable.lambda$run$2(ScheduledMethodRunnable.java:124) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at io.micrometer.observation.Observation.observe(Observation.java:499) ~[micrometer-observation-1.12.2.jar!/:1.12.2] api-1 | at org.springframework.scheduling.support.ScheduledMethodRunnable.run(ScheduledMethodRunnable.java:124) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at org.springframework.scheduling.concurrent.ReschedulingRunnable.run(ReschedulingRunnable.java:96) ~[spring-context-6.1.3.jar!/:6.1.3] api-1 | at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:572) ~[na:na] api-1 | at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:317) ~[na:na] api-1 | at java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:304) ~[na:na] api-1 | at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) ~[na:na] api-1 | at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ~[na:na] api-1 | at java.base/java.lang.Thread.run(Thread.java:1583) ~[na:na] api-1 | db-1 | 2024-06-11 08:00:12.392 UTC [62] LOG: checkpoint starting: time db-1 | 2024-06-11 08:00:15.219 UTC [62] LOG: checkpoint complete: wrote 29 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=2.814 s, sync=0.007 s, total=2.828 s; sync files=26, longest=0.004 s, average=0.001 s; distance=7 kB, estimate=827 kB; lsn=0/1A305A0, redo lsn=0/1A30568

onestay commented 5 months ago

@Enrico004

Flavia-de-Luce commented 5 months ago

Ich glaube auch, er meinte das er wegen den E-Mails nen Task gescheduled hat