← Index
NYTProf Performance Profile   « line view »
For ../prof.pl
  Run on Wed Dec 14 16:10:05 2022
Reported on Wed Dec 14 16:12:57 2022

Filename/Users/ether/.perlbrew/libs/36.0@std/lib/perl5/Module/Implementation.pm
StatementsExecuted 141 statements in 1.05ms
Subroutines
Calls P F Exclusive
Time		 Inclusive
Time		 Subroutine
111748µs904µsModule::Implementation::::BEGIN@9Module::Implementation::BEGIN@9
21186µs95µsModule::Implementation::::_copy_symbolsModule::Implementation::_copy_symbols
21171µs6.98msModule::Implementation::::_load_implementationModule::Implementation::_load_implementation
11143µs47µsModule::Implementation::::BEGIN@5Module::Implementation::BEGIN@5
21119µs24µsModule::Implementation::::_build_loaderModule::Implementation::_build_loader
22218µs7.09msModule::Implementation::::__ANON__[:52]Module::Implementation::__ANON__[:52]
142114µs14µsModule::Implementation::::CORE:substModule::Implementation::CORE:subst (opcode)
11114µs72µsModule::Implementation::::BEGIN@8Module::Implementation::BEGIN@8
2229µs33µsModule::Implementation::::build_loader_subModule::Implementation::build_loader_sub
2118µs6.81msModule::Implementation::::try {...} Module::Implementation::try {...}
1117µs13µsModule::Implementation::::BEGIN@128Module::Implementation::BEGIN@128
1116µs33µsModule::Implementation::::BEGIN@6Module::Implementation::BEGIN@6
1115µs17µsModule::Implementation::::BEGIN@129Module::Implementation::BEGIN@129
1112µs2µ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
5230µs251µs
# spent 47µs (43+4) within Module::Implementation::BEGIN@5 which was called: # once (43µs+4µs) by B::Hooks::EndOfScope::BEGIN@13 at line 5
use strict;
# spent 47µs making 1 call to Module::Implementation::BEGIN@5 # spent 4µs making 1 call to strict::import
6252µs260µs
# spent 33µs (6+27) within Module::Implementation::BEGIN@6 which was called: # once (6µs+27µs) by B::Hooks::EndOfScope::BEGIN@13 at line 6
use warnings;
# spent 33µs making 1 call to Module::Implementation::BEGIN@6 # spent 27µs making 1 call to warnings::import
7
8370µs3130µs
# spent 72µs (14+58) within Module::Implementation::BEGIN@8 which was called: # once (14µs+58µs) by B::Hooks::EndOfScope::BEGIN@13 at line 8
use Module::Runtime 0.012 qw( require_module );
# spent 72µs making 1 call to Module::Implementation::BEGIN@8 # spent 45µs making 1 call to UNIVERSAL::VERSION # spent 13µs making 1 call to Module::Runtime::import
92533µs2924µs
# spent 904µs (748+156) within Module::Implementation::BEGIN@9 which was called: # once (748µs+156µs) by B::Hooks::EndOfScope::BEGIN@13 at line 9
use Try::Tiny;
# spent 904µs making 1 call to Module::Implementation::BEGIN@9 # spent 20µ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
2011µsmy %Implementation;
21
22
# spent 33µs (9+24) within Module::Implementation::build_loader_sub which was called 2 times, avg 16µs/call: # once (2µs+16µs) by Package::Stash::BEGIN@12 at line 16 of Package/Stash.pm # once (7µs+8µs) by B::Hooks::EndOfScope::BEGIN@12 at line 14 of B/Hooks/EndOfScope.pm
sub build_loader_sub {
2322µs my $caller = caller();
24
2529µs224µs return _build_loader( $caller, @_ );
# spent 24µs making 2 calls to Module::Implementation::_build_loader, avg 12µs/call
26}
27
28
# spent 24µs (19+5) within Module::Implementation::_build_loader which was called 2 times, avg 12µs/call: # 2 times (19µs+5µs) by Module::Implementation::build_loader_sub at line 25, avg 12µs/call
sub _build_loader {
2920s my $package = shift;
3025µs my %args = @_;
31
3222µs my @implementations = @{ $args{implementations} };
3321µs my @symbols = @{ $args{symbols} || [] };
34
3521µs my $implementation;
3621µs my $env_var = uc $package;
3728µs25µs $env_var =~ s/::/_/g;
# spent 5µs making 2 calls to Module::Implementation::CORE:subst, avg 2µs/call
3820s $env_var .= '_IMPLEMENTATION';
39
40
# spent 7.09ms (18µs+7.07) within Module::Implementation::__ANON__[/Users/ether/.perlbrew/libs/36.0@std/lib/perl5/Module/Implementation.pm:52] which was called 2 times, avg 3.54ms/call: # once (9µs+5.37ms) by B::Hooks::EndOfScope::BEGIN@12 at line 14 of B/Hooks/EndOfScope.pm # once (9µs+1.70ms) by Package::Stash::BEGIN@12 at line 16 of Package/Stash.pm
return sub {
41 my ( $implementation, $loaded ) = _load_implementation(
42 $package,
4326µs26.98ms $ENV{$env_var},
# spent 6.98ms making 2 calls to Module::Implementation::_load_implementation, avg 3.49ms/call
44 \@implementations,
45 );
46
4723µs $Implementation{$package} = $implementation;
48
4925µs295µs _copy_symbols( $loaded, $package, \@symbols );
# spent 95µs making 2 calls to Module::Implementation::_copy_symbols, avg 48µs/call
50
5124µs return $loaded;
52210µs };
53}
54
55
# spent 2µs within Module::Implementation::implementation_for which was called: # once (2µs+0s) by Package::Stash::BEGIN@12 at line 32 of Package/Stash.pm
sub implementation_for {
5610s my $package = shift;
57
5812µs return $Implementation{$package};
59}
60
61
# spent 6.98ms (71µs+6.90) within Module::Implementation::_load_implementation which was called 2 times, avg 3.49ms/call: # 2 times (71µ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.49ms/call
sub _load_implementation {
6220s my $package = shift;
6322µs my $env_value = shift;
6421µs 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;
8822µs for my $possible ( @{$implementations} ) {
8921µs my $try = "${package}::$possible";
90
9120s my $ok;
92
# spent 6.81ms (8µs+6.80) within Module::Implementation::try {...} which was called 2 times, avg 3.41ms/call: # 2 times (8µs+6.80ms) by Try::Tiny::try at line 102 of Try/Tiny.pm, avg 3.41ms/call
try {
9325µs26.80ms require_module($try);
# spent 6.80ms making 2 calls to Module::Runtime::require_module, avg 3.40ms/call
9425µs $ok = 1;
95 }
96 catch {
97 $err .= $_ if defined $_;
98251µs46.90ms };
# spent 6.88ms making 2 calls to Try::Tiny::try, avg 3.44ms/call # spent 20µs making 2 calls to Try::Tiny::catch, avg 10µs/call
99
100212µ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 95µs (86+9) within Module::Implementation::_copy_symbols which was called 2 times, avg 48µs/call: # 2 times (86µs+9µs) by Module::Implementation::__ANON__[/Users/ether/.perlbrew/libs/36.0@std/lib/perl5/Module/Implementation.pm:52] at line 49, avg 48µs/call
sub _copy_symbols {
11721µs my $from_package = shift;
11821µs my $to_package = shift;
11920s my $symbols = shift;
120
12126µs for my $sym ( @{$symbols} ) {
1221219µs129µs my $type = $sym =~ s/^([\$\@\%\&\*])// ? $1 : '&';
# spent 9µs making 12 calls to Module::Implementation::CORE:subst, avg 750ns/call
123
124124µs my $from = "${from_package}::$sym";
125122µs my $to = "${to_package}::$sym";
126
127 {
1281429µs219µs
# spent 13µs (7+6) within Module::Implementation::BEGIN@128 which was called: # once (7µs+6µ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 6µs making 1 call to strict::unimport
129299µs229µs
# spent 17µs (5+12) within Module::Implementation::BEGIN@129 which was called: # once (5µs+12µs) by B::Hooks::EndOfScope::BEGIN@13 at line 129
no warnings 'once';
# spent 17µs making 1 call to Module::Implementation::BEGIN@129 # spent 12µ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}
1371258µs : $type eq '*' ? *{$from}
138 : die
139 "Can't copy symbol from $from_package to $to_package: $type$sym";
140 }
141 }
142}
143
14413µs1;
145
146# ABSTRACT: Loads one of several alternate underlying implementations for a module
147
148__END__
 
# spent 14µs within Module::Implementation::CORE:subst which was called 14 times, avg 1µs/call: # 12 times (9µs+0s) by Module::Implementation::_copy_symbols at line 122, avg 750ns/call # 2 times (5µs+0s) by Module::Implementation::_build_loader at line 37, avg 2µ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.