← Index
NYTProf Performance Profile   « block view • line view • sub view »
For -e
  Run on Wed Nov 17 22:00:36 2010
Reported on Wed Nov 17 22:13:36 2010

Filename/home/doy/coding/src/Moose/blib/lib//Moose/Meta/Role/Composite.pm
StatementsExecuted 625 statements in 12.8ms
Subroutines
Calls P F Exclusive
Time		 Inclusive
Time		 Subroutine
72117.70ms16.8msMoose::Meta::Role::Composite::::add_methodMoose::Meta::Role::Composite::add_method
311551µs2.38msMoose::Meta::Role::Composite::::newMoose::Meta::Role::Composite::new
1822438µs615µsMoose::Meta::Role::Composite::::has_methodMoose::Meta::Role::Composite::has_method
311316µs70.3msMoose::Meta::Role::Composite::::apply_paramsMoose::Meta::Role::Composite::apply_params
311112µs152µsMoose::Meta::Role::Composite::::_get_local_methodsMoose::Meta::Role::Composite::_get_local_methods
11177µs96µsMoose::Meta::Role::Composite::::BEGIN@3Moose::Meta::Role::Composite::BEGIN@3
11151µs340µsMoose::Meta::Role::Composite::::BEGIN@13Moose::Meta::Role::Composite::BEGIN@13
11142µs203µsMoose::Meta::Role::Composite::::BEGIN@7Moose::Meta::Role::Composite::BEGIN@7
31139µs39µsMoose::Meta::Role::Composite::::__ANON__[:30]Moose::Meta::Role::Composite::__ANON__[:30]
11138µs3.05msMoose::Meta::Role::Composite::::BEGIN@5Moose::Meta::Role::Composite::BEGIN@5
11138µs106µsMoose::Meta::Role::Composite::::BEGIN@4Moose::Meta::Role::Composite::BEGIN@4
0000s0sMoose::Meta::Role::Composite::::get_methodMoose::Meta::Role::Composite::get_method
0000s0sMoose::Meta::Role::Composite::::get_method_listMoose::Meta::Role::Composite::get_method_list
0000s0sMoose::Meta::Role::Composite::::reinitializeMoose::Meta::Role::Composite::reinitialize
Call graph for these subroutines as a Graphviz dot language file.
Line State
ments		 Time
on line		 Calls Time
in subs		 Code
1package Moose::Meta::Role::Composite;
2
33101µs2115µs
# spent 96µs (77+19) within Moose::Meta::Role::Composite::BEGIN@3 which was called: # once (77µs+19µs) by Moose::BEGIN@28 at line 3
use strict;
# spent 96µs making 1 call to Moose::Meta::Role::Composite::BEGIN@3 # spent 19µs making 1 call to strict::import
4395µs2174µs
# spent 106µs (38+68) within Moose::Meta::Role::Composite::BEGIN@4 which was called: # once (38µs+68µs) by Moose::BEGIN@28 at line 4
use warnings;
# spent 106µs making 1 call to Moose::Meta::Role::Composite::BEGIN@4 # spent 68µs making 1 call to warnings::import
53148µs26.06ms
# spent 3.05ms (38µs+3.01) within Moose::Meta::Role::Composite::BEGIN@5 which was called: # once (38µs+3.01ms) by Moose::BEGIN@28 at line 5
use metaclass;
# spent 3.05ms making 1 call to Moose::Meta::Role::Composite::BEGIN@5 # spent 3.01ms making 1 call to metaclass::import
6
73222µs2364µs
# spent 203µs (42+161) within Moose::Meta::Role::Composite::BEGIN@7 which was called: # once (42µs+161µs) by Moose::BEGIN@28 at line 7
use Scalar::Util 'blessed';
# spent 203µs making 1 call to Moose::Meta::Role::Composite::BEGIN@7 # spent 161µs making 1 call to Exporter::import
8
915µsour $VERSION = '1.19';
10160µs$VERSION = eval $VERSION;
# spent 11µs executing statements in string eval
1114µsour $AUTHORITY = 'cpan:STEVAN';
12
1332.05ms2629µs
# spent 340µs (51+289) within Moose::Meta::Role::Composite::BEGIN@13 which was called: # once (51µs+289µs) by Moose::BEGIN@28 at line 13
use base 'Moose::Meta::Role';
# spent 340µs making 1 call to Moose::Meta::Role::Composite::BEGIN@13 # spent 289µs making 1 call to base::import
14
15# NOTE:
16# we need to override the ->name
17# method from Class::MOP::Package
18# since we don't have an actual
19# package for this.
20# - SL
21127µs22.10ms__PACKAGE__->meta->add_attribute('name' => (reader => 'name'));
# spent 1.95ms making 1 call to Class::MOP::Mixin::HasAttributes::add_attribute # spent 150µs making 1 call to Moose::Meta::Role::Composite::meta
22
23# NOTE:
24# Again, since we don't have a real
25# package to store our methods in,
26# we use a HASH ref instead.
27# - SL
28__PACKAGE__->meta->add_attribute('_methods' => (
29 reader => '_method_map',
30356µs
# spent 39µs within Moose::Meta::Role::Composite::__ANON__[/home/doy/coding/src/Moose/blib/lib//Moose/Meta/Role/Composite.pm:30] which was called 3 times, avg 13µs/call: # 3 times (39µs+0s) by Moose::Meta::Role::Composite::_new at line 12 of generated method (unknown origin), avg 13µs/call
default => sub { {} }
31131µs22.10ms));
# spent 2.01ms making 1 call to Class::MOP::Mixin::HasAttributes::add_attribute # spent 88µs making 1 call to Moose::Meta::Role::Composite::meta
32
33124µs22.02ms__PACKAGE__->meta->add_attribute(
# spent 1.94ms making 1 call to Class::MOP::Mixin::HasAttributes::add_attribute # spent 88µs making 1 call to Moose::Meta::Role::Composite::meta
34 'application_role_summation_class',
35 reader => 'application_role_summation_class',
36 default => 'Moose::Meta::Role::Application::RoleSummation',
37);
38
39
# spent 2.38ms (551µs+1.83) within Moose::Meta::Role::Composite::new which was called 3 times, avg 793µs/call: # 3 times (551µs+1.83ms) by Moose::Meta::Role::combine at line 508 of Moose/Meta/Role.pm, avg 793µs/call
sub new {
40325µs my ($class, %params) = @_;
41
42 # the roles param is required ...
43323µs foreach ( @{$params{roles}} ) {
448156µs841µs unless ( $_->isa('Moose::Meta::Role') ) {
# spent 41µs making 8 calls to UNIVERSAL::isa, avg 5µs/call
45 require Moose;
46 Moose->throw_error("The list of roles must be instances of Moose::Meta::Role, not $_");
47 }
48 }
49
50876µs850µs my @composition_roles = map {
# spent 50µs making 8 calls to Moose::Meta::Role::composition_class_roles, avg 6µs/call
51 $_->composition_class_roles
52338µs } @{ $params{roles} };
53
5438µs if (@composition_roles) {
55 my $meta = Moose::Meta::Class->create_anon_class(
56 superclasses => [ $class ],
57 roles => [ @composition_roles ],
58 cache => 1,
59 );
60 $class = $meta->name;
61 }
62
63 # and the name is created from the
64 # roles if one has not been provided
6511198µs840µs $params{name} ||= (join "|" => map { $_->name } @{$params{roles}});
# spent 40µs making 8 calls to Class::MOP::Package::name, avg 5µs/call
66375µs31.70ms $class->_new(\%params);
# spent 1.70ms making 3 calls to Moose::Meta::Role::Composite::_new, avg 566µs/call
67}
68
69# This is largely a cope of what's in Moose::Meta::Role (itself
70# largely a copy of Class::MOP::Class). However, we can't actually
71# call add_package_symbol, because there's no package to which which
72# add the symbol.
73
# spent 16.8ms (7.70+9.07) within Moose::Meta::Role::Composite::add_method which was called 72 times, avg 233µs/call: # 72 times (7.70ms+9.07ms) by Moose::Meta::Role::Application::RoleSummation::apply_methods at line 200 of Moose/Meta/Role/Application/RoleSummation.pm, avg 233µs/call
sub add_method {
7472299µs my ($self, $method_name, $method) = @_;
75
7672156µs unless ( defined $method_name && $method_name ) {
77 Moose->throw_error("You must define a method name");
78 }
79
8072119µs my $body;
81721.35ms72369µs if (blessed($method)) {
# spent 369µs making 72 calls to Scalar::Util::blessed, avg 5µs/call
82721.14ms72367µs $body = $method->body;
# spent 367µs making 72 calls to Class::MOP::Method::body, avg 5µs/call
83723.89ms3607.49ms if ($method->package_name ne $self->name) {
# spent 5.04ms making 72 calls to Class::MOP::Method::clone, avg 70µs/call # spent 1.68ms making 144 calls to Moose::Meta::Role::Composite::name, avg 12µs/call # spent 421µs making 72 calls to UNIVERSAL::can, avg 6µs/call # spent 347µs making 72 calls to Class::MOP::Method::package_name, avg 5µs/call
84 $method = $method->clone(
85 package_name => $self->name,
86 name => $method_name
87 ) if $method->can('clone');
88 }
89 }
90 else {
91 $body = $method;
92 $method = $self->wrap_method_body( body => $body, name => $method_name );
93 }
94
95721.55ms72849µs $self->_method_map->{$method_name} = $method;
# spent 849µs making 72 calls to Moose::Meta::Role::Composite::_method_map, avg 12µs/call
96}
97
98sub get_method_list {
99 my $self = shift;
100 return keys %{ $self->_method_map };
101}
102
103
# spent 152µs (112+40) within Moose::Meta::Role::Composite::_get_local_methods which was called 3 times, avg 51µs/call: # 3 times (112µs+40µs) by Moose::Meta::Role::Application::ToRole::apply_methods at line 80 of Moose/Meta/Role/Application/ToRole.pm, avg 51µs/call
sub _get_local_methods {
10438µs my $self = shift;
1053100µs340µs return values %{ $self->_method_map };
# spent 40µs making 3 calls to Moose::Meta::Role::Composite::_method_map, avg 13µs/call
106}
107
108
# spent 615µs (438+177) within Moose::Meta::Role::Composite::has_method which was called 18 times, avg 34µs/call: # 9 times (235µs+90µs) by Moose::Meta::Role::Application::RoleSummation::apply_override_method_modifiers at line 218 of Moose/Meta/Role/Application/RoleSummation.pm, avg 36µs/call # 9 times (203µs+87µs) by Moose::Meta::Role::add_override_method_modifier at line 358 of Moose/Meta/Role.pm, avg 32µs/call
sub has_method {
1091858µs my ($self, $method_name) = @_;
110
11118364µs18177µs return exists $self->_method_map->{$method_name};
# spent 177µs making 18 calls to Moose::Meta::Role::Composite::_method_map, avg 10µs/call
112}
113
114sub get_method {
115 my ($self, $method_name) = @_;
116
117 return $self->_method_map->{$method_name};
118}
119
120
# spent 70.3ms (316µs+70.0) within Moose::Meta::Role::Composite::apply_params which was called 3 times, avg 23.4ms/call: # 3 times (316µs+70.0ms) by Moose::Meta::Role::combine at line 509 of Moose/Meta/Role.pm, avg 23.4ms/call
sub apply_params {
121313µs my ($self, $role_params) = @_;
122364µs648µs Class::MOP::load_class($self->application_role_summation_class);
# spent 48µs making 3 calls to Moose::Meta::Role::Composite::application_role_summation_class, avg 16µs/call # spent 728µs making 3 calls to Class::MOP::load_class, avg 243µs/call, recursion: max depth 2, sum of overlapping time 728µs
123
1243145µs969.2ms $self->application_role_summation_class->new(
# spent 68.7ms making 3 calls to Moose::Meta::Role::Application::apply, avg 22.9ms/call # spent 489µs making 3 calls to Moose::Meta::Role::Application::new, avg 163µs/call # spent 42µs making 3 calls to Moose::Meta::Role::Composite::application_role_summation_class, avg 14µs/call
125 role_params => $role_params,
126 )->apply($self);
127
128345µs return $self;
129}
130
131sub reinitialize {
132 my ( $class, $old_meta, @args ) = @_;
133
134 Moose->throw_error(
135 'Moose::Meta::Role::Composite instances can only be reinitialized from an existing metaclass instance'
136 )
137 if !blessed $old_meta
138 || !$old_meta->isa('Moose::Meta::Role::Composite');
139
140 my %existing_classes = map { $_ => $old_meta->$_() } qw(
141 application_role_summation_class
142 );
143
144 return $old_meta->meta->clone_object( $old_meta, %existing_classes, @args );
145}
146
147141µs1;
148
149__END__
Report produced by the NYTProf 4.04 Perl profiler, developed by Tim Bunce and Adam Kaplan.