← Index
NYTProf Performance Profile   « line view »
For rbm/rbm
  Run on Wed Feb 12 20:36:06 2020
Reported on Wed Feb 12 21:42:25 2020

Filename/usr/lib/x86_64-linux-gnu/perl/5.28/Time/HiRes.pm
StatementsExecuted 32 statements in 912µs
Subroutines
Calls P F Exclusive
Time
Inclusive
Time
Subroutine
1221222µs247µsTime::HiRes::::statTime::HiRes::stat (xsub)
11118µs254µsTime::HiRes::::importTime::HiRes::import
11116µs22µsTime::HiRes::::AUTOLOADTime::HiRes::AUTOLOAD
11112µs12µsTime::HiRes::::BEGIN@3Time::HiRes::BEGIN@3
1116µs16µsTime::HiRes::::BEGIN@70Time::HiRes::BEGIN@70
1116µs8µsTime::HiRes::::BEGIN@4Time::HiRes::BEGIN@4
1113µs3µsTime::HiRes::::CORE:substTime::HiRes::CORE:subst (opcode)
1113µs3µsTime::HiRes::::constantTime::HiRes::constant (xsub)
1112µs2µsTime::HiRes::::BEGIN@7Time::HiRes::BEGIN@7
111700ns700nsTime::HiRes::::__ANON__[:71]Time::HiRes::__ANON__[:71]
0000s0sTime::HiRes::::tv_intervalTime::HiRes::tv_interval
Call graph for these subroutines as a Graphviz dot language file.
Line State
ments
Time
on line
Calls Time
in subs
Code
1package Time::HiRes;
2
3242µs112µs
# spent 12µs within Time::HiRes::BEGIN@3 which was called: # once (12µs+0s) by File::Copy::BEGIN@1 at line 3
{ use 5.006; }
# spent 12µs making 1 call to Time::HiRes::BEGIN@3
4324µs210µs
# spent 8µs (6+2) within Time::HiRes::BEGIN@4 which was called: # once (6µs+2µs) by File::Copy::BEGIN@1 at line 4
use strict;
# spent 8µs making 1 call to Time::HiRes::BEGIN@4 # spent 2µs making 1 call to strict::import
5
61700nsrequire Exporter;
72187µs12µs
# spent 2µs within Time::HiRes::BEGIN@7 which was called: # once (2µs+0s) by File::Copy::BEGIN@1 at line 7
use XSLoader ();
# spent 2µs making 1 call to Time::HiRes::BEGIN@7
8
917µsour @ISA = qw(Exporter);
10
111300nsour @EXPORT = qw( );
12# More or less this same list is in Makefile.PL. Should unify.
1314µsour @EXPORT_OK = qw (usleep sleep ualarm alarm gettimeofday time tv_interval
14 getitimer setitimer nanosleep clock_gettime clock_getres
15 clock clock_nanosleep
16 CLOCKS_PER_SEC
17 CLOCK_BOOTTIME
18 CLOCK_HIGHRES
19 CLOCK_MONOTONIC
20 CLOCK_MONOTONIC_COARSE
21 CLOCK_MONOTONIC_FAST
22 CLOCK_MONOTONIC_PRECISE
23 CLOCK_MONOTONIC_RAW
24 CLOCK_PROCESS_CPUTIME_ID
25 CLOCK_PROF
26 CLOCK_REALTIME
27 CLOCK_REALTIME_COARSE
28 CLOCK_REALTIME_FAST
29 CLOCK_REALTIME_PRECISE
30 CLOCK_REALTIME_RAW
31 CLOCK_SECOND
32 CLOCK_SOFTTIME
33 CLOCK_THREAD_CPUTIME_ID
34 CLOCK_TIMEOFDAY
35 CLOCK_UPTIME
36 CLOCK_UPTIME_COARSE
37 CLOCK_UPTIME_FAST
38 CLOCK_UPTIME_PRECISE
39 CLOCK_UPTIME_RAW
40 CLOCK_VIRTUAL
41 ITIMER_PROF
42 ITIMER_REAL
43 ITIMER_REALPROF
44 ITIMER_VIRTUAL
45 TIMER_ABSTIME
46 d_usleep d_ualarm d_gettimeofday d_getitimer d_setitimer
47 d_nanosleep d_clock_gettime d_clock_getres
48 d_clock d_clock_nanosleep d_hires_stat
49 d_futimens d_utimensat d_hires_utime
50 stat lstat utime
51 );
52
531200nsour $VERSION = '1.9759';
541100nsour $XS_VERSION = $VERSION;
55111µs$VERSION = eval $VERSION;
# spent 2µs executing statements in string eval
56
57our $AUTOLOAD;
58
# spent 22µs (16+6) within Time::HiRes::AUTOLOAD which was called: # once (16µs+6µs) by Time::HiRes::import at line 79
sub AUTOLOAD {
591100ns my $constname;
6018µs13µs ($constname = $AUTOLOAD) =~ s/.*:://;
# spent 3µs making 1 call to Time::HiRes::CORE:subst
61 # print "AUTOLOAD: constname = $constname ($AUTOLOAD)\n";
621200ns die "&Time::HiRes::constant not defined" if $constname eq 'constant';
6317µs13µs my ($error, $val) = constant($constname);
# spent 3µs making 1 call to Time::HiRes::constant
64 # print "AUTOLOAD: error = $error, val = $val\n";
651100ns if ($error) {
66 my (undef,$file,$line) = caller;
67 die "$error at $file line $line.\n";
68 }
69 {
703274µs226µs
# spent 16µs (6+10) within Time::HiRes::BEGIN@70 which was called: # once (6µs+10µs) by File::Copy::BEGIN@1 at line 70
no strict 'refs';
# spent 16µs making 1 call to Time::HiRes::BEGIN@70 # spent 10µs making 1 call to strict::unimport
7126µs
# spent 700ns within Time::HiRes::__ANON__[/usr/lib/x86_64-linux-gnu/perl/5.28/Time/HiRes.pm:71] which was called: # once (700ns+0s) by Time::HiRes::import at line 73
*$AUTOLOAD = sub { $val };
72 }
7315µs1700ns goto &$AUTOLOAD;
# spent 700ns making 1 call to Time::HiRes::__ANON__[Time/HiRes.pm:71]
74}
75
76
# spent 254µs (18+236) within Time::HiRes::import which was called: # once (18µs+236µs) by File::Copy::BEGIN@1 at line 1 of (eval 11)[File/Copy.pm:20]
sub import {
771400ns my $this = shift;
781500ns for my $i (@_) {
7924µs122µs if (($i eq 'clock_getres' && !&d_clock_getres) ||
# spent 22µs making 1 call to Time::HiRes::AUTOLOAD
80 ($i eq 'clock_gettime' && !&d_clock_gettime) ||
81 ($i eq 'clock_nanosleep' && !&d_clock_nanosleep) ||
82 ($i eq 'clock' && !&d_clock) ||
83 ($i eq 'nanosleep' && !&d_nanosleep) ||
84 ($i eq 'usleep' && !&d_usleep) ||
85 ($i eq 'utime' && !&d_hires_utime) ||
86 ($i eq 'ualarm' && !&d_ualarm)) {
87 require Carp;
88 Carp::croak("Time::HiRes::$i(): unimplemented in this platform");
89 }
90 }
9117µs119µs Time::HiRes->export_to_level(1, $this, @_);
# spent 19µs making 1 call to Exporter::export_to_level
92}
93
941316µs1308µsXSLoader::load( 'Time::HiRes', $XS_VERSION );
# spent 308µs making 1 call to XSLoader::load
95
96# Preloaded methods go here.
97
98sub tv_interval {
99 # probably could have been done in C
100 my ($a, $b) = @_;
101 $b = [gettimeofday()] unless defined($b);
102 (${$b}[0] - ${$a}[0]) + ((${$b}[1] - ${$a}[1]) / 1_000_000);
103}
104
105# Autoload methods go after =cut, and are processed by the autosplit program.
106
107110µs1;
108__END__
 
# spent 3µs within Time::HiRes::CORE:subst which was called: # once (3µs+0s) by Time::HiRes::AUTOLOAD at line 60
sub Time::HiRes::CORE:subst; # opcode
# spent 3µs within Time::HiRes::constant which was called: # once (3µs+0s) by Time::HiRes::AUTOLOAD at line 63
sub Time::HiRes::constant; # xsub
# spent 247µs (222+25) within Time::HiRes::stat which was called 12 times, avg 21µs/call: # 6 times (203µs+18µs) by File::Copy::copy at line 104 of File/Copy.pm, avg 37µs/call # 6 times (18µs+7µs) by File::Copy::copy at line 106 of File/Copy.pm, avg 4µs/call
sub Time::HiRes::stat; # xsub