Huh.

Is there an strace for windows? It would be good to know exactly what's
going on during those breaks.

On 02/25/2013 09:16 PM, Olivier Trempe wrote:
> Hi,
> 
> I wrote a little "hello world" script and I am a little concerned by
> execution that hangs for long periods of time.
> 
> *computer:*
> Windows XP Professional Service Pack 3
> Intel(R) Xeon(R) CPU
> W3550 @ 3.07GHz
> 3.07GHz, 3.50 GB of RAM
> 
> *init.pp:*
> class hello
> {
>     notice('Hello world!')
> }
> 
> *command line:*
> puppet apply --debug -e 'include hello'
> 
> *output:*
> */Execution hangs ~12 seconds before printing first debug log line/*
> Debug: importing 'K:/Code/puppet/modules/hello/manifests/init.pp' in
> environment production
> Debug: Automatically imported hello from hello into production
> Notice: Scope(Class[Hello]): Hello world!
> Debug: Creating default schedules
> Debug: Failed to load library 'selinux' for feature 'selinux'
> Debug: Using settings: adding file resource 'requestdir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/certificate_requests]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/certificate_requests"}'
> Debug: Using settings: adding file resource 'client_datadir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/client_data]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :mode=>"750", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/client_data"}'
> Debug: Using settings: adding file resource 'hostprivkey':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private_keys/###########.############.net.pem]{:loglevel=>:debug,
> :ensure=>:file, :links=>:follow, :mode=>"600", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private_keys/###########.############.net.pem"}'
> Debug: Using settings: adding file resource 'vardir': 'File[C:/Documents
> and Settings/All Users/Application
> Data/PuppetLabs/puppet/var]{:loglevel=>:debug, :ensure=>:directory,
> :links=>:follow, :backup=>false, :path=>"C:/Documents and Settings/All
> Users/Application Data/PuppetLabs/puppet/var"}'
> Debug: Using settings: adding file resource 'statedir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :mode=>"1755", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state"}'
> Debug: Using settings: adding file resource 'rundir': 'File[C:/Documents
> and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/run]{:loglevel=>:debug, :ensure=>:directory,
> :links=>:follow, :mode=>"1777", :backup=>false, :path=>"C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/var/run"}'
> Debug: Using settings: adding file resource 'ssldir': 'File[C:/Documents
> and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl]{:loglevel=>:debug, :ensure=>:directory,
> :links=>:follow, :mode=>"771", :backup=>false, :path=>"C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/etc/ssl"}'
> Debug: Using settings: adding file resource 'privatekeydir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private_keys]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :mode=>"750", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private_keys"}'
> Debug: Using settings: adding file resource 'plugindest':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/lib]{:loglevel=>:debug, :ensure=>:directory,
> :links=>:follow, :backup=>false, :path=>"C:/Documents and Settings/All
> Users/Application Data/PuppetLabs/puppet/var/lib"}'
> Debug: Using settings: adding file resource 'statefile':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/state.yaml]{:loglevel=>:debug,
> :ensure=>:file, :links=>:follow, :mode=>"660", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/state.yaml"}'
> Debug: Using settings: adding file resource 'clientbucketdir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/clientbucket]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :mode=>"750", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/clientbucket"}'
> Debug: Using settings: adding file resource 'hostpubkey':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/public_keys/###########.############.net.pem]{:loglevel=>:debug,
> :ensure=>:file, :links=>:follow, :mode=>"644", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/public_keys/###########.############.net.pem"}'
> Debug: Using settings: adding file resource 'logdir': 'File[C:/Documents
> and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/log]{:loglevel=>:debug, :ensure=>:directory,
> :links=>:follow, :mode=>"750", :backup=>false, :path=>"C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/var/log"}'
> Debug: Using settings: adding file resource 'lastrunfile':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/last_run_summary.yaml]{:loglevel=>:debug,
> :ensure=>:file, :links=>:follow, :mode=>"644", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/last_run_summary.yaml"}'
> Debug: Using settings: adding file resource 'graphdir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/graphs]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/graphs"}'
> Debug: Using settings: adding file resource 'publickeydir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/public_keys]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/public_keys"}'
> Debug: Using settings: adding file resource 'privatedir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :mode=>"750", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private"}'
> Debug: Using settings: adding file resource 'clientyamldir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/client_yaml]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :mode=>"750", :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/client_yaml"}'
> Debug: Using settings: adding file resource 'confdir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc]{:loglevel=>:debug, :ensure=>:directory,
> :links=>:follow, :backup=>false, :path=>"C:/Documents and Settings/All
> Users/Application Data/PuppetLabs/puppet/etc"}'
> Debug: Using settings: adding file resource 'lastrunreport':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/last_run_report.yaml]{:loglevel=>:debug, 
> :ensure=>:file,
> :links=>:follow, :mode=>"640", :backup=>false, :path=>"C:/Documents and
> Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/last_run_report.yaml"}'
> Debug: Using settings: adding file resource 'certdir':
> 'File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/certs]{:loglevel=>:debug,
> :ensure=>:directory, :links=>:follow, :backup=>false,
> :path=>"C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/certs"}'
> Debug: Puppet::Type::File::ProviderPosix: feature posix is missing
> Debug: Failed to load library 'shadow' for feature 'libshadow'
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl]: Autorequiring File[C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/etc]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state]: Autorequiring File[C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/var]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/last_run_summary.yaml]: Autorequiring
> File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private_keys]: Autorequiring
> File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/last_run_report.yaml]: Autorequiring
> File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/lib]: Autorequiring File[C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/var]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/public_keys/###########.############.net.pem]:
> Autorequiring File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/public_keys]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/log]: Autorequiring File[C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/var]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/clientbucket]: Autorequiring
> File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/state.yaml]: Autorequiring
> File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/certs]: Autorequiring File[C:/Documents
> and Settings/All Users/Application Data/PuppetLabs/puppet/etc/ssl]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/client_data]: Autorequiring File[C:/Documents
> and Settings/All Users/Application Data/PuppetLabs/puppet/var]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state/graphs]: Autorequiring
> File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/state]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private]: Autorequiring File[C:/Documents
> and Settings/All Users/Application Data/PuppetLabs/puppet/etc/ssl]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private_keys/###########.############.net.pem]:
> Autorequiring File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/private_keys]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/run]: Autorequiring File[C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/var]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/certificate_requests]: Autorequiring
> File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/client_yaml]: Autorequiring File[C:/Documents
> and Settings/All Users/Application Data/PuppetLabs/puppet/var]
> Debug: /File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl/public_keys]: Autorequiring
> File[C:/Documents and Settings/All Users/Application
> Data/PuppetLabs/puppet/etc/ssl]
> Debug: Finishing transaction 86414160
> Debug: Loaded state in 0.00 seconds
> */Execution hangs another ~12 seconds here/*
> Debug: Loaded state in 0.00 seconds
> Info: Applying configuration version '1361821561'
> Debug: /Schedule[daily]: Skipping device resources because running on a host
> Debug: /Schedule[monthly]: Skipping device resources because running on
> a host
> Debug: /Schedule[hourly]: Skipping device resources because running on a
> host
> Debug: /Schedule[never]: Skipping device resources because running on a host
> Debug: /Schedule[weekly]: Skipping device resources because running on a
> host
> Debug: /Schedule[puppet]: Skipping device resources because running on a
> host
> Debug: Finishing transaction 98314548
> Debug: Storing state
> Debug: Stored state in 0.02 seconds
> Notice: Finished catalog run in 0.11 seconds
> Debug: Using settings: adding file resource 'rrddir': 'File[C:/Documents
> and Settings/All Users/Application
> Data/PuppetLabs/puppet/var/rrd]{:loglevel=>:debug, :ensure=>:directory,
> :links=>:follow, :mode=>"750", :backup=>false, :path=>"C:/Documents and
> Settings/All Users/Application Data/PuppetLabs/puppet/var/rrd"}'
> Debug: Finishing transaction 98020872
> Debug: Received report to process from ###########.############.net
> Debug: Processing report from ###########.############.net with
> processor Puppet::Reports::Store
> 
> 
> *total execution time:*
> 25 seconds... just to print hello world?!?
> 
> Is this a normal behavior?
> (It takes the same time without the --debug switch)
> 
> Thanks!
> 
> Olivier Trempe
> 
> 
> -- 
> You received this message because you are subscribed to the Google
> Groups "Puppet Users" group.
> To unsubscribe from this group and stop receiving emails from it, send
> an email to [email protected].
> To post to this group, send email to [email protected].
> Visit this group at http://groups.google.com/group/puppet-users?hl=en.
> For more options, visit https://groups.google.com/groups/opt_out.
>  
>  

-- 
You received this message because you are subscribed to the Google Groups 
"Puppet Users" group.
To unsubscribe from this group and stop receiving emails from it, send an email 
to [email protected].
To post to this group, send email to [email protected].
Visit this group at http://groups.google.com/group/puppet-users?hl=en.
For more options, visit https://groups.google.com/groups/opt_out.


Reply via email to