You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@geronimo.apache.org by "John Sisson (JIRA)" <de...@geronimo.apache.org> on 2005/07/10 09:32:09 UTC

[jira] Created: (GERONIMO-733) Ouput configuration startup times in startup console output

Ouput configuration startup times in startup console output
-----------------------------------------------------------

         Key: GERONIMO-733
         URL: http://issues.apache.org/jira/browse/GERONIMO-733
     Project: Geronimo
        Type: Improvement
  Components: general  
    Reporter: John Sisson
    Priority: Minor


Before this idea is forgotten, I have raised this issue with the following text taken from the dev list mail thread "Re: New Startup Output, Mark 2":

On Fri, 8 Jul 2005, Geir Magnusson Jr. wrote:
> > At the risk of showing words in your mouth, are you suggesting it
> > would just be nice to see how long it took to start each component?
> 
> Exactly. It would just give people a reference as to what got done at  
> each additional delta of the progress bar...

This should be easy for someone to implement.  Let me explain:

 - The code is in the system module
 - The class that starts the server is Daemon.
 - Daemon uses a helper class that implements StartupMonitor and calls
   the appropriate methods on that as things happen during the startup
   sequence.  The helper class is responsible for nearly all output from
   the startup classes themselves.
 - The progress bar is implemented in ProgressBarStartupMonitor
 - The non-pb is implemented in SilentStartupMonitor

		 So, if you want additional output in a non-progress-bar case (such 
as with DEBUG or INFO output enabled), you can either add code to 
SilentStartupMonitor or add a new implementation of StartupMonitor and 
instantiate that instead of SilentStartupMonitor in the "-v" and "-vv" 
cases (leaving SilentStartupMonitor for the "-quiet" case).

		 The startup monitor is called every time a configuration is 
loading, loaded, starting, and started.  Note there are only a handful of 
configurations (5-10, usually), you do not get a call for every GBean 
loaded or something like that.  Anyway, if you want to know how long it 
takes each configuration to be loaded and started, just call 
System.currentTimeMillis here and there and keep some statistics.

		 I would recommend that you save any such output to the end for the 
case where DEBUG or INFO output is enabled, since it would otherwise be 
lost among all the initial output.  But if you save the stats along the 
way, the final output could look something like this:

10:51:28,745 INFO  [Daemon] Server startup completed
10:51:28,745 INFO  [MyMonitor] 3s to start org/apache/geronimo/System
10:51:28,745 INFO  [MyMonitor] 5s to start org/apache/geronimo/Server
10:51:28,745 INFO  [MyMonitor] 2s to start org/apache/geronimo/Deployer
...

		 Finally, I don't think it's a good idea to add something like this
to the progress bar.  The progress bar is very clean by design, and I
don't think more specific statistics would be helpful to the typical user.  
The server developers are more likely to be interested in finer-grained
information (and more likely to want more detailed log output as well), so
I'd prefer this kind of thing get added to the "-v" or "-vv" startup
options instead.

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira


[jira] Updated: (GERONIMO-733) Ouput configuration startup times in startup console output

Posted by "John Sisson (JIRA)" <de...@geronimo.apache.org>.
     [ http://issues.apache.org/jira/browse/GERONIMO-733?page=all ]

John Sisson updated GERONIMO-733:
---------------------------------

    Version: 1.0-M5

> Ouput configuration startup times in startup console output
> -----------------------------------------------------------
>
>          Key: GERONIMO-733
>          URL: http://issues.apache.org/jira/browse/GERONIMO-733
>      Project: Geronimo
>         Type: Improvement
>   Components: general
>     Versions: 1.0-M5
>     Reporter: John Sisson
>     Priority: Minor

>
> Before this idea is forgotten, I have raised this issue with the following text taken from the dev list mail thread "Re: New Startup Output, Mark 2":
> On Fri, 8 Jul 2005, Geir Magnusson Jr. wrote:
> > > At the risk of showing words in your mouth, are you suggesting it
> > > would just be nice to see how long it took to start each component?
> > 
> > Exactly. It would just give people a reference as to what got done at  
> > each additional delta of the progress bar...
> This should be easy for someone to implement.  Let me explain:
>  - The code is in the system module
>  - The class that starts the server is Daemon.
>  - Daemon uses a helper class that implements StartupMonitor and calls
>    the appropriate methods on that as things happen during the startup
>    sequence.  The helper class is responsible for nearly all output from
>    the startup classes themselves.
>  - The progress bar is implemented in ProgressBarStartupMonitor
>  - The non-pb is implemented in SilentStartupMonitor
> 		 So, if you want additional output in a non-progress-bar case (such 
> as with DEBUG or INFO output enabled), you can either add code to 
> SilentStartupMonitor or add a new implementation of StartupMonitor and 
> instantiate that instead of SilentStartupMonitor in the "-v" and "-vv" 
> cases (leaving SilentStartupMonitor for the "-quiet" case).
> 		 The startup monitor is called every time a configuration is 
> loading, loaded, starting, and started.  Note there are only a handful of 
> configurations (5-10, usually), you do not get a call for every GBean 
> loaded or something like that.  Anyway, if you want to know how long it 
> takes each configuration to be loaded and started, just call 
> System.currentTimeMillis here and there and keep some statistics.
> 		 I would recommend that you save any such output to the end for the 
> case where DEBUG or INFO output is enabled, since it would otherwise be 
> lost among all the initial output.  But if you save the stats along the 
> way, the final output could look something like this:
> 10:51:28,745 INFO  [Daemon] Server startup completed
> 10:51:28,745 INFO  [MyMonitor] 3s to start org/apache/geronimo/System
> 10:51:28,745 INFO  [MyMonitor] 5s to start org/apache/geronimo/Server
> 10:51:28,745 INFO  [MyMonitor] 2s to start org/apache/geronimo/Deployer
> ...
> 		 Finally, I don't think it's a good idea to add something like this
> to the progress bar.  The progress bar is very clean by design, and I
> don't think more specific statistics would be helpful to the typical user.  
> The server developers are more likely to be interested in finer-grained
> information (and more likely to want more detailed log output as well), so
> I'd prefer this kind of thing get added to the "-v" or "-vv" startup
> options instead.

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira


[jira] Resolved: (GERONIMO-733) Ouput configuration startup times in startup console output

Posted by "John Sisson (JIRA)" <de...@geronimo.apache.org>.
     [ http://issues.apache.org/jira/browse/GERONIMO-733?page=all ]
     
John Sisson resolved GERONIMO-733:
----------------------------------

    Resolution: Duplicate

> Ouput configuration startup times in startup console output
> -----------------------------------------------------------
>
>          Key: GERONIMO-733
>          URL: http://issues.apache.org/jira/browse/GERONIMO-733
>      Project: Geronimo
>         Type: Improvement
>   Components: general
>     Reporter: John Sisson
>     Priority: Minor
>      Fix For: 1.0

>
> Before this idea is forgotten, I have raised this issue with the following text taken from the dev list mail thread "Re: New Startup Output, Mark 2":
> On Fri, 8 Jul 2005, Geir Magnusson Jr. wrote:
> > > At the risk of showing words in your mouth, are you suggesting it
> > > would just be nice to see how long it took to start each component?
> > 
> > Exactly. It would just give people a reference as to what got done at  
> > each additional delta of the progress bar...
> This should be easy for someone to implement.  Let me explain:
>  - The code is in the system module
>  - The class that starts the server is Daemon.
>  - Daemon uses a helper class that implements StartupMonitor and calls
>    the appropriate methods on that as things happen during the startup
>    sequence.  The helper class is responsible for nearly all output from
>    the startup classes themselves.
>  - The progress bar is implemented in ProgressBarStartupMonitor
>  - The non-pb is implemented in SilentStartupMonitor
> 		 So, if you want additional output in a non-progress-bar case (such 
> as with DEBUG or INFO output enabled), you can either add code to 
> SilentStartupMonitor or add a new implementation of StartupMonitor and 
> instantiate that instead of SilentStartupMonitor in the "-v" and "-vv" 
> cases (leaving SilentStartupMonitor for the "-quiet" case).
> 		 The startup monitor is called every time a configuration is 
> loading, loaded, starting, and started.  Note there are only a handful of 
> configurations (5-10, usually), you do not get a call for every GBean 
> loaded or something like that.  Anyway, if you want to know how long it 
> takes each configuration to be loaded and started, just call 
> System.currentTimeMillis here and there and keep some statistics.
> 		 I would recommend that you save any such output to the end for the 
> case where DEBUG or INFO output is enabled, since it would otherwise be 
> lost among all the initial output.  But if you save the stats along the 
> way, the final output could look something like this:
> 10:51:28,745 INFO  [Daemon] Server startup completed
> 10:51:28,745 INFO  [MyMonitor] 3s to start org/apache/geronimo/System
> 10:51:28,745 INFO  [MyMonitor] 5s to start org/apache/geronimo/Server
> 10:51:28,745 INFO  [MyMonitor] 2s to start org/apache/geronimo/Deployer
> ...
> 		 Finally, I don't think it's a good idea to add something like this
> to the progress bar.  The progress bar is very clean by design, and I
> don't think more specific statistics would be helpful to the typical user.  
> The server developers are more likely to be interested in finer-grained
> information (and more likely to want more detailed log output as well), so
> I'd prefer this kind of thing get added to the "-v" or "-vv" startup
> options instead.

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira


[jira] Commented: (GERONIMO-733) Ouput configuration startup times in startup console output

Posted by "John Sisson (JIRA)" <de...@geronimo.apache.org>.
    [ http://issues.apache.org/jira/browse/GERONIMO-733?page=comments#action_12359998 ] 

John Sisson commented on GERONIMO-733:
--------------------------------------

Done as part of the new --long startup option that uses a different startup progress output. See GERONIMO-1268.

> Ouput configuration startup times in startup console output
> -----------------------------------------------------------
>
>          Key: GERONIMO-733
>          URL: http://issues.apache.org/jira/browse/GERONIMO-733
>      Project: Geronimo
>         Type: Improvement
>   Components: general
>     Reporter: John Sisson
>     Priority: Minor
>      Fix For: 1.0

>
> Before this idea is forgotten, I have raised this issue with the following text taken from the dev list mail thread "Re: New Startup Output, Mark 2":
> On Fri, 8 Jul 2005, Geir Magnusson Jr. wrote:
> > > At the risk of showing words in your mouth, are you suggesting it
> > > would just be nice to see how long it took to start each component?
> > 
> > Exactly. It would just give people a reference as to what got done at  
> > each additional delta of the progress bar...
> This should be easy for someone to implement.  Let me explain:
>  - The code is in the system module
>  - The class that starts the server is Daemon.
>  - Daemon uses a helper class that implements StartupMonitor and calls
>    the appropriate methods on that as things happen during the startup
>    sequence.  The helper class is responsible for nearly all output from
>    the startup classes themselves.
>  - The progress bar is implemented in ProgressBarStartupMonitor
>  - The non-pb is implemented in SilentStartupMonitor
> 		 So, if you want additional output in a non-progress-bar case (such 
> as with DEBUG or INFO output enabled), you can either add code to 
> SilentStartupMonitor or add a new implementation of StartupMonitor and 
> instantiate that instead of SilentStartupMonitor in the "-v" and "-vv" 
> cases (leaving SilentStartupMonitor for the "-quiet" case).
> 		 The startup monitor is called every time a configuration is 
> loading, loaded, starting, and started.  Note there are only a handful of 
> configurations (5-10, usually), you do not get a call for every GBean 
> loaded or something like that.  Anyway, if you want to know how long it 
> takes each configuration to be loaded and started, just call 
> System.currentTimeMillis here and there and keep some statistics.
> 		 I would recommend that you save any such output to the end for the 
> case where DEBUG or INFO output is enabled, since it would otherwise be 
> lost among all the initial output.  But if you save the stats along the 
> way, the final output could look something like this:
> 10:51:28,745 INFO  [Daemon] Server startup completed
> 10:51:28,745 INFO  [MyMonitor] 3s to start org/apache/geronimo/System
> 10:51:28,745 INFO  [MyMonitor] 5s to start org/apache/geronimo/Server
> 10:51:28,745 INFO  [MyMonitor] 2s to start org/apache/geronimo/Deployer
> ...
> 		 Finally, I don't think it's a good idea to add something like this
> to the progress bar.  The progress bar is very clean by design, and I
> don't think more specific statistics would be helpful to the typical user.  
> The server developers are more likely to be interested in finer-grained
> information (and more likely to want more detailed log output as well), so
> I'd prefer this kind of thing get added to the "-v" or "-vv" startup
> options instead.

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira


[jira] Updated: (GERONIMO-733) Ouput configuration startup times in startup console output

Posted by "David Blevins (JIRA)" <de...@geronimo.apache.org>.
     [ http://issues.apache.org/jira/browse/GERONIMO-733?page=all ]

David Blevins updated GERONIMO-733:
-----------------------------------

    Fix Version: 1.0
                     (was: 1.0-M5)

> Ouput configuration startup times in startup console output
> -----------------------------------------------------------
>
>          Key: GERONIMO-733
>          URL: http://issues.apache.org/jira/browse/GERONIMO-733
>      Project: Geronimo
>         Type: Improvement
>   Components: general
>     Reporter: John Sisson
>     Priority: Minor
>      Fix For: 1.0

>
> Before this idea is forgotten, I have raised this issue with the following text taken from the dev list mail thread "Re: New Startup Output, Mark 2":
> On Fri, 8 Jul 2005, Geir Magnusson Jr. wrote:
> > > At the risk of showing words in your mouth, are you suggesting it
> > > would just be nice to see how long it took to start each component?
> > 
> > Exactly. It would just give people a reference as to what got done at  
> > each additional delta of the progress bar...
> This should be easy for someone to implement.  Let me explain:
>  - The code is in the system module
>  - The class that starts the server is Daemon.
>  - Daemon uses a helper class that implements StartupMonitor and calls
>    the appropriate methods on that as things happen during the startup
>    sequence.  The helper class is responsible for nearly all output from
>    the startup classes themselves.
>  - The progress bar is implemented in ProgressBarStartupMonitor
>  - The non-pb is implemented in SilentStartupMonitor
> 		 So, if you want additional output in a non-progress-bar case (such 
> as with DEBUG or INFO output enabled), you can either add code to 
> SilentStartupMonitor or add a new implementation of StartupMonitor and 
> instantiate that instead of SilentStartupMonitor in the "-v" and "-vv" 
> cases (leaving SilentStartupMonitor for the "-quiet" case).
> 		 The startup monitor is called every time a configuration is 
> loading, loaded, starting, and started.  Note there are only a handful of 
> configurations (5-10, usually), you do not get a call for every GBean 
> loaded or something like that.  Anyway, if you want to know how long it 
> takes each configuration to be loaded and started, just call 
> System.currentTimeMillis here and there and keep some statistics.
> 		 I would recommend that you save any such output to the end for the 
> case where DEBUG or INFO output is enabled, since it would otherwise be 
> lost among all the initial output.  But if you save the stats along the 
> way, the final output could look something like this:
> 10:51:28,745 INFO  [Daemon] Server startup completed
> 10:51:28,745 INFO  [MyMonitor] 3s to start org/apache/geronimo/System
> 10:51:28,745 INFO  [MyMonitor] 5s to start org/apache/geronimo/Server
> 10:51:28,745 INFO  [MyMonitor] 2s to start org/apache/geronimo/Deployer
> ...
> 		 Finally, I don't think it's a good idea to add something like this
> to the progress bar.  The progress bar is very clean by design, and I
> don't think more specific statistics would be helpful to the typical user.  
> The server developers are more likely to be interested in finer-grained
> information (and more likely to want more detailed log output as well), so
> I'd prefer this kind of thing get added to the "-v" or "-vv" startup
> options instead.

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira


[jira] Closed: (GERONIMO-733) Ouput configuration startup times in startup console output

Posted by "John Sisson (JIRA)" <de...@geronimo.apache.org>.
     [ http://issues.apache.org/jira/browse/GERONIMO-733?page=all ]
     
John Sisson closed GERONIMO-733:
--------------------------------


> Ouput configuration startup times in startup console output
> -----------------------------------------------------------
>
>          Key: GERONIMO-733
>          URL: http://issues.apache.org/jira/browse/GERONIMO-733
>      Project: Geronimo
>         Type: Improvement
>   Components: general
>     Reporter: John Sisson
>     Priority: Minor
>      Fix For: 1.0

>
> Before this idea is forgotten, I have raised this issue with the following text taken from the dev list mail thread "Re: New Startup Output, Mark 2":
> On Fri, 8 Jul 2005, Geir Magnusson Jr. wrote:
> > > At the risk of showing words in your mouth, are you suggesting it
> > > would just be nice to see how long it took to start each component?
> > 
> > Exactly. It would just give people a reference as to what got done at  
> > each additional delta of the progress bar...
> This should be easy for someone to implement.  Let me explain:
>  - The code is in the system module
>  - The class that starts the server is Daemon.
>  - Daemon uses a helper class that implements StartupMonitor and calls
>    the appropriate methods on that as things happen during the startup
>    sequence.  The helper class is responsible for nearly all output from
>    the startup classes themselves.
>  - The progress bar is implemented in ProgressBarStartupMonitor
>  - The non-pb is implemented in SilentStartupMonitor
> 		 So, if you want additional output in a non-progress-bar case (such 
> as with DEBUG or INFO output enabled), you can either add code to 
> SilentStartupMonitor or add a new implementation of StartupMonitor and 
> instantiate that instead of SilentStartupMonitor in the "-v" and "-vv" 
> cases (leaving SilentStartupMonitor for the "-quiet" case).
> 		 The startup monitor is called every time a configuration is 
> loading, loaded, starting, and started.  Note there are only a handful of 
> configurations (5-10, usually), you do not get a call for every GBean 
> loaded or something like that.  Anyway, if you want to know how long it 
> takes each configuration to be loaded and started, just call 
> System.currentTimeMillis here and there and keep some statistics.
> 		 I would recommend that you save any such output to the end for the 
> case where DEBUG or INFO output is enabled, since it would otherwise be 
> lost among all the initial output.  But if you save the stats along the 
> way, the final output could look something like this:
> 10:51:28,745 INFO  [Daemon] Server startup completed
> 10:51:28,745 INFO  [MyMonitor] 3s to start org/apache/geronimo/System
> 10:51:28,745 INFO  [MyMonitor] 5s to start org/apache/geronimo/Server
> 10:51:28,745 INFO  [MyMonitor] 2s to start org/apache/geronimo/Deployer
> ...
> 		 Finally, I don't think it's a good idea to add something like this
> to the progress bar.  The progress bar is very clean by design, and I
> don't think more specific statistics would be helpful to the typical user.  
> The server developers are more likely to be interested in finer-grained
> information (and more likely to want more detailed log output as well), so
> I'd prefer this kind of thing get added to the "-v" or "-vv" startup
> options instead.

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira


[jira] Updated: (GERONIMO-733) Ouput configuration startup times in startup console output

Posted by "John Sisson (JIRA)" <de...@geronimo.apache.org>.
     [ http://issues.apache.org/jira/browse/GERONIMO-733?page=all ]

John Sisson updated GERONIMO-733:
---------------------------------

    Fix Version: 1.0-M5
        Version:     (was: 1.0-M5)

> Ouput configuration startup times in startup console output
> -----------------------------------------------------------
>
>          Key: GERONIMO-733
>          URL: http://issues.apache.org/jira/browse/GERONIMO-733
>      Project: Geronimo
>         Type: Improvement
>   Components: general
>     Reporter: John Sisson
>     Priority: Minor
>      Fix For: 1.0-M5

>
> Before this idea is forgotten, I have raised this issue with the following text taken from the dev list mail thread "Re: New Startup Output, Mark 2":
> On Fri, 8 Jul 2005, Geir Magnusson Jr. wrote:
> > > At the risk of showing words in your mouth, are you suggesting it
> > > would just be nice to see how long it took to start each component?
> > 
> > Exactly. It would just give people a reference as to what got done at  
> > each additional delta of the progress bar...
> This should be easy for someone to implement.  Let me explain:
>  - The code is in the system module
>  - The class that starts the server is Daemon.
>  - Daemon uses a helper class that implements StartupMonitor and calls
>    the appropriate methods on that as things happen during the startup
>    sequence.  The helper class is responsible for nearly all output from
>    the startup classes themselves.
>  - The progress bar is implemented in ProgressBarStartupMonitor
>  - The non-pb is implemented in SilentStartupMonitor
> 		 So, if you want additional output in a non-progress-bar case (such 
> as with DEBUG or INFO output enabled), you can either add code to 
> SilentStartupMonitor or add a new implementation of StartupMonitor and 
> instantiate that instead of SilentStartupMonitor in the "-v" and "-vv" 
> cases (leaving SilentStartupMonitor for the "-quiet" case).
> 		 The startup monitor is called every time a configuration is 
> loading, loaded, starting, and started.  Note there are only a handful of 
> configurations (5-10, usually), you do not get a call for every GBean 
> loaded or something like that.  Anyway, if you want to know how long it 
> takes each configuration to be loaded and started, just call 
> System.currentTimeMillis here and there and keep some statistics.
> 		 I would recommend that you save any such output to the end for the 
> case where DEBUG or INFO output is enabled, since it would otherwise be 
> lost among all the initial output.  But if you save the stats along the 
> way, the final output could look something like this:
> 10:51:28,745 INFO  [Daemon] Server startup completed
> 10:51:28,745 INFO  [MyMonitor] 3s to start org/apache/geronimo/System
> 10:51:28,745 INFO  [MyMonitor] 5s to start org/apache/geronimo/Server
> 10:51:28,745 INFO  [MyMonitor] 2s to start org/apache/geronimo/Deployer
> ...
> 		 Finally, I don't think it's a good idea to add something like this
> to the progress bar.  The progress bar is very clean by design, and I
> don't think more specific statistics would be helpful to the typical user.  
> The server developers are more likely to be interested in finer-grained
> information (and more likely to want more detailed log output as well), so
> I'd prefer this kind of thing get added to the "-v" or "-vv" startup
> options instead.

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira