I quickly looked over the calls and I don't see why it would be called
twice either.  Is a module failing to start?  If thats the case the spring
context would be refreshed twice and so the .started methods would be
called twice.

Can you debug and put a breakpoint on that method and look at the
stacktrace?  (or just print the stacktrace from that method to the logs)

Ben

On Fri, Dec 16, 2011 at 1:18 PM, Rowan Seymour <[email protected]> wrote:

> I've now noticed on 3 different machines with OpenMRS 1.8.2 and 1.8.3,
> sometimes module activator startup methods are called twice. I can see this
> from modules which write something to the log when they are being started
>
> For example...
>
> INFO - LoggingAdvice.invoke(109) |2011-12-14 18:48:43,003| In method
> SchedulerService.restoreFromMemento. Arguments: OpenmrsMemento=null,
> INFO - LoggingAdvice.invoke(134) |2011-12-14 18:48:43,004| Exiting method
> restoreFromMemento
> *INFO - JMXActivator.started(33) |2011-12-14 18:48:43,005| Starting JMX
> Module*
> INFO - SchedulerServiceInterceptor.afterReturning(36) |2011-12-14
> 18:48:43,020| schedules service
> INFO - JMXActivator.started(37) |2011-12-14 18:48:43,027| Registered
> management beans
> INFO - FrameworkServlet.initServletBean(301) |2011-12-14 18:48:43,028|
> FrameworkServlet 'openmrs': initialization started
> INFO - SchedulerServiceInterceptor.afterReturning(36) |2011-12-14
> 18:48:43,057| schedules service
> INFO - ContextRefreshListener.onApplicationEvent(37) |2011-12-14
> 18:48:43,063| Refreshed management beans
> INFO - FrameworkServlet.initServletBean(320) |2011-12-14 18:48:43,064|
> FrameworkServlet 'openmrs': initialization completed in 35 ms
> WARN - CommonsLoggingOutput.warn(59) |2011-12-14 18:48:43,099| Setting
> extra type info to overloaded methods may fail with <parameter .../>
> ERROR - CommonsLoggingOutput.error(75) |2011-12-14 18:48:43,100| Parameter
> mismatch parsing signatures section in dwr.xml on line:
> DWRProgramWorkflowService.updatePatientProgram(Integer patientProgramId,
> String enrollmentDateYmd, String completionDateYmd, Integer locationId)
> *INFO - JMXActivator.started(33) |2011-12-14 18:48:43,100| Starting JMX
> Module*
> INFO - SchedulerServiceInterceptor.afterReturning(36) |2011-12-14
> 18:48:43,112| schedules service
> INFO - JMXActivator.started(37) |2011-12-14 18:48:43,118| Registered
> management beans
> INFO - ModuleListController.formBackingObject(261) |2011-12-14
> 18:48:43,140| Returning 5 modules
> INFO - SchedulerServiceInterceptor.afterReturning(36) |2011-12-14
> 18:48:46,198| schedules service
> INFO - SchedulerServiceInterceptor.afterReturning(36) |2011-12-14
> 18:48:46,201| schedules service
>
> I've also noticed it with modules like that one that use
> BaseModuleActivator, but also HTML Form Entry which uses the old Activator
> interface.
>
> Haven't been able to figure out why yet...
>
> --
>
> *Dr Rowan Seymour**
> Partners In Health, Rwanda*
> Tel: +250783835665
>
>  ------------------------------
> Click here to 
> unsubscribe<[email protected]?body=SIGNOFF%20openmrs-devel-l>from 
> OpenMRS Developers' mailing list

_________________________________________

To unsubscribe from OpenMRS Developers' mailing list, send an e-mail to 
[email protected] with "SIGNOFF openmrs-devel-l" in the  body (not 
the subject) of your e-mail.

[mailto:[email protected]?body=SIGNOFF%20openmrs-devel-l]

Reply via email to