Performance Profile Index
For /home/chris/git/koha.git/circ/circulation.pl
  Run on Tue Aug 25 19:38:48 2009
Reported on Tue Aug 25 19:39:06 2009

Profile of /home/chris/git/koha.git/circ/circulation.pl for 1.04s, executing 19321 statements and 4052 subroutine calls in 59 source files and 31 string evals.
Top 15 Subroutines — ordered by exclusive time
Calls P F Exclusive
Time		 Inclusive
Time		 Subroutine
1536413115ms115msDBI::st::::execute DBI::st::execute(xsub)
21255.6ms55.8msDBI::db::::do DBI::db::do(xsub)
1221110.1ms14.4msCGI::Carp::::stamp CGI::Carp::stamp
2119.66ms20.9msCGI::Session::::_load_pluggables CGI::Session::_load_pluggables
245219.08ms9.08msFile::Spec::Unix::::splitpathFile::Spec::Unix::splitpath
168238.31ms8.83msDBI::db::::ping DBI::db::ping(xsub)
6117.20ms7.76msCGI::::_compile CGI::_compile
69126.61ms16.4msDBI::db::::selectrow_array DBI::db::selectrow_array(xsub)
122116.10ms6.10msCGI::Carp::::realwarn CGI::Carp::realwarn
201126.06ms6.57msDBI::::_new_handle DBI::_new_handle(xsub)
18144125.69ms13.5msDBI::st::::fetchrow_hashref DBI::st::fetchrow_hashref(xsub)
20149144.70ms21.2msDBI::db::::prepare DBI::db::prepare(xsub)
123214.47ms9.29msCGI::Carp::::id CGI::Carp::id
201114.38ms11.5msDBI::::_new_sth DBI::_new_sth
18446133.86ms4.01msDBI::common::::FETCH DBI::common::FETCH(xsub)
See all 1098 subroutines
Source Code Files — ordered by exclusive time then name
StmtsExclusive
Time		 Avg.ReportsSource File
34059.5ms175µsline • block • sub/home/chris/git/koha.git/C4/Circulation.pm
4156.9ms1.39msline • block • subCGI/Session/Driver/mysql.pm
58542.3ms72µsline • block • sub/home/chris/git/koha.git/C4/Calendar.pm
445828.4ms6µsline • block • subCGI/Carp.pm
114420.0ms17µsline • block • sub/home/chris/git/koha.git/C4/Context.pm
63218.0ms28µsline • block • subCGI.pm (executed 7 string evals)
35314.9ms42µsline • block • sub/home/chris/git/koha.git/C4/Reserves.pm
131010.8ms8µsline • block • subDBI.pm
4818.93ms19µsline • block • sub/home/chris/git/koha.git/C4/Members.pm
8047.45ms9µsline • block • subDBD/mysql.pm
1636.78ms42µsline • block • sub/home/chris/git/koha.git/C4/Biblio.pm
2355.45ms23µsline • block • sub/home/chris/git/koha.git/C4/Auth.pm
4665.02ms11µsline • block • subCGI/Cookie.pm
4824.40ms9µsline • block • sub/home/chris/git/koha.git/C4/Dates.pm (executed 8 string evals)
25164.36ms2µsline • block • subFile/Spec/Unix.pm
4014.31ms11µsline • block • subCGI/Session.pm (executed 6 string evals)
2333.66ms16µsline • block • sub/home/chris/git/koha.git/circ/circulation.pl
10533.34ms3µsline • block • subCache/Memcached.pm
1633.08ms19µsline • block • subYAML/Base.pm (executed 4 string evals)
11302.94ms3µsline • block • subHTML/Template/Pro.pm
662.75ms42µsline • block • subCGI/Session/Driver/DBI.pm
142.62ms187µsline • block • sub/home/chris/git/koha.git/C4/Overdues.pm
392.43ms62µsline • block • subYAML.pm
752.02ms27µsline • block • sub/home/chris/git/koha.git/C4/Branch.pm
211.76ms84µsline • block • subYAML/Node.pm
351.20ms34µsline • block • sub/home/chris/git/koha.git/circ/../../lib/Storable.pm (autosplit into ../../lib/auto/Storable/thaw.al)
2991.07ms4µsline • block • subCache/Memcached/GetParser.pm
28961µs34µsline • block • subCGI/Session/Driver.pm
25902µs36µsline • block • subCGI/Session/Serialize/yaml.pm (executed 2 string evals)
7886µs127µsline • block • subYAML/Syck.pm
132799µs6µsline • block • sub/home/chris/git/koha.git/C4/Output.pm
486734µs2µsline • block • subCGI/Util.pm
151592µs4µsline • block • sub/home/chris/git/koha.git/C4/Languages.pm
16548µs34µsline • block • sub/home/chris/git/koha.git/C4/Items.pm
65536µs8µsline • block • subMemoize.pm (executed 2 string evals)
23516µs22µsline • block • sub/home/chris/git/koha.git/C4/Koha.pm
152482µs3µsline • block • subExporter.pm
83415µs5µsline • block • subbase.pm (executed 1 string eval)
43402µs9µsline • block • subData/Dumper.pm
70394µs6µsline • block • subMemoize/Memcached.pm
12233µs19µsline • block • subCGI/Session/ID/md5.pm
9226µs25µsline • block • subYAML/Tag.pm
132204µs2µsline • block • subText/Abbrev.pm
29180µs6µsline • block • subAutoLoader.pm
32173µs5µsline • block • suboverload.pm
71117µs2µsline • block • subwarnings.pm
595µs19µsline • block • sub/home/chris/git/koha.git/kohaversion.pl
3794µs3µsline • block • substrict.pm
2392µs4µsline • block • subconstant.pm
1533µs2µsline • block • subCGI/Session/ErrorHandler.pm
512µs2µsline • block • subUNIVERSAL.pm
811µs1µsline • block • sub/home/chris/git/koha.git/C4/Boolean.pm
17µs7µsline • block • subURI/Split.pm
1500ns500nsline • block • sub/home/chris/git/koha.git/C4/Print.pm
1300ns300nsline • block • sub/home/chris/git/koha.git/C4/Accounts.pm
1300ns300nsline • block • sub/home/chris/git/koha.git/C4/Search.pm
00s0sline • block • subPOSIX.pm
00s0sline • block • subStorable.pm (executed 1 string eval)
00s0sline • block • subDate/Calc.pm
19202334msTotal (31 string evals account for a further 119 statements)
3255.66msAverage
886µs9µsMedian
0.000898.3e-6Deviation

Package treemap
Packages - subroutine times rolled up to level 1 package name
Exclusive
Time		 Package Name Prefix
217msDBI:: (includes 5 packages)
50.2msCGI:: (includes 10 packages)
21.8msC4:: (includes 15 packages)
11.0msFile::
4.40msCache:: (includes 2 packages)
3.80msDBD:: (includes 3 packages)
3.38msHTML::
2.00msYAML:: (includes 2 packages)
1.32msStorable::
1.16msDate::
923µsMemoize:: (includes 2 packages)
818µsExporter::
504µsstrict::
502µsData::
432µsbase::
387µsPOSIX::
310µsUNIVERSAL::
292µsoverload::
234µswarnings::
210µsText::
102µsconstant::
87µsAutoLoader::
61µsURI::
35µsInternals::
31µsmro::
Packages - subroutine times rolled up to level 2 package name
Exclusive
Time		 Package Name Prefix
127msDBI::st::
75.4msDBI::db::
20.8msCGI::Carp::
12.9msCGI::Session:: (includes 6 packages)
11.6msCGI::
11.0msFile::Spec::
10.5msDBI::
6.75msC4::Context::
4.40msCache::Memcached:: (includes 2 packages)
3.92msDBI::common::
3.68msC4::Dates::
3.47msDBD::mysql::
3.38msHTML::Template::
2.59msCGI::Util::
2.31msCGI::Cookie::
1.96msC4::Calendar::
1.93msC4::Members::
1.47msC4::Reserves::
1.37msC4::Circulation::
1.32msStorable::
1.19msC4::Auth::
1.16msDate::Calc::
1.01msYAML::Base::
987µsYAML::Syck::
883µsC4::Biblio::
875µsC4::Output::
818µsExporter::
662µsC4::Languages::
516µsMemoize::
504µsstrict::
502µsData::Dumper::
432µsbase::
431µsC4::Branch::
408µsMemoize::Memcached::
387µsPOSIX::
334µsDBD::_:: (includes 2 packages)
310µsUNIVERSAL::
292µsoverload::
234µswarnings::
210µsText::Abbrev::
207µsC4::Koha::
204µsC4::Overdues::
129µsC4::Items::
102µsconstant::
87µsAutoLoader::
61µsURI::Split::
54µsC4::Boolean::
48µsDBI::dr::
35µsInternals::
31µsmro::
0sYAML::
Packages - subroutine times rolled up to level 3 package name
Exclusive
Time		 Package Name Prefix
127msDBI::st::
75.4msDBI::db::
20.8msCGI::Carp::
12.2msCGI::Session::
11.6msCGI::
11.0msFile::Spec::Unix::
10.5msDBI::
6.75msC4::Context::
3.92msDBI::common::
3.68msC4::Dates::
3.47msDBD::mysql::st::
3.38msHTML::Template::Pro::
3.22msCache::Memcached::
2.59msCGI::Util::
2.31msCGI::Cookie::
1.96msC4::Calendar::
1.93msC4::Members::
1.47msC4::Reserves::
1.37msC4::Circulation::
1.32msStorable::
1.19msC4::Auth::
1.19msCache::Memcached::GetParser::
1.16msDate::Calc::
1.01msYAML::Base::
987µsYAML::Syck::
883µsC4::Biblio::
875µsC4::Output::
818µsExporter::
662µsC4::Languages::
516µsMemoize::
504µsstrict::
502µsData::Dumper::
452µsCGI::Session::Driver:: (includes 3 packages)
432µsbase::
431µsC4::Branch::
408µsMemoize::Memcached::
387µsPOSIX::
310µsUNIVERSAL::
301µsDBD::_::st::
292µsoverload::
234µswarnings::
210µsText::Abbrev::
207µsC4::Koha::
204µsC4::Overdues::
182µsCGI::Session::ErrorHandler::
129µsC4::Items::
102µsconstant::
90µsCGI::Session::Serialize::
87µsAutoLoader::
61µsURI::Split::
54µsC4::Boolean::
48µsDBI::dr::
35µsInternals::
33µsDBD::_::common::
31µsmro::
0sDBD::mysql::
0sYAML::
Packages - subroutine times rolled up to level 4 package name
Exclusive
Time		 Package Name Prefix
127msDBI::st::
75.4msDBI::db::
20.8msCGI::Carp::
12.2msCGI::Session::
11.6msCGI::
11.0msFile::Spec::Unix::
10.5msDBI::
6.75msC4::Context::
3.92msDBI::common::
3.68msC4::Dates::
3.47msDBD::mysql::st::
3.38msHTML::Template::Pro::
3.22msCache::Memcached::
2.59msCGI::Util::
2.31msCGI::Cookie::
1.96msC4::Calendar::
1.93msC4::Members::
1.47msC4::Reserves::
1.37msC4::Circulation::
1.32msStorable::
1.19msC4::Auth::
1.19msCache::Memcached::GetParser::
1.16msDate::Calc::
1.01msYAML::Base::
987µsYAML::Syck::
883µsC4::Biblio::
875µsC4::Output::
818µsExporter::
662µsC4::Languages::
516µsMemoize::
504µsstrict::
502µsData::Dumper::
432µsbase::
431µsC4::Branch::
408µsMemoize::Memcached::
387µsPOSIX::
310µsUNIVERSAL::
301µsDBD::_::st::
292µsoverload::
234µswarnings::
210µsText::Abbrev::
209µsCGI::Session::Driver::mysql::
207µsC4::Koha::
204µsC4::Overdues::
182µsCGI::Session::ErrorHandler::
178µsCGI::Session::Driver::DBI::
129µsC4::Items::
102µsconstant::
90µsCGI::Session::Serialize::yaml::
87µsAutoLoader::
66µsCGI::Session::Driver::
61µsURI::Split::
54µsC4::Boolean::
48µsDBI::dr::
35µsInternals::
33µsDBD::_::common::
31µsmro::
0sDBD::mysql::
0sYAML::
Report produced by the NYTProf 2.10 Perl profiler, developed by Tim Bunce and Adam Kaplan.