Issue #4589 has been updated by Marcin Deranek.

This is with stored config turned off:

    Tue Aug 24 09:52:13 +0200 2010 Puppet (notice): Starting Puppet client 
version 0.25.5
    Tue Aug 24 09:55:24 +0200 2010 Puppet (notice): Finished catalog run in 
144.16 seconds
    Tue Aug 24 09:59:47 +0200 2010 Puppet (notice): Finished catalog run in 
194.78 seconds
    Tue Aug 24 10:04:20 +0200 2010 Puppet (notice): Finished catalog run in 
205.19 seconds
    Tue Aug 24 10:08:45 +0200 2010 Puppet (notice): Finished catalog run in 
198.01 seconds
    Tue Aug 24 10:13:20 +0200 2010 Puppet (notice): Finished catalog run in 
207.01 seconds

and after restart (stored config turned off):

    Tue Aug 24 10:13:58 +0200 2010 Puppet (notice): Caught TERM; calling stop
    Tue Aug 24 10:13:58 +0200 2010 Puppet (notice): Reopening log files
    Tue Aug 24 10:13:58 +0200 2010 Puppet (notice): Starting Puppet client 
version 0.25.5
    Tue Aug 24 10:16:49 +0200 2010 Puppet (notice): Finished catalog run in 
143.04 seconds
    Tue Aug 24 10:21:12 +0200 2010 Puppet (notice): Finished catalog run in 
196.32 seconds
    Tue Aug 24 10:25:44 +0200 2010 Puppet (notice): Finished catalog run in 
204.15 seconds
    Tue Aug 24 10:30:12 +0200 2010 Puppet (notice): Finished catalog run in 
200.22 seconds
    Tue Aug 24 10:34:42 +0200 2010 Puppet (notice): Finished catalog run in 
203.34 seconds

and after reload (stored config turned off):

    Tue Aug 24 10:36:36 +0200 2010 Puppet (notice): Caught HUP; calling restart
    Tue Aug 24 10:39:12 +0200 2010 Puppet (notice): Finished catalog run in 
201.42 seconds
    Tue Aug 24 10:43:39 +0200 2010 Puppet (notice): Finished catalog run in 
198.83 seconds
    Tue Aug 24 10:48:16 +0200 2010 Puppet (notice): Finished catalog run in 
208.97 seconds
    Tue Aug 24 10:52:51 +0200 2010 Puppet (notice): Finished catalog run in 
206.72 seconds
    Tue Aug 24 10:57:21 +0200 2010 Puppet (notice): Finished catalog run in 
201.97 seconds
----------------------------------------
Bug #4589: puppet 0.25.5 slower on 2+ run
http://projects.puppetlabs.com/issues/4589

Author: Marcin Deranek
Status: Needs more information
Priority: Normal
Assigned to: 
Category: package
Target version: 
Affected version: 0.25.5
Keywords: 
Branch: 


While migrating to puppet 0.25.5 we discovered that puppet is getting slower on 
every 2+ run by ~30%. All that extra time was generated by Package resource. 
For example generating a package resource on a sample machine with all 
installed packages:

<pre>
( echo -n "package { ["; for package in `rpm -q -a`; do echo -n 
"\"$package\","; done; echo -n "]: ensure => installed}" ) > /tmp/test.pp

If we tell puppetd to execute this recipe eg.

node default {
  include test.pp
}
</pre>

we get the following results (puppet running in daemon mode):

<pre>
Mon Aug 23 16:32:15 +0200 2010 Puppet (notice): Starting Puppet client version 
0.25.5
Mon Aug 23 16:34:56 +0200 2010 Puppet (notice): Finished catalog run in 141.73 
seconds
Mon Aug 23 16:39:20 +0200 2010 Puppet (notice): Finished catalog run in 195.50 
seconds
Mon Aug 23 16:43:49 +0200 2010 Puppet (notice): Finished catalog run in 201.67 
seconds
Mon Aug 23 16:48:20 +0200 2010 Puppet (notice): Finished catalog run in 201.71 
seconds
Mon Aug 23 16:52:51 +0200 2010 Puppet (notice): Finished catalog run in 203.66 
seconds
</pre>

as you can see first run takes ~140s whereas every next takes ~200s! System 
details:
CentOS 5.4; ruby 1.8.6-p369; puppet 0.25.5 with stored configuration; facter 
1.5.7

For comparison puppet 0.24.8 on the same system with the very same recipe is 
more consistent:

<pre>
Mon Aug 23 17:29:50 +0200 2010 Puppet (notice): Starting Puppet client version 
0.24.8
Mon Aug 23 17:30:59 +0200 2010 Puppet (notice): Starting catalog run
Mon Aug 23 17:33:22 +0200 2010 Puppet (notice): Finished catalog run in 142.95 
seconds
Mon Aug 23 17:33:30 +0200 2010 Puppet (notice): Starting catalog run
Mon Aug 23 17:35:55 +0200 2010 Puppet (notice): Finished catalog run in 144.44 
seconds
Mon Aug 23 17:37:03 +0200 2010 Puppet (notice): Starting catalog run
Mon Aug 23 17:39:40 +0200 2010 Puppet (notice): Finished catalog run in 156.39 
seconds
Mon Aug 23 17:40:48 +0200 2010 Puppet (notice): Starting catalog run
Mon Aug 23 17:43:25 +0200 2010 Puppet (notice): Finished catalog run in 156.40 
seconds
Mon Aug 23 17:44:34 +0200 2010 Puppet (notice): Starting catalog run
Mon Aug 23 17:47:01 +0200 2010 Puppet (notice): Finished catalog run in 147.44 
seconds
</pre>


-- 
You have received this notification because you have either subscribed to it, 
or are involved in it.
To change your notification preferences, please click here: 
http://projects.puppetlabs.com/my/account

-- 
You received this message because you are subscribed to the Google Groups 
"Puppet Bugs" group.
To post to this group, send email to [email protected].
To unsubscribe from this group, send email to 
[email protected].
For more options, visit this group at 
http://groups.google.com/group/puppet-bugs?hl=en.

Reply via email to