Profile of Net/SSLeay.pm

Filename	/usr/local/lib/perl5/site_perl/mach/5.24/Net/SSLeay.pm
Statements	Executed 163 statements in 9.72ms

Subroutines
Calls	P	F	Exclusive Time	Inclusive Time	Subroutine
1	1	1	4.42ms	4.42ms	Net::SSLeay::::load_error_stringsNet::SSLeay::load_error_strings (xsub)
20	14	1	2.01ms	2.39ms	Net::SSLeay::::AUTOLOADNet::SSLeay::AUTOLOAD
1	1	1	469µs	469µs	Net::SSLeay::::library_initNet::SSLeay::library_init (xsub)
20	1	1	205µs	205µs	Net::SSLeay::::CORE:substNet::SSLeay::CORE:subst (opcode)
20	1	1	166µs	166µs	Net::SSLeay::::constantNet::SSLeay::constant (xsub)
1	1	1	144µs	190µs	Net::SSLeay::::BEGIN@449Net::SSLeay::BEGIN@449
1	1	1	128µs	314µs	Net::SSLeay::::randomizeNet::SSLeay::randomize
1	1	1	127µs	127µs	Net::SSLeay::::RAND_load_fileNet::SSLeay::RAND_load_file (xsub)
1	1	1	56µs	69µs	Net::SSLeay::::BEGIN@16Net::SSLeay::BEGIN@16
1	1	1	47µs	47µs	Net::SSLeay::::OpenSSL_add_all_digestsNet::SSLeay::OpenSSL_add_all_digests (xsub)
1	1	1	44µs	44µs	Net::SSLeay::::PEM_read_bio_DHparamsNet::SSLeay::PEM_read_bio_DHparams (xsub)
1	1	1	43µs	4.66ms	Net::SSLeay::::BEGIN@19Net::SSLeay::BEGIN@19
1	1	1	31µs	110µs	Net::SSLeay::::BEGIN@20Net::SSLeay::BEGIN@20
1	1	1	30µs	30µs	Net::SSLeay::::RAND_seedNet::SSLeay::RAND_seed (xsub)
2	2	1	29µs	29µs	Net::SSLeay::::CORE:ftereadNet::SSLeay::CORE:fteread (opcode)
1	1	1	25µs	1.12ms	Net::SSLeay::::BEGIN@24Net::SSLeay::BEGIN@24
1	1	1	22µs	410µs	Net::SSLeay::::BEGIN@18Net::SSLeay::BEGIN@18
1	1	1	21µs	211µs	Net::SSLeay::::BEGIN@17Net::SSLeay::BEGIN@17
1	1	1	11µs	11µs	Net::SSLeay::::BIO_newNet::SSLeay::BIO_new (xsub)
1	1	1	9µs	9µs	Net::SSLeay::::BIO_freeNet::SSLeay::BIO_free (xsub)
1	1	1	9µs	9µs	Net::SSLeay::::BIO_writeNet::SSLeay::BIO_write (xsub)
1	1	1	9µs	9µs	Net::SSLeay::::CORE:matchNet::SSLeay::CORE:match (opcode)
1	1	1	7µs	7µs	Net::SSLeay::::BIO_s_memNet::SSLeay::BIO_s_mem (xsub)
0	0	0	0s	0s	Net::SSLeay::::die_if_ssl_errorNet::SSLeay::die_if_ssl_error
0	0	0	0s	0s	Net::SSLeay::::die_nowNet::SSLeay::die_now
0	0	0	0s	0s	Net::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
- -
16	2	70µs	2	81µs	# spent 69µs (56+12) within Net::SSLeay::BEGIN@16 which was called: # once (56µs+12µs) by IO::Socket::SSL::BEGIN@19 at line 16 # spent 69µs making 1 call to Net::SSLeay::BEGIN@16 # spent 12µs making 1 call to strict::import
17	2	66µs	2	402µs	# spent 211µs (21+190) within Net::SSLeay::BEGIN@17 which was called: # once (21µs+190µs) by IO::Socket::SSL::BEGIN@19 at line 17 # spent 211µs making 1 call to Net::SSLeay::BEGIN@17 # spent 190µs making 1 call to Exporter::import
18	2	74µs	2	797µs	# spent 410µs (22+387) within Net::SSLeay::BEGIN@18 which was called: # once (22µs+387µs) by IO::Socket::SSL::BEGIN@19 at line 18 # spent 410µs making 1 call to Net::SSLeay::BEGIN@18 # spent 387µs making 1 call to vars::import
19	2	67µs	2	9.27ms	# spent 4.66ms (43µs+4.61) within Net::SSLeay::BEGIN@19 which was called: # once (43µs+4.61ms) by IO::Socket::SSL::BEGIN@19 at line 19 # spent 4.66ms making 1 call to Net::SSLeay::BEGIN@19 # spent 4.61ms making 1 call to Exporter::import
20	2	77µs	2	189µs	# spent 110µs (31+79) within Net::SSLeay::BEGIN@20 which was called: # once (31µs+79µs) by IO::Socket::SSL::BEGIN@19 at line 20 # spent 110µs making 1 call to Net::SSLeay::BEGIN@20 # spent 79µs making 1 call to Exporter::import
21	1	26µs
- -
23	1	2µs
24	2	2.16ms	2	2.22ms	# spent 1.12ms (25µs+1.10) within Net::SSLeay::BEGIN@24 which was called: # once (25µs+1.10ms) by IO::Socket::SSL::BEGIN@19 at line 24 # spent 1.12ms making 1 call to Net::SSLeay::BEGIN@24 # spent 1.10ms making 1 call to AutoLoader::import
- -
27	1	2µs
- -
37	1	2µs
- -
41	1	2µs
- -
45	1	1µs
- -
63	1	2µs
64	1	2µs
- -
66	1	2µs
67	1	27µs
- -
74	1	166µs
- -
378					# spent 2.39ms (2.01+380µs) within Net::SSLeay::AUTOLOAD which was called 20 times, avg 120µs/call: # 5 times (547µs+92µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 261 of IO/Socket/SSL.pm, avg 128µs/call # 3 times (278µs+58µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 2171 of IO/Socket/SSL.pm, avg 112µs/call # once (125µs+39µs) by IO::Socket::SSL::BEGIN@46 at line 46 of IO/Socket/SSL.pm # once (123µs+22µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 39 of IO/Socket/SSL.pm # once (125µs+19µs) by IO::Socket::SSL::SSL_Context::BEGIN@2168 at line 2168 of IO/Socket/SSL.pm # once (105µs+15µs) by IO::Socket::SSL::BEGIN@48 at line 48 of IO/Socket/SSL.pm # once (97µs+22µs) by IO::Socket::SSL::BEGIN@49 at line 49 of IO/Socket/SSL.pm # once (102µs+14µs) by IO::Socket::SSL::BEGIN@70 at line 71 of IO/Socket/SSL.pm # once (94µs+16µs) by IO::Socket::SSL::BEGIN@47 at line 47 of IO/Socket/SSL.pm # once (90µs+18µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 41 of IO/Socket/SSL.pm # once (98µs+10µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 278 of IO/Socket/SSL.pm # once (96µs+10µs) by IO::Socket::SSL::SSL_Context::BEGIN@2169 at line 2169 of IO/Socket/SSL.pm # once (78µs+12µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 40 of IO/Socket/SSL.pm # once (58µs+32µs) by IO::Socket::SSL::init at line 200 of IO/Socket/SSL.pm
- -
383	20	34µs
384	20	434µs	20	205µs	# spent 205µs making 20 calls to Net::SSLeay::CORE:subst, avg 10µs/call
385	20	288µs	20	166µs	# spent 166µs making 20 calls to Net::SSLeay::constant, avg 8µs/call
386	20	71µs
387	1	22µs	1	9µs	# spent 9µs making 1 call to Net::SSLeay::CORE:match
388	1	3µs
389	1	17µs	1	842µs	# spent 842µs making 1 call to AutoLoader::AUTOLOAD
- -
395	19	1.19ms			# spent 28µs executing statements in string eval # includes 10µs spent executing 2 calls to 1 sub defined therein. # spent 24µs executing statements in string eval # includes 5µs spent executing 1 call to 1 sub defined therein. # spent 17µs executing statements in string eval # includes 10µs spent executing 2 calls to 1 sub defined therein. # spent 16µs executing statements in string eval # includes 9µs spent executing 2 calls to 1 sub defined therein. # spent 16µs executing statements in string eval # includes 10µs spent executing 2 calls to 1 sub defined therein. # spent 16µs executing statements in string eval # includes 19µs spent executing 2 calls to 1 sub defined therein. # spent 10µ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 4µs spent executing 1 call to 1 sub defined therein. # spent 9µ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 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. # 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.
396	19	366µs	19	88µs	# spent 6µs making 1 call to Net::SSLeay::ERROR_WANT_READ # spent 5µs making 1 call to Net::SSLeay::FILETYPE_PEM # spent 5µs making 1 call to Net::SSLeay::VERIFY_NONE # 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_TLSv1_1 # spent 5µs making 1 call to Net::SSLeay::OP_SINGLE_DH_USE # spent 5µs making 1 call to Net::SSLeay::VERIFY_CLIENT_ONCE # spent 5µs making 1 call to Net::SSLeay::OP_NO_TLSv1 # spent 5µs making 1 call to Net::SSLeay::VERIFY_PEER # spent 4µs making 1 call to Net::SSLeay::OP_ALL # spent 4µs making 1 call to Net::SSLeay::OP_NO_SSLv2 # spent 4µs making 1 call to Net::SSLeay::ERROR_SYSCALL # spent 4µs making 1 call to Net::SSLeay::ERROR_WANT_WRITE # spent 4µs making 1 call to Net::SSLeay::FILETYPE_ASN1 # spent 4µs making 1 call to Net::SSLeay::OPENSSL_VERSION_NUMBER # spent 4µs making 1 call to Net::SSLeay::OP_NO_SSLv3 # 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::X509_V_FLAG_TRUSTED_FIRST
- -
400	1	10µs
401	1	3.73ms	1	3.70ms	# spent 3.70ms making 1 call to XSLoader::load
402	1	3µs
403	1	4µs
- -
411	1	3µs
- -
415
- -
431
- -
439
- -
449					# spent 190µs (144+46) within Net::SSLeay::BEGIN@449 which was called: # once (144µs+46µs) by IO::Socket::SSL::BEGIN@19 at line 452
450	1	71µs			# spent 92µs executing statements in string eval # includes 37µs spent executing 1 call to 2 subs defined therein.
451	1	13µs
452	1	260µs	1	190µs	# spent 190µs making 1 call to Net::SSLeay::BEGIN@449
- -
457	1	134µs
- -
915					### Arrange some randomness for eay PRNG
916
917					# spent 314µs (128+186) within Net::SSLeay::randomize which was called: # once (128µs+186µs) by IO::Socket::SSL::init at line 24 of AutoLoader.pm sub randomize (;$$$) {
918	1	3µs			my ($rn_seed_file, $seed, $egd_path) = @_;
919	1	2µs			my $rnsf = defined($rn_seed_file) && -r $rn_seed_file;
920
921	1	2µs			$egd_path = '';
922	1	10µs			$egd_path = $ENV{'EGD_PATH'} if $ENV{'EGD_PATH'};
923
924	1	97µs	1	30µs	RAND_seed(rand() + $$); # Stir it with time and pid # spent 30µs making 1 call to Net::SSLeay::RAND_seed
925
926	1	29µs	1	15µ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
931	1	1µs			RAND_load_file($rn_seed_file, -s _) if $rnsf;
932	1	1µs			RAND_seed($seed) if $seed;
933	1	2µs			RAND_seed($ENV{RND_SEED}) if $ENV{RND_SEED};
934	1	169µs	2	140µs	RAND_load_file($Net::SSLeay::random_device, $Net::SSLeay::how_random/8) # spent 127µs making 1 call to Net::SSLeay::RAND_load_file # spent 13µs making 1 call to Net::SSLeay::CORE:fteread
935					if -r $Net::SSLeay::random_device;
936					}
937
938					# end of Net::SSLeay::randomize
939	1	7µs			1;

					# 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 7µs within Net::SSLeay::BIO_s_mem which was called: # once (7µs+0s) by IO::Socket::SSL::init at line 207 of IO/Socket/SSL.pm sub Net::SSLeay::BIO_s_mem; # xsub
					# spent 9µs within Net::SSLeay::BIO_write which was called: # once (9µs+0s) by IO::Socket::SSL::init at line 209 of IO/Socket/SSL.pm sub Net::SSLeay::BIO_write; # xsub
					# spent 29µs within Net::SSLeay::CORE:fteread which was called 2 times, avg 14µs/call: # once (15µs+0s) by Net::SSLeay::randomize at line 926 # once (13µs+0s) by Net::SSLeay::randomize at line 934 sub Net::SSLeay::CORE:fteread; # opcode
					# spent 9µs within Net::SSLeay::CORE:match which was called: # once (9µs+0s) by Net::SSLeay::AUTOLOAD at line 387 sub Net::SSLeay::CORE:match; # opcode
					# spent 205µs within Net::SSLeay::CORE:subst which was called 20 times, avg 10µs/call: # 20 times (205µs+0s) by Net::SSLeay::AUTOLOAD at line 384, avg 10µs/call sub Net::SSLeay::CORE:subst; # opcode
					# spent 47µs within Net::SSLeay::OpenSSL_add_all_digests which was called: # once (47µs+0s) by IO::Socket::SSL::init at line 199 of IO/Socket/SSL.pm sub Net::SSLeay::OpenSSL_add_all_digests; # xsub
					# spent 44µs within Net::SSLeay::PEM_read_bio_DHparams which was called: # once (44µs+0s) by IO::Socket::SSL::init at line 219 of IO/Socket/SSL.pm sub Net::SSLeay::PEM_read_bio_DHparams; # xsub
					# spent 127µs within Net::SSLeay::RAND_load_file which was called: # once (127µs+0s) by Net::SSLeay::randomize at line 934 sub Net::SSLeay::RAND_load_file; # xsub
					# spent 30µs within Net::SSLeay::RAND_seed which was called: # once (30µs+0s) by Net::SSLeay::randomize at line 924 sub Net::SSLeay::RAND_seed; # xsub
					# spent 166µs within Net::SSLeay::constant which was called 20 times, avg 8µs/call: # 20 times (166µs+0s) by Net::SSLeay::AUTOLOAD at line 385, avg 8µs/call sub Net::SSLeay::constant; # xsub
					# spent 469µs within Net::SSLeay::library_init which was called: # once (469µs+0s) by IO::Socket::SSL::init at line 196 of IO/Socket/SSL.pm sub Net::SSLeay::library_init; # xsub
					# spent 4.42ms within Net::SSLeay::load_error_strings which was called: # once (4.42ms+0s) by IO::Socket::SSL::init at line 198 of IO/Socket/SSL.pm sub Net::SSLeay::load_error_strings; # xsub