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

Profile of /home/chris/git/koha.git/circ/circulation.pl for 1.01s, executing 39456 statements and 5524 subroutine calls in 58 source files and 29 string evals.
Top 15 Subroutines — ordered by exclusive time
Calls P F Exclusive
Time		 Inclusive
Time		 Subroutine
21259.2ms59.4msDBI::db::::do DBI::db::do(xsub)
101381117.3ms17.5msDBI::st::::execute DBI::st::execute(xsub)
1201116.6ms42.3msCache::Memcached::::_load_multi Cache::Memcached::_load_multi
121118.74ms12.3msCGI::Carp::::stamp CGI::Carp::stamp
2118.68ms17.8msCGI::Session::::_load_pluggables CGI::Session::_load_pluggables
120117.34ms7.34msCache::Memcached::::__ANON__[Cache/Memcached.pm:721] Cache::Memcached::__ANON__[Cache/Memcached.pm:721]
70117.27ms8.48msCache::Memcached::::_write_and_read Cache::Memcached::_write_and_read
137237.13ms7.28msDBI::db::::ping DBI::db::ping(xsub)
6117.09ms7.26msCGI::::_compile CGI::_compile
243216.60ms6.60msFile::Spec::Unix::::splitpath File::Spec::Unix::splitpath
64125.30ms12.3msDBI::db::::selectrow_array DBI::db::selectrow_array(xsub)
12620115.28ms5.43msDBI::common::::FETCH DBI::common::FETCH(xsub)
120115.17ms8.39msCache::Memcached::GetParser::::parse_bufferCache::Memcached::GetParser::parse_buffer
162125.15ms5.30msDBI::::_new_handle DBI::_new_handle(xsub)
162114.98ms10.4msDBI::::_new_sth DBI::_new_sth
See all 1037 subroutines
Source Code Files — ordered by exclusive time then name
StmtsExclusive
Time		 Avg.ReportsSource File
4160.3ms1.47msline • block • subCGI/Session/Driver/mysql.pm
1718552.1ms3µsline • block • subCache/Memcached.pm
448120.1ms4µsline • block • subCGI/Carp.pm
94118.2ms19µsline • block • sub/home/chris/git/koha.git/C4/Context.pm
59814.7ms24µsline • block • subCGI.pm (executed 7 string evals)
30312.9ms43µsline • block • sub/home/chris/git/koha.git/C4/Reserves.pm
108610.2ms9µsline • block • subDBI.pm
16109.31ms6µsline • block • subMemoize/Memcached.pm
6489.30ms14µsline • block • subDBD/mysql.pm
26198.46ms3µsline • block • subCache/Memcached/GetParser.pm
3387.99ms24µsline • block • sub/home/chris/git/koha.git/C4/Members.pm
13897.83ms6µsline • block • subMemoize.pm (executed 3 string evals)
2356.37ms27µsline • block • sub/home/chris/git/koha.git/C4/Auth.pm
1685.69ms34µsline • block • sub/home/chris/git/koha.git/C4/Circulation.pm
11165.32ms5µsline • block • subHTML/Template/Pro.pm
3624.47ms12µsline • block • sub/home/chris/git/koha.git/C4/Dates.pm (executed 6 string evals)
4664.36ms9µsline • block • subCGI/Cookie.pm
25024.35ms2µsline • block • subFile/Spec/Unix.pm
4013.97ms10µsline • block • subCGI/Session.pm (executed 6 string evals)
2283.53ms15µsline • block • sub/home/chris/git/koha.git/circ/circulation.pl
893.39ms38µsline • block • sub/home/chris/git/koha.git/C4/Biblio.pm
1632.97ms18µsline • block • subYAML/Base.pm (executed 4 string evals)
662.43ms37µsline • block • subCGI/Session/Driver/DBI.pm
4742.26ms5µsline • block • sub/home/chris/git/koha.git/circ/../../lib/Storable.pm (autosplit into ../../lib/auto/Storable/_freeze.al)
211.82ms87µsline • block • subYAML/Node.pm
91.73ms192µsline • block • sub/home/chris/git/koha.git/C4/Overdues.pm
391.66ms43µsline • block • subYAML.pm
531.35ms25µsline • block • sub/home/chris/git/koha.git/C4/Branch.pm
711.31ms18µsline • block • sub/home/chris/git/koha.git/circ/../../lib/Storable.pm (autosplit into ../../lib/auto/Storable/thaw.al)
741.05ms14µsline • block • subAutoLoader.pm
25886µs35µsline • block • subCGI/Session/Serialize/yaml.pm (executed 2 string evals)
132867µs7µsline • block • sub/home/chris/git/koha.git/C4/Output.pm
7766µs109µsline • block • subYAML/Syck.pm
430654µs2µsline • block • subCGI/Util.pm
28626µs22µsline • block • subCGI/Session/Driver.pm
151594µs4µsline • block • sub/home/chris/git/koha.git/C4/Languages.pm
23578µs25µsline • block • sub/home/chris/git/koha.git/C4/Koha.pm
44567µs13µsline • block • sub/home/chris/git/koha.git/circ/../../lib/Storable.pm (autosplit into ../../lib/auto/Storable/nfreeze.al)
83420µs5µsline • block • subbase.pm (executed 1 string eval)
43408µs9µsline • block • subData/Dumper.pm
152408µs3µsline • block • subExporter.pm
5244µs49µsline • block • sub/home/chris/git/koha.git/kohaversion.pl
9238µs26µsline • block • subYAML/Tag.pm
12232µs19µsline • block • subCGI/Session/ID/md5.pm
132201µs2µsline • block • subText/Abbrev.pm
32115µs4µsline • block • suboverload.pm
71114µs2µsline • block • subwarnings.pm
3789µs2µsline • block • substrict.pm
2389µs4µsline • block • subconstant.pm
1532µ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
1300ns300nsline • block • sub/home/chris/git/koha.git/C4/Accounts.pm
1300ns300nsline • block • sub/home/chris/git/koha.git/C4/Print.pm
1300ns300nsline • block • sub/home/chris/git/koha.git/C4/Search.pm
00s0sline • block • subPOSIX.pm
00s0sline • block • subDate/Calc.pm
39247297msTotal (29 string evals account for a further 209 statements)
6765.13msAverage
1.31ms9µsMedian
0.001308.0e-6Deviation

Package treemap
Packages - subroutine times rolled up to level 1 package name
Exclusive
Time		 Package Name Prefix
119msDBI:: (includes 5 packages)
62.5msCache:: (includes 2 packages)
39.3msCGI:: (includes 10 packages)
19.6msC4:: (includes 13 packages)
14.9msMemoize:: (includes 2 packages)
11.0msFile::
4.88msDBD:: (includes 3 packages)
4.78msStorable::
3.48msHTML::
1.88msYAML:: (includes 2 packages)
742µsAutoLoader::
557µsExporter::
519µsData::
467µsDate::
438µsbase::
299µsUNIVERSAL::
292µsPOSIX::
272µsstrict::
233µswarnings::
174µsoverload::
146µsText::
103µsconstant::
65µsURI::
35µsInternals::
32µsmro::
Packages - subroutine times rolled up to level 2 package name
Exclusive
Time		 Package Name Prefix
75.7msDBI::db::
62.5msCache::Memcached:: (includes 2 packages)
27.2msDBI::st::
14.9msCGI::Carp::
11.8msCGI::Session:: (includes 6 packages)
11.0msFile::Spec::
10.2msDBI::
9.31msCGI::
9.06msMemoize::Memcached::
7.28msC4::Context::
5.88msMemoize::
5.35msDBI::common::
4.78msStorable::
4.51msDBD::mysql::
3.88msC4::Dates::
3.48msHTML::Template::
2.18msCGI::Cookie::
2.17msC4::Auth::
1.44msC4::Members::
1.35msC4::Reserves::
1.11msCGI::Util::
1.01msYAML::Base::
866µsC4::Output::
865µsYAML::Syck::
742µsAutoLoader::
711µsC4::Circulation::
663µsC4::Languages::
557µsExporter::
521µsC4::Biblio::
519µsData::Dumper::
467µsDate::Calc::
438µsbase::
377µsDBD::_:: (includes 2 packages)
299µsUNIVERSAL::
293µsC4::Branch::
292µsPOSIX::
272µsstrict::
233µswarnings::
228µsC4::Koha::
174µsoverload::
154µsC4::Overdues::
146µsText::Abbrev::
103µsconstant::
65µsURI::Split::
65µsC4::Boolean::
44µsDBI::dr::
35µsInternals::
32µsmro::
0sYAML::
Packages - subroutine times rolled up to level 3 package name
Exclusive
Time		 Package Name Prefix
75.7msDBI::db::
50.8msCache::Memcached::
27.2msDBI::st::
14.9msCGI::Carp::
11.7msCache::Memcached::GetParser::
11.1msCGI::Session::
11.0msFile::Spec::Unix::
10.2msDBI::
9.31msCGI::
9.06msMemoize::Memcached::
7.28msC4::Context::
5.88msMemoize::
5.35msDBI::common::
4.78msStorable::
4.51msDBD::mysql::st::
3.88msC4::Dates::
3.48msHTML::Template::Pro::
2.18msCGI::Cookie::
2.17msC4::Auth::
1.44msC4::Members::
1.35msC4::Reserves::
1.11msCGI::Util::
1.01msYAML::Base::
866µsC4::Output::
865µsYAML::Syck::
742µsAutoLoader::
711µsC4::Circulation::
663µsC4::Languages::
557µsExporter::
521µsC4::Biblio::
519µsData::Dumper::
495µsCGI::Session::Driver:: (includes 3 packages)
467µsDate::Calc::
438µsbase::
344µsDBD::_::st::
299µsUNIVERSAL::
293µsC4::Branch::
292µsPOSIX::
272µsstrict::
233µswarnings::
228µsC4::Koha::
174µsoverload::
154µsC4::Overdues::
146µsText::Abbrev::
114µsCGI::Session::Serialize::
112µsCGI::Session::ErrorHandler::
103µsconstant::
65µsURI::Split::
65µsC4::Boolean::
44µsDBI::dr::
35µsInternals::
33µsDBD::_::common::
32µsmro::
0sDBD::mysql::
0sYAML::
Packages - subroutine times rolled up to level 4 package name
Exclusive
Time		 Package Name Prefix
75.7msDBI::db::
50.8msCache::Memcached::
27.2msDBI::st::
14.9msCGI::Carp::
11.7msCache::Memcached::GetParser::
11.1msCGI::Session::
11.0msFile::Spec::Unix::
10.2msDBI::
9.31msCGI::
9.06msMemoize::Memcached::
7.28msC4::Context::
5.88msMemoize::
5.35msDBI::common::
4.78msStorable::
4.51msDBD::mysql::st::
3.88msC4::Dates::
3.48msHTML::Template::Pro::
2.18msCGI::Cookie::
2.17msC4::Auth::
1.44msC4::Members::
1.35msC4::Reserves::
1.11msCGI::Util::
1.01msYAML::Base::
866µsC4::Output::
865µsYAML::Syck::
742µsAutoLoader::
711µsC4::Circulation::
663µsC4::Languages::
557µsExporter::
521µsC4::Biblio::
519µsData::Dumper::
467µsDate::Calc::
438µsbase::
344µsDBD::_::st::
299µsUNIVERSAL::
293µsC4::Branch::
292µsPOSIX::
272µsstrict::
233µswarnings::
228µsC4::Koha::
206µsCGI::Session::Driver::mysql::
190µsCGI::Session::Driver::DBI::
174µsoverload::
154µsC4::Overdues::
146µsText::Abbrev::
114µsCGI::Session::Serialize::yaml::
112µsCGI::Session::ErrorHandler::
103µsconstant::
99µsCGI::Session::Driver::
65µsURI::Split::
65µsC4::Boolean::
44µsDBI::dr::
35µsInternals::
33µsDBD::_::common::
32µsmro::
0sDBD::mysql::
0sYAML::
Report produced by the NYTProf 2.10 Perl profiler, developed by Tim Bunce and Adam Kaplan.