← Index
NYTProf Performance Profile   « line view »
For ../prof.pl
  Run on Wed Dec 14 15:57:08 2022
Reported on Wed Dec 14 16:00:33 2022

Filename/Users/ether/.perlbrew/libs/36.0@std/lib/perl5/Module/Implementation.pm
StatementsExecuted 141 statements in 1.19ms
Subroutines
Calls P F Exclusive
Time		 Inclusive
Time		 Subroutine
111943µs1.14msModule::Implementation::::BEGIN@9Module::Implementation::BEGIN@9
211108µs120µsModule::Implementation::::_copy_symbolsModule::Implementation::_copy_symbols
21152µs6.96msModule::Implementation::::_load_implementationModule::Implementation::_load_implementation
21139µs48µsModule::Implementation::::_build_loaderModule::Implementation::_build_loader
11129µs31µsModule::Implementation::::BEGIN@5Module::Implementation::BEGIN@5
22229µs7.11msModule::Implementation::::__ANON__[:52]Module::Implementation::__ANON__[:52]
21125µs6.79msModule::Implementation::::try {...} Module::Implementation::try {...}
142121µs21µsModule::Implementation::::CORE:substModule::Implementation::CORE:subst (opcode)
11116µs42µsModule::Implementation::::BEGIN@8Module::Implementation::BEGIN@8
2227µs55µsModule::Implementation::::build_loader_subModule::Implementation::build_loader_sub
1117µs22µsModule::Implementation::::BEGIN@129Module::Implementation::BEGIN@129
1117µs40µsModule::Implementation::::BEGIN@6Module::Implementation::BEGIN@6
1116µs13µsModule::Implementation::::BEGIN@128Module::Implementation::BEGIN@128
1113µs3µsModule::Implementation::::implementation_forModule::Implementation::implementation_for
0000s0sModule::Implementation::::__ANON__[:78]Module::Implementation::__ANON__[:78]
0000s0sModule::Implementation::::__ANON__[:82]Module::Implementation::__ANON__[:82]
0000s0sModule::Implementation::::__ANON__[:95]Module::Implementation::__ANON__[:95]
0000s0sModule::Implementation::::__ANON__[:98]Module::Implementation::__ANON__[:98]
0000s0sModule::Implementation::::catch {...} Module::Implementation::catch {...}
Call graph for these subroutines as a Graphviz dot language file.
Line State
ments		 Time
on line		 Calls Time
in subs		 Code
1package Module::Implementation;
2# git description: v0.08-2-gd599347
311µs$Module::Implementation::VERSION = '0.09';
4
5228µs233µs
# spent 31µs (29+2) within Module::Implementation::BEGIN@5 which was called: # once (29µs+2µs) by B::Hooks::EndOfScope::BEGIN@13 at line 5
use strict;
# spent 31µs making 1 call to Module::Implementation::BEGIN@5 # spent 2µs making 1 call to strict::import
6227µs273µs
# spent 40µs (7+33) within Module::Implementation::BEGIN@6 which was called: # once (7µs+33µs) by B::Hooks::EndOfScope::BEGIN@13 at line 6
use warnings;
# spent 40µs making 1 call to Module::Implementation::BEGIN@6 # spent 33µs making 1 call to warnings::import
7
8339µs368µs
# spent 42µs (16+26) within Module::Implementation::BEGIN@8 which was called: # once (16µs+26µs) by B::Hooks::EndOfScope::BEGIN@13 at line 8
use Module::Runtime 0.012 qw( require_module );
# spent 42µs making 1 call to Module::Implementation::BEGIN@8 # spent 14µs making 1 call to Module::Runtime::import # spent 12µs making 1 call to UNIVERSAL::VERSION
92677µs21.16ms
# spent 1.14ms (943µs+194µs) within Module::Implementation::BEGIN@9 which was called: # once (943µs+194µs) by B::Hooks::EndOfScope::BEGIN@13 at line 9
use Try::Tiny;
# spent 1.14ms making 1 call to Module::Implementation::BEGIN@9 # spent 23µs making 1 call to Exporter::import
10
11# This is needed for the benefit of Test::CleanNamespaces, which in turn loads
12# Package::Stash, which in turn loads this module and expects a minimum
13# version.
1410sunless ( exists $Module::Implementation::{VERSION}
15 && ${ $Module::Implementation::{VERSION} } ) {
16
17 $Module::Implementation::{VERSION} = \42;
18}
19
2010smy %Implementation;
21
22
# spent 55µs (7+48) within Module::Implementation::build_loader_sub which was called 2 times, avg 28µs/call: # once (5µs+35µs) by Package::Stash::BEGIN@12 at line 16 of Package/Stash.pm # once (2µs+13µs) by B::Hooks::EndOfScope::BEGIN@12 at line 14 of B/Hooks/EndOfScope.pm
sub build_loader_sub {
2321µs my $caller = caller();
24
25218µs248µs return _build_loader( $caller, @_ );
# spent 48µs making 2 calls to Module::Implementation::_build_loader, avg 24µs/call
26}
27
28
# spent 48µs (39+9) within Module::Implementation::_build_loader which was called 2 times, avg 24µs/call: # 2 times (39µs+9µs) by Module::Implementation::build_loader_sub at line 25, avg 24µs/call
sub _build_loader {
2920s my $package = shift;
3027µs my %args = @_;
31
3223µs my @implementations = @{ $args{implementations} };
3323µs my @symbols = @{ $args{symbols} || [] };
34
3520s my $implementation;
3623µs my $env_var = uc $package;
37217µs29µs $env_var =~ s/::/_/g;
# spent 9µs making 2 calls to Module::Implementation::CORE:subst, avg 4µs/call
3822µs $env_var .= '_IMPLEMENTATION';
39
40
# spent 7.11ms (29µs+7.08) within Module::Implementation::__ANON__[/Users/ether/.perlbrew/libs/36.0@std/lib/perl5/Module/Implementation.pm:52] which was called 2 times, avg 3.55ms/call: # once (15µs+4.74ms) by B::Hooks::EndOfScope::BEGIN@12 at line 14 of B/Hooks/EndOfScope.pm # once (14µs+2.33ms) by Package::Stash::BEGIN@12 at line 16 of Package/Stash.pm
return sub {
41 my ( $implementation, $loaded ) = _load_implementation(
42 $package,
4328µs26.96ms $ENV{$env_var},
# spent 6.96ms making 2 calls to Module::Implementation::_load_implementation, avg 3.48ms/call
44 \@implementations,
45 );
46
4722µs $Implementation{$package} = $implementation;
48
4927µs2120µs _copy_symbols( $loaded, $package, \@symbols );
# spent 120µs making 2 calls to Module::Implementation::_copy_symbols, avg 60µs/call
50
5129µs return $loaded;
52215µs };
53}
54
55
# spent 3µs within Module::Implementation::implementation_for which was called: # once (3µs+0s) by Package::Stash::BEGIN@12 at line 32 of Package/Stash.pm
sub implementation_for {
5611µs my $package = shift;
57
5813µs return $Implementation{$package};
59}
60
61
# spent 6.96ms (52µs+6.90) within Module::Implementation::_load_implementation which was called 2 times, avg 3.48ms/call: # 2 times (52µs+6.90ms) by Module::Implementation::__ANON__[/Users/ether/.perlbrew/libs/36.0@std/lib/perl5/Module/Implementation.pm:52] at line 43, avg 3.48ms/call
sub _load_implementation {
6220s my $package = shift;
6323µs my $env_value = shift;
6420s my $implementations = shift;
65
6621µs if ($env_value) {
67 die "$env_value is not a valid implementation for $package"
68 unless grep { $_ eq $env_value } @{$implementations};
69
70 my $requested = "${package}::$env_value";
71
72 # Values from the %ENV hash are tainted. We know it's safe to untaint
73 # this value because the value was one of our known implementations.
74 ($requested) = $requested =~ /^(.+)$/;
75
76 try {
77 require_module($requested);
78 }
79 catch {
80 require Carp;
81 Carp::croak("Could not load $requested: $_");
82 };
83
84 return ( $env_value, $requested );
85 }
86 else {
8720s my $err;
8821µs for my $possible ( @{$implementations} ) {
8921µs my $try = "${package}::$possible";
90
9120s my $ok;
92
# spent 6.79ms (25µs+6.77) within Module::Implementation::try {...} which was called 2 times, avg 3.40ms/call: # 2 times (25µs+6.77ms) by Try::Tiny::try at line 102 of Try/Tiny.pm, avg 3.40ms/call
try {
9329µs26.77ms require_module($try);
# spent 6.77ms making 2 calls to Module::Runtime::require_module, avg 3.38ms/call
94210µs $ok = 1;
95 }
96 catch {
97 $err .= $_ if defined $_;
98230µs46.90ms };
# spent 6.87ms making 2 calls to Try::Tiny::try, avg 3.44ms/call # spent 33µs making 2 calls to Try::Tiny::catch, avg 16µs/call
99
10029µs return ( $possible, $try ) if $ok;
101 }
102
103 require Carp;
104 if ( defined $err && length $err ) {
105 Carp::croak(
106 "Could not find a suitable $package implementation: $err");
107 }
108 else {
109 Carp::croak(
110 'Module::Runtime failed to load a module but did not throw a real error. This should never happen. Something is very broken'
111 );
112 }
113 }
114}
115
116
# spent 120µs (108+12) within Module::Implementation::_copy_symbols which was called 2 times, avg 60µs/call: # 2 times (108µs+12µs) by Module::Implementation::__ANON__[/Users/ether/.perlbrew/libs/36.0@std/lib/perl5/Module/Implementation.pm:52] at line 49, avg 60µs/call
sub _copy_symbols {
11721µs my $from_package = shift;
11821µs my $to_package = shift;
11921µs my $symbols = shift;
120
121213µs for my $sym ( @{$symbols} ) {
1221236µs1212µs my $type = $sym =~ s/^([\$\@\%\&\*])// ? $1 : '&';
# spent 12µs making 12 calls to Module::Implementation::CORE:subst, avg 1µs/call
123
124123µs my $from = "${from_package}::$sym";
125123µs my $to = "${to_package}::$sym";
126
127 {
1281437µs220µs
# spent 13µs (6+7) within Module::Implementation::BEGIN@128 which was called: # once (6µs+7µs) by B::Hooks::EndOfScope::BEGIN@13 at line 128
no strict 'refs';
# spent 13µs making 1 call to Module::Implementation::BEGIN@128 # spent 7µs making 1 call to strict::unimport
1292100µs237µs
# spent 22µs (7+15) within Module::Implementation::BEGIN@129 which was called: # once (7µs+15µs) by B::Hooks::EndOfScope::BEGIN@13 at line 129
no warnings 'once';
# spent 22µs making 1 call to Module::Implementation::BEGIN@129 # spent 15µs making 1 call to warnings::unimport
130
131 # Copied from Exporter
132 *{$to}
133 = $type eq '&' ? \&{$from}
134 : $type eq '$' ? \${$from}
135 : $type eq '@' ? \@{$from}
136 : $type eq '%' ? \%{$from}
1371254µs : $type eq '*' ? *{$from}
138 : die
139 "Can't copy symbol from $from_package to $to_package: $type$sym";
140 }
141 }
142}
143
14414µs1;
145
146# ABSTRACT: Loads one of several alternate underlying implementations for a module
147
148__END__
 
# spent 21µs within Module::Implementation::CORE:subst which was called 14 times, avg 2µs/call: # 12 times (12µs+0s) by Module::Implementation::_copy_symbols at line 122, avg 1µs/call # 2 times (9µs+0s) by Module::Implementation::_build_loader at line 37, avg 4µs/call
sub Module::Implementation::CORE:subst; # opcode
Report produced by the NYTProf 6.12 Perl profiler, developed by Tim Bunce based on work by Adam Kaplan and Salvador Fandiño García.