Profile of Net/SSLeay.pm

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

Subroutines
Calls	P	F	Exclusive Time	Inclusive Time	Subroutine
1	1	1	4.00ms	4.00ms	Net::SSLeay::::load_error_stringsNet::SSLeay::load_error_strings (xsub)
20	14	1	1.78ms	2.06ms	Net::SSLeay::::AUTOLOADNet::SSLeay::AUTOLOAD
1	1	1	510µs	510µs	Net::SSLeay::::library_initNet::SSLeay::library_init (xsub)
20	1	1	163µs	163µs	Net::SSLeay::::CORE:substNet::SSLeay::CORE:subst (opcode)
1	1	1	152µs	195µs	Net::SSLeay::::BEGIN@449Net::SSLeay::BEGIN@449
1	1	1	129µs	297µs	Net::SSLeay::::randomizeNet::SSLeay::randomize
20	1	1	110µs	110µs	Net::SSLeay::::constantNet::SSLeay::constant (xsub)
1	1	1	109µs	109µs	Net::SSLeay::::RAND_load_fileNet::SSLeay::RAND_load_file (xsub)
1	1	1	47µs	63µs	Net::SSLeay::::BEGIN@16Net::SSLeay::BEGIN@16
1	1	1	45µs	45µ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	33µs	33µs	Net::SSLeay::::RAND_seedNet::SSLeay::RAND_seed (xsub)
1	1	1	30µs	3.28ms	Net::SSLeay::::BEGIN@19Net::SSLeay::BEGIN@19
2	2	1	26µs	26µs	Net::SSLeay::::CORE:ftereadNet::SSLeay::CORE:fteread (opcode)
1	1	1	25µs	1.03ms	Net::SSLeay::::BEGIN@24Net::SSLeay::BEGIN@24
1	1	1	25µs	206µs	Net::SSLeay::::BEGIN@17Net::SSLeay::BEGIN@17
1	1	1	22µs	81µs	Net::SSLeay::::BEGIN@20Net::SSLeay::BEGIN@20
1	1	1	22µs	277µs	Net::SSLeay::::BEGIN@18Net::SSLeay::BEGIN@18
1	1	1	11µs	11µs	Net::SSLeay::::BIO_newNet::SSLeay::BIO_new (xsub)
1	1	1	10µs	10µs	Net::SSLeay::::CORE:matchNet::SSLeay::CORE:match (opcode)
1	1	1	10µs	10µs	Net::SSLeay::::BIO_writeNet::SSLeay::BIO_write (xsub)
1	1	1	9µs	9µs	Net::SSLeay::::BIO_freeNet::SSLeay::BIO_free (xsub)
1	1	1	8µs	8µ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	60µs	2	79µs	# spent 63µs (47+16) within Net::SSLeay::BEGIN@16 which was called: # once (47µs+16µs) by IO::Socket::SSL::BEGIN@19 at line 16 # spent 63µs making 1 call to Net::SSLeay::BEGIN@16 # spent 16µs making 1 call to strict::import
17	2	70µs	2	387µs	# spent 206µs (25+181) within Net::SSLeay::BEGIN@17 which was called: # once (25µs+181µs) by IO::Socket::SSL::BEGIN@19 at line 17 # spent 206µs making 1 call to Net::SSLeay::BEGIN@17 # spent 181µs making 1 call to Exporter::import
18	2	60µs	2	531µs	# spent 277µs (22+254) within Net::SSLeay::BEGIN@18 which was called: # once (22µs+254µs) by IO::Socket::SSL::BEGIN@19 at line 18 # spent 277µs making 1 call to Net::SSLeay::BEGIN@18 # spent 254µs making 1 call to vars::import
19	2	64µs	2	6.53ms	# spent 3.28ms (30µs+3.25) within Net::SSLeay::BEGIN@19 which was called: # once (30µs+3.25ms) by IO::Socket::SSL::BEGIN@19 at line 19 # spent 3.28ms making 1 call to Net::SSLeay::BEGIN@19 # spent 3.25ms making 1 call to Exporter::import
20	2	78µs	2	139µs	# spent 81µs (22+58) within Net::SSLeay::BEGIN@20 which was called: # once (22µs+58µs) by IO::Socket::SSL::BEGIN@19 at line 20 # spent 81µs making 1 call to Net::SSLeay::BEGIN@20 # spent 58µs making 1 call to Exporter::import
21	1	32µs
- -
23	1	3µs
24	2	2.11ms	2	2.04ms	# spent 1.03ms (25µs+1.01) within Net::SSLeay::BEGIN@24 which was called: # once (25µs+1.01ms) by IO::Socket::SSL::BEGIN@19 at line 24 # spent 1.03ms making 1 call to Net::SSLeay::BEGIN@24 # spent 1.01ms making 1 call to AutoLoader::import
- -
27	1	2µs
- -
37	1	2µs
- -
41	1	2µs
- -
45	1	2µs
- -
63	1	2µs
64	1	2µs
- -
66	1	2µs
67	1	20µs
- -
74	1	137µs
- -
378					# spent 2.06ms (1.78+283µs) within Net::SSLeay::AUTOLOAD which was called 20 times, avg 103µs/call: # 5 times (445µs+49µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 261 of IO/Socket/SSL.pm, avg 99µs/call # 3 times (235µs+28µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 2171 of IO/Socket/SSL.pm, avg 88µs/call # once (144µs+32µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 39 of IO/Socket/SSL.pm # once (126µs+42µs) by IO::Socket::SSL::BEGIN@46 at line 46 of IO/Socket/SSL.pm # once (125µs+17µs) by IO::Socket::SSL::SSL_Context::BEGIN@2168 at line 2168 of IO/Socket/SSL.pm # once (91µs+18µs) by IO::Socket::SSL::BEGIN@70 at line 71 of IO/Socket/SSL.pm # once (91µs+9µs) by IO::Socket::SSL::BEGIN@47 at line 47 of IO/Socket/SSL.pm # once (89µs+10µs) by IO::Socket::SSL::SSL_Context::BEGIN@2169 at line 2169 of IO/Socket/SSL.pm # once (76µs+13µs) by IO::Socket::SSL::BEGIN@49 at line 49 of IO/Socket/SSL.pm # once (80µs+10µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 278 of IO/Socket/SSL.pm # once (77µs+10µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 40 of IO/Socket/SSL.pm # once (75µs+10µs) by IO::Socket::SSL::BEGIN@48 at line 48 of IO/Socket/SSL.pm # once (71µs+9µs) by Mail::SpamAssassin::Plugin::SpamCop::BEGIN@53 at line 41 of IO/Socket/SSL.pm # once (54µs+25µs) by IO::Socket::SSL::init at line 200 of IO/Socket/SSL.pm
- -
383	20	34µs
384	20	317µs	20	163µs	# spent 163µs making 20 calls to Net::SSLeay::CORE:subst, avg 8µs/call
385	20	238µs	20	110µs	# spent 110µs making 20 calls to Net::SSLeay::constant, avg 5µs/call
386	20	70µs
387	1	25µs	1	10µs	# spent 10µs making 1 call to Net::SSLeay::CORE:match
388	1	3µs
389	1	18µs	1	959µs	# spent 959µs making 1 call to AutoLoader::AUTOLOAD
- -
395	19	1.14ms			# spent 25µs executing statements in string eval # includes 5µs spent executing 1 call to 1 sub defined therein. # spent 21µs executing statements in string eval # includes 8µs spent executing 2 calls to 1 sub defined therein. # spent 20µ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 10µs spent executing 2 calls to 1 sub defined therein. # spent 16µs executing statements in string eval # includes 11µs spent executing 2 calls to 1 sub defined therein. # spent 15µs executing statements in string eval # includes 10µ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 4µ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 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.
396	19	262µs	19	91µ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::FILETYPE_PEM # spent 5µs making 1 call to Net::SSLeay::VERIFY_PEER # spent 5µs making 1 call to Net::SSLeay::OP_NO_SSLv3 # spent 5µs making 1 call to Net::SSLeay::ERROR_SYSCALL # spent 5µs making 1 call to Net::SSLeay::ERROR_WANT_WRITE # spent 5µs making 1 call to Net::SSLeay::FILETYPE_ASN1 # 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_1 # spent 5µs making 1 call to Net::SSLeay::OP_NO_TLSv1_2 # spent 5µs making 1 call to Net::SSLeay::VERIFY_CLIENT_ONCE # spent 4µs making 1 call to Net::SSLeay::OP_NO_TLSv1 # spent 4µs making 1 call to Net::SSLeay::VERIFY_FAIL_IF_NO_PEER_CERT # spent 4µs making 1 call to Net::SSLeay::OP_SINGLE_DH_USE # 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	2µs
401	1	3.84ms	1	3.81ms	# spent 3.81ms making 1 call to XSLoader::load
402	1	4µs
403	1	5µs
- -
411	1	3µs
- -
415
- -
431
- -
439
- -
449					# spent 195µs (152+43) within Net::SSLeay::BEGIN@449 which was called: # once (152µs+43µs) by IO::Socket::SSL::BEGIN@19 at line 452
450	1	71µs			# spent 90µs executing statements in string eval # includes 34µs spent executing 1 call to 2 subs defined therein.
451	1	13µs
452	1	223µs	1	195µs	# spent 195µs making 1 call to Net::SSLeay::BEGIN@449
- -
457	1	177µs
- -
915					### Arrange some randomness for eay PRNG
916
917					# spent 297µs (129+168) within Net::SSLeay::randomize which was called: # once (129µs+168µs) by IO::Socket::SSL::init at line 24 of AutoLoader.pm sub randomize (;$$$) {
918	1	2µ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	3µs			$egd_path = $ENV{'EGD_PATH'} if $ENV{'EGD_PATH'};
923
924	1	108µs	1	33µs	RAND_seed(rand() + $$); # Stir it with time and pid # spent 33µs making 1 call to Net::SSLeay::RAND_seed
925
926	1	28µs	1	16µs	unless ($rnsf \|\| -r $Net::SSLeay::random_device \|\| $seed \|\| -S $egd_path) { # spent 16µ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	2µs			RAND_load_file($rn_seed_file, -s _) if $rnsf;
932	1	2µs			RAND_seed($seed) if $seed;
933	1	3µs			RAND_seed($ENV{RND_SEED}) if $ENV{RND_SEED};
934	1	149µs	2	119µs	RAND_load_file($Net::SSLeay::random_device, $Net::SSLeay::how_random/8) # spent 109µs making 1 call to Net::SSLeay::RAND_load_file # spent 10µ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	8µ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 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 26µs within Net::SSLeay::CORE:fteread which was called 2 times, avg 13µs/call: # once (16µs+0s) by Net::SSLeay::randomize at line 926 # once (10µs+0s) by Net::SSLeay::randomize at line 934 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 163µs within Net::SSLeay::CORE:subst which was called 20 times, avg 8µs/call: # 20 times (163µs+0s) by Net::SSLeay::AUTOLOAD at line 384, avg 8µs/call sub Net::SSLeay::CORE:subst; # opcode
					# spent 45µs within Net::SSLeay::OpenSSL_add_all_digests which was called: # once (45µ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 109µs within Net::SSLeay::RAND_load_file which was called: # once (109µs+0s) by Net::SSLeay::randomize at line 934 sub Net::SSLeay::RAND_load_file; # xsub
					# spent 33µs within Net::SSLeay::RAND_seed which was called: # once (33µs+0s) by Net::SSLeay::randomize at line 924 sub Net::SSLeay::RAND_seed; # xsub
					# spent 110µs within Net::SSLeay::constant which was called 20 times, avg 5µs/call: # 20 times (110µs+0s) by Net::SSLeay::AUTOLOAD at line 385, avg 5µs/call sub Net::SSLeay::constant; # xsub
					# spent 510µs within Net::SSLeay::library_init which was called: # once (510µs+0s) by IO::Socket::SSL::init at line 196 of IO/Socket/SSL.pm sub Net::SSLeay::library_init; # xsub
					# spent 4.00ms within Net::SSLeay::load_error_strings which was called: # once (4.00ms+0s) by IO::Socket::SSL::init at line 198 of IO/Socket/SSL.pm sub Net::SSLeay::load_error_strings; # xsub