← Index
NYTProf Performance Profile   « line view »
For /usr/local/bin/sa-learn
  Run on Sun Nov 5 02:36:06 2017
Reported on Sun Nov 5 02:56:21 2017

Filename/usr/local/lib/perl5/site_perl/mach/5.24/Net/SSLeay.pm
StatementsExecuted 163 statements in 9.97ms
Subroutines
Calls P F Exclusive
Time
Inclusive
Time
Subroutine
1114.46ms4.46msNet::SSLeay::::load_error_stringsNet::SSLeay::load_error_strings (xsub)
201412.00ms2.36msNet::SSLeay::::AUTOLOADNet::SSLeay::AUTOLOAD
111494µs494µsNet::SSLeay::::library_initNet::SSLeay::library_init (xsub)
2011195µs195µsNet::SSLeay::::CORE:substNet::SSLeay::CORE:subst (opcode)
2011149µs149µsNet::SSLeay::::constantNet::SSLeay::constant (xsub)
111143µs339µsNet::SSLeay::::randomizeNet::SSLeay::randomize
111142µs183µsNet::SSLeay::::BEGIN@449Net::SSLeay::BEGIN@449
111131µs131µsNet::SSLeay::::RAND_load_fileNet::SSLeay::RAND_load_file (xsub)
11150µs50µsNet::SSLeay::::PEM_read_bio_DHparamsNet::SSLeay::PEM_read_bio_DHparams (xsub)
11150µs62µsNet::SSLeay::::BEGIN@16Net::SSLeay::BEGIN@16
11143µs43µsNet::SSLeay::::OpenSSL_add_all_digestsNet::SSLeay::OpenSSL_add_all_digests (xsub)
11138µs129µsNet::SSLeay::::BEGIN@20Net::SSLeay::BEGIN@20
11135µs4.67msNet::SSLeay::::BEGIN@19Net::SSLeay::BEGIN@19
11132µs1.21msNet::SSLeay::::BEGIN@24Net::SSLeay::BEGIN@24
11132µs32µsNet::SSLeay::::RAND_seedNet::SSLeay::RAND_seed (xsub)
22132µs32µsNet::SSLeay::::CORE:ftereadNet::SSLeay::CORE:fteread (opcode)
11127µs402µsNet::SSLeay::::BEGIN@18Net::SSLeay::BEGIN@18
11125µs240µsNet::SSLeay::::BEGIN@17Net::SSLeay::BEGIN@17
11111µs11µsNet::SSLeay::::BIO_newNet::SSLeay::BIO_new (xsub)
11110µs10µsNet::SSLeay::::BIO_writeNet::SSLeay::BIO_write (xsub)
11110µs10µsNet::SSLeay::::CORE:matchNet::SSLeay::CORE:match (opcode)
1119µs9µsNet::SSLeay::::BIO_freeNet::SSLeay::BIO_free (xsub)
1118µs8µsNet::SSLeay::::BIO_s_memNet::SSLeay::BIO_s_mem (xsub)
0000s0sNet::SSLeay::::die_if_ssl_errorNet::SSLeay::die_if_ssl_error
0000s0sNet::SSLeay::::die_nowNet::SSLeay::die_now
0000s0sNet::SSLeay::::print_errsNet::SSLeay::print_errs
Call graph for these subroutines as a Graphviz dot language file.
Line State
ments
Time
on line
Calls Time
in subs
Code
1
- -
16273µs273µs
# spent 62µs (50+12) within Net::SSLeay::BEGIN@16 which was called: # once (50µs+12µs) by IO::Socket::SSL::BEGIN@19 at line 16
# spent 62µs making 1 call to Net::SSLeay::BEGIN@16 # spent 12µs making 1 call to strict::import
17298µs2456µs
# spent 240µs (25+215) within Net::SSLeay::BEGIN@17 which was called: # once (25µs+215µs) by IO::Socket::SSL::BEGIN@19 at line 17
# spent 240µs making 1 call to Net::SSLeay::BEGIN@17 # spent 215µs making 1 call to Exporter::import
18272µs2778µs
# spent 402µs (27+376) within Net::SSLeay::BEGIN@18 which was called: # once (27µs+376µs) by IO::Socket::SSL::BEGIN@19 at line 18
# spent 402µs making 1 call to Net::SSLeay::BEGIN@18 # spent 376µs making 1 call to vars::import
19290µs29.31ms
# spent 4.67ms (35µs+4.64) within Net::SSLeay::BEGIN@19 which was called: # once (35µs+4.64ms) by IO::Socket::SSL::BEGIN@19 at line 19
# spent 4.67ms making 1 call to Net::SSLeay::BEGIN@19 # spent 4.64ms making 1 call to Exporter::import
20282µs2220µs
# spent 129µs (38+91) within Net::SSLeay::BEGIN@20 which was called: # once (38µs+91µs) by IO::Socket::SSL::BEGIN@19 at line 20
# spent 129µs making 1 call to Net::SSLeay::BEGIN@20 # spent 91µs making 1 call to Exporter::import
21127µs
- -
2316µs
2422.19ms22.39ms
# spent 1.21ms (32µs+1.18) within Net::SSLeay::BEGIN@24 which was called: # once (32µs+1.18ms) by IO::Socket::SSL::BEGIN@19 at line 24
# spent 1.21ms making 1 call to Net::SSLeay::BEGIN@24 # spent 1.18ms making 1 call to AutoLoader::import
- -
2712µs
- -
3712µs
- -
4112µs
- -
4512µs
- -
6312µs
6411µs
- -
6612µs
67127µs
- -
741156µs
- -
378
# spent 2.36ms (2.00+354µs) within Net::SSLeay::AUTOLOAD which was called 20 times, avg 118µs/call: # 5 times (520µs+75µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 261 of IO/Socket/SSL.pm, avg 119µs/call # 3 times (278µs+35µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 2171 of IO/Socket/SSL.pm, avg 105µs/call # once (141µs+42µs) by IO::Socket::SSL::BEGIN@46 at line 46 of IO/Socket/SSL.pm # once (134µs+17µs) by IO::Socket::SSL::SSL_Context::BEGIN@2168 at line 2168 of IO/Socket/SSL.pm # once (124µs+24µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 39 of IO/Socket/SSL.pm # once (109µs+16µs) by IO::Socket::SSL::BEGIN@47 at line 47 of IO/Socket/SSL.pm # once (100µs+20µs) by IO::Socket::SSL::BEGIN@48 at line 48 of IO/Socket/SSL.pm # once (97µs+18µs) by IO::Socket::SSL::SSL_Context::BEGIN@2169 at line 2169 of IO/Socket/SSL.pm # once (98µs+15µs) by IO::Socket::SSL::BEGIN@70 at line 71 of IO/Socket/SSL.pm # once (96µs+15µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 278 of IO/Socket/SSL.pm # once (97µs+13µs) by IO::Socket::SSL::BEGIN@49 at line 49 of IO/Socket/SSL.pm # once (76µs+18µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 40 of IO/Socket/SSL.pm # once (72µs+19µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 41 of IO/Socket/SSL.pm # once (60µs+26µs) by IO::Socket::SSL::init at line 200 of IO/Socket/SSL.pm
- -
3832033µs
38420414µs20195µs
# spent 195µs making 20 calls to Net::SSLeay::CORE:subst, avg 10µs/call
38520275µs20149µs
# spent 149µs making 20 calls to Net::SSLeay::constant, avg 7µs/call
3862073µs
387130µs110µs
# spent 10µs making 1 call to Net::SSLeay::CORE:match
38813µs
389118µs1869µs
# spent 869µs making 1 call to AutoLoader::AUTOLOAD
- -
395191.22ms
# spent 20µs executing statements in string eval
# includes 11µs spent executing 2 calls to 1 sub defined therein. # spent 20µs executing statements in string eval
# includes 9µs spent executing 2 calls to 1 sub defined therein. # spent 19µs executing statements in string eval
# includes 10µs spent executing 2 calls to 1 sub defined therein. # spent 18µs executing statements in string eval
# includes 14µs spent executing 2 calls to 1 sub defined therein. # spent 17µs executing statements in string eval
# includes 12µs spent executing 2 calls to 1 sub defined therein. # spent 11µs executing statements in string eval
# includes 6µs spent executing 1 call to 1 sub defined therein. # spent 9µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 9µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 9µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 9µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 9µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 9µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 8µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 8µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 8µs executing statements in string eval
# includes 4µs spent executing 1 call to 1 sub defined therein. # spent 8µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein. # spent 8µs executing statements in string eval
# includes 4µs spent executing 1 call to 1 sub defined therein. # spent 8µs executing statements in string eval
# includes 4µs spent executing 1 call to 1 sub defined therein. # spent 8µs executing statements in string eval
# includes 5µs spent executing 1 call to 1 sub defined therein.
39619393µs1991µs
# spent 6µs making 1 call to Net::SSLeay::ERROR_WANT_READ # spent 6µs making 1 call to Net::SSLeay::VERIFY_NONE # spent 5µs making 1 call to Net::SSLeay::ERROR_SYSCALL # spent 5µs making 1 call to Net::SSLeay::FILETYPE_PEM # spent 5µs making 1 call to Net::SSLeay::VERIFY_FAIL_IF_NO_PEER_CERT # spent 5µs making 1 call to Net::SSLeay::OP_NO_SSLv3 # spent 5µs making 1 call to Net::SSLeay::ERROR_WANT_WRITE # spent 5µs making 1 call to Net::SSLeay::OPENSSL_VERSION_NUMBER # spent 5µs making 1 call to Net::SSLeay::OP_ALL # spent 5µs making 1 call to Net::SSLeay::OP_NO_SSLv2 # spent 5µs making 1 call to Net::SSLeay::OP_NO_TLSv1 # spent 5µs making 1 call to Net::SSLeay::VERIFY_PEER # spent 5µs making 1 call to Net::SSLeay::X509_V_FLAG_TRUSTED_FIRST # spent 5µs making 1 call to Net::SSLeay::VERIFY_CLIENT_ONCE # spent 4µs making 1 call to Net::SSLeay::OP_NO_TLSv1_2 # spent 4µs making 1 call to Net::SSLeay::OP_SINGLE_ECDH_USE # spent 4µs making 1 call to Net::SSLeay::FILETYPE_ASN1 # spent 4µs making 1 call to Net::SSLeay::OP_NO_TLSv1_1 # spent 4µs making 1 call to Net::SSLeay::OP_SINGLE_DH_USE
- -
40012µs
40113.83ms13.80ms
# spent 3.80ms making 1 call to XSLoader::load
40214µs
40314µs
- -
41112µs
- -
415
- -
431
- -
439
- -
449
# spent 183µs (142+41) within Net::SSLeay::BEGIN@449 which was called: # once (142µs+41µs) by IO::Socket::SSL::BEGIN@19 at line 452
450176µs
# spent 79µs executing statements in string eval
# includes 32µs spent executing 1 call to 2 subs defined therein.
451120µs
4521271µs1183µs
# spent 183µs making 1 call to Net::SSLeay::BEGIN@449
- -
4571126µs
- -
915### Arrange some randomness for eay PRNG
916
917
# spent 339µs (143+196) within Net::SSLeay::randomize which was called: # once (143µs+196µs) by IO::Socket::SSL::init at line 24 of AutoLoader.pm
sub randomize (;$$$) {
91812µs my ($rn_seed_file, $seed, $egd_path) = @_;
91913µs my $rnsf = defined($rn_seed_file) && -r $rn_seed_file;
920
92112µs $egd_path = '';
92219µs $egd_path = $ENV{'EGD_PATH'} if $ENV{'EGD_PATH'};
923
9241108µs132µs RAND_seed(rand() + $$); # Stir it with time and pid
# spent 32µs making 1 call to Net::SSLeay::RAND_seed
925
926128µs115µs unless ($rnsf || -r $Net::SSLeay::random_device || $seed || -S $egd_path) {
# spent 15µs making 1 call to Net::SSLeay::CORE:fteread
927 my $poll_retval = Net::SSLeay::RAND_poll();
928 warn "Random number generator not seeded!!!" if $trace && !$poll_retval;
929 }
930
93112µs RAND_load_file($rn_seed_file, -s _) if $rnsf;
93212µs RAND_seed($seed) if $seed;
93312µs RAND_seed($ENV{RND_SEED}) if $ENV{RND_SEED};
9341184µs2148µs RAND_load_file($Net::SSLeay::random_device, $Net::SSLeay::how_random/8)
# spent 131µs making 1 call to Net::SSLeay::RAND_load_file # spent 17µs making 1 call to Net::SSLeay::CORE:fteread
935 if -r $Net::SSLeay::random_device;
936}
937
938# end of Net::SSLeay::randomize
93918µs1;
 
# spent 9µs within Net::SSLeay::BIO_free which was called: # once (9µs+0s) by IO::Socket::SSL::init at line 220 of IO/Socket/SSL.pm
sub Net::SSLeay::BIO_free; # xsub
# spent 11µs within Net::SSLeay::BIO_new which was called: # once (11µs+0s) by IO::Socket::SSL::init at line 207 of IO/Socket/SSL.pm
sub Net::SSLeay::BIO_new; # xsub
# spent 8µs within Net::SSLeay::BIO_s_mem which was called: # once (8µs+0s) by IO::Socket::SSL::init at line 207 of IO/Socket/SSL.pm
sub Net::SSLeay::BIO_s_mem; # xsub
# spent 10µs within Net::SSLeay::BIO_write which was called: # once (10µs+0s) by IO::Socket::SSL::init at line 209 of IO/Socket/SSL.pm
sub Net::SSLeay::BIO_write; # xsub
# spent 32µs within Net::SSLeay::CORE:fteread which was called 2 times, avg 16µs/call: # once (17µs+0s) by Net::SSLeay::randomize at line 934 # once (15µs+0s) by Net::SSLeay::randomize at line 926
sub Net::SSLeay::CORE:fteread; # opcode
# spent 10µs within Net::SSLeay::CORE:match which was called: # once (10µs+0s) by Net::SSLeay::AUTOLOAD at line 387
sub Net::SSLeay::CORE:match; # opcode
# spent 195µs within Net::SSLeay::CORE:subst which was called 20 times, avg 10µs/call: # 20 times (195µs+0s) by Net::SSLeay::AUTOLOAD at line 384, avg 10µs/call
sub Net::SSLeay::CORE:subst; # opcode
# spent 43µs within Net::SSLeay::OpenSSL_add_all_digests which was called: # once (43µs+0s) by IO::Socket::SSL::init at line 199 of IO/Socket/SSL.pm
sub Net::SSLeay::OpenSSL_add_all_digests; # xsub
# spent 50µs within Net::SSLeay::PEM_read_bio_DHparams which was called: # once (50µs+0s) by IO::Socket::SSL::init at line 219 of IO/Socket/SSL.pm
sub Net::SSLeay::PEM_read_bio_DHparams; # xsub
# spent 131µs within Net::SSLeay::RAND_load_file which was called: # once (131µs+0s) by Net::SSLeay::randomize at line 934
sub Net::SSLeay::RAND_load_file; # xsub
# spent 32µs within Net::SSLeay::RAND_seed which was called: # once (32µs+0s) by Net::SSLeay::randomize at line 924
sub Net::SSLeay::RAND_seed; # xsub
# spent 149µs within Net::SSLeay::constant which was called 20 times, avg 7µs/call: # 20 times (149µs+0s) by Net::SSLeay::AUTOLOAD at line 385, avg 7µs/call
sub Net::SSLeay::constant; # xsub
# spent 494µs within Net::SSLeay::library_init which was called: # once (494µs+0s) by IO::Socket::SSL::init at line 196 of IO/Socket/SSL.pm
sub Net::SSLeay::library_init; # xsub
# spent 4.46ms within Net::SSLeay::load_error_strings which was called: # once (4.46ms+0s) by IO::Socket::SSL::init at line 198 of IO/Socket/SSL.pm
sub Net::SSLeay::load_error_strings; # xsub