Performance Profile Index
For /home/chris/git/koha.git/cataloguing/addbiblio.pl
  Run on Tue Aug 25 11:37:23 2009
Reported on Tue Aug 25 11:37:54 2009

Profile of /home/chris/git/koha.git/cataloguing/addbiblio.pl for 2.12s, executing 165029 statements and 20822 subroutine calls in 58 source files and 26 string evals.
Top 15 Subroutines — ordered by exclusive time
Calls P F Exclusive
Time
Inclusive
Time
Subroutine
356666210ms210msDBI::common::::FETCH DBI::common::FETCH(xsub)
356555197ms569msDBI::st::::fetchrow_hashref DBI::st::fetchrow_hashref(xsub)
356555162ms162msDBI::st::::fetch DBI::st::fetch(xsub)
111138ms314msmain::::build_tabs main::build_tabs
40583151.8ms51.8msmain::::CreateKey main::CreateKey
61238.8ms39.0msStorable::::mretrieve Storable::mretrieve(xsub)
11238.3ms38.5msDBI::db::::do DBI::db::do(xsub)
4741136.5ms135msmain::::create_input main::create_input
6163330.4ms30.6msDBI::st::::fetchrow DBI::st::fetchrow(xsub)
11127.6ms30.9msC4::Output::::output_with_http_headers C4::Output::output_with_http_headers
5472324.3ms24.4msDBI::db::::ping DBI::db::ping(xsub)
11222.4ms23.9msHTML::Template::Pro::::exec_tmpl_stringHTML::Template::Pro::exec_tmpl_string(xsub)
361116.2ms73.4msCache::Memcached::::_load_multi Cache::Memcached::_load_multi
9563213.7ms13.7msC4::Context::::userenv C4::Context::userenv
11110.4ms578msDBD::_::st::::fetchall_arrayref DBD::_::st::fetchall_arrayref
Source Code Files — ordered by exclusive time then name
StmtsExclusive
Time
Avg.ReportsSource File
462581ms1.26msline • block • subDBI.pm
140785255ms2µsline • block • sub/home/chris/git/koha.git/cataloguing/addbiblio.pl
591775.6ms13µsline • block • sub/home/chris/git/koha.git/C4/Context.pm
5342.0ms792µsline • block • sub/home/chris/git/koha.git/cataloguing/../../lib/Storable.pm (autosplit into ../../lib/auto/Storable/thaw.al)
2639.1ms1.50msline • block • subCGI/Session/Driver/mysql.pm
13230.1ms228µsline • block • sub/home/chris/git/koha.git/C4/Output.pm
393124.4ms6µsline • block • subCache/Memcached.pm
87023.7ms27µsline • block • subHTML/Template/Pro.pm
74917.4ms23µsline • block • subCGI.pm (executed 12 string evals)
422716.7ms4µsline • block • subCGI/Carp.pm
12238.30ms7µsline • block • subCache/Memcached/GetParser.pm
2216.55ms30µsline • block • subMemoize.pm (executed 3 string evals)
2295.14ms22µsline • block • sub/home/chris/git/koha.git/C4/Auth.pm
4423.79ms9µsline • block • subCGI/Cookie.pm
19113.41ms2µsline • block • subFile/Spec/Unix.pm
1633.03ms19µsline • block • subYAML/Base.pm (executed 4 string evals)
252.88ms115µsline • block • sub/home/chris/git/koha.git/C4/Biblio.pm
2242.85ms13µsline • block • subCGI/Session.pm (executed 3 string evals)
2842.57ms9µsline • block • subDBD/mysql.pm
422.06ms49µsline • block • subCGI/Session/Driver/DBI.pm
2521.79ms7µsline • block • subMemoize/Memcached.pm
211.78ms85µsline • block • subYAML/Node.pm
391.70ms44µsline • block • subYAML.pm
7841.22ms2µsline • block • subCGI/Util.pm
3811.18ms3µsline • block • subExporter.pm
28962µs34µsline • block • sub/home/chris/git/koha.git/cataloguing/value_builder/marc21_field_008.pl
24897µs37µsline • block • sub/home/chris/git/koha.git/cataloguing/value_builder/marc21_field_007.pl
21817µs39µsline • block • subCGI/Session/Serialize/yaml.pm (executed 2 string evals)
283724µs3µsline • block • subExporter/Heavy.pm
24701µs29µsline • block • sub/home/chris/git/koha.git/cataloguing/value_builder/marc21_field_006.pl
24634µs26µsline • block • sub/home/chris/git/koha.git/cataloguing/value_builder/marc21_leader.pl
6622µs104µsline • block • sub/home/chris/git/koha.git/C4/Koha.pm
20598µs30µsline • block • subCGI/Session/Driver.pm
151577µs4µsline • block • sub/home/chris/git/koha.git/C4/Languages.pm
7573µs82µsline • block • sub/home/chris/git/koha.git/C4/ClassSource.pm
4465µs116µsline • block • subYAML/Syck.pm
83410µs5µsline • block • subbase.pm (executed 1 string eval)
43384µs9µsline • block • subData/Dumper.pm
20368µs18µsline • block • sub/home/chris/git/koha.git/cataloguing/value_builder/marc21_field_005.pl
12308µs26µsline • block • sub/home/chris/git/koha.git/cataloguing/value_builder/marc21_field_003.pl
12232µs19µsline • block • subCGI/Session/ID/md5.pm
9230µs26µsline • block • subYAML/Tag.pm
29192µs7µsline • block • subAutoLoader.pm
6177µs30µsline • block • sub/home/chris/git/koha.git/kohaversion.pl
69135µs2µsline • block • subText/Abbrev.pm
49121µs2µsline • block • substrict.pm
32115µs4µsline • block • suboverload.pm
71112µs2µsline • block • subwarnings.pm
2387µs4µsline • block • subconstant.pm
721µs3µsline • block • sub/home/chris/git/koha.git/C4/Members.pm
816µs2µsline • block • subCGI/Session/ErrorHandler.pm
512µs2µsline • block • subUNIVERSAL.pm
812µs1µsline • block • sub/home/chris/git/koha.git/C4/Boolean.pm
1500ns500nsline • block • sub/home/chris/git/koha.git/C4/AuthoritiesMarc.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 • subStorable.pm (executed 1 string eval)
00s0sline • block • subDate/Calc.pm
1644741.16sTotal (26 string evals account for a further 555 statements)
283520.1msAverage
724µs13µsMedian
0.000711.1e-5Deviation

Package treemap
Packages - subroutine times rolled up to level 1 package name
Exclusive
Time
Package Name Prefix
677msDBI:: (includes 5 packages)
228msmain::
69.8msC4:: (includes 9 packages)
42.1msStorable::
38.0msCGI:: (includes 10 packages)
33.0msCache:: (includes 2 packages)
24.3msHTML::
11.5msDBD:: (includes 3 packages)
8.25msDate::
8.25msMemoize:: (includes 2 packages)
5.98msFile::
2.28msExporter::
1.58msYAML:: (includes 2 packages)
501µsData::
431µsbase::
402µsstrict::
317µsUNIVERSAL::
238µswarnings::
182µsoverload::
100µsconstant::
92µsAutoLoader::
72µsText::
34µsInternals::
32µsmro::
Packages - subroutine times rolled up to level 2 package name
Exclusive
Time
Package Name Prefix
394msDBI::st::
228msmain::
210msDBI::common::
68.7msDBI::db::
42.1msStorable::
34.2msC4::Context::
33.0msCache::Memcached:: (includes 2 packages)
32.2msC4::Output::
24.3msHTML::Template::
13.1msCGI::Carp::
11.6msCGI::
10.4msDBD::_:: (includes 2 packages)
10.2msCGI::Session:: (includes 6 packages)
8.25msDate::Calc::
6.29msMemoize::
5.98msFile::Spec::
3.89msDBI::
2.28msExporter::
1.96msMemoize::Memcached::
1.68msCGI::Util::
1.47msCGI::Cookie::
1.24msC4::Biblio::
1.15msDBD::mysql::
1.14msC4::Auth::
1.03msYAML::Base::
644µsC4::Languages::
549µsYAML::Syck::
501µsData::Dumper::
431µsbase::
402µsstrict::
317µsUNIVERSAL::
238µswarnings::
182µsoverload::
118µsC4::Koha::
111µsC4::ClassSource::
100µsconstant::
92µsAutoLoader::
72µsText::Abbrev::
71µsC4::Boolean::
66µsC4::Members::
47µsDBI::dr::
34µsInternals::
32µsmro::
0sYAML::
Packages - subroutine times rolled up to level 3 package name
Exclusive
Time
Package Name Prefix
394msDBI::st::
228msmain::
210msDBI::common::
68.7msDBI::db::
42.1msStorable::
34.2msC4::Context::
32.2msC4::Output::
24.3msHTML::Template::Pro::
24.1msCache::Memcached::
13.1msCGI::Carp::
11.6msCGI::
10.4msDBD::_::st::
9.85msCGI::Session::
8.87msCache::Memcached::GetParser::
8.25msDate::Calc::
6.29msMemoize::
5.98msFile::Spec::Unix::
3.89msDBI::
2.28msExporter::
1.96msMemoize::Memcached::
1.68msCGI::Util::
1.47msCGI::Cookie::
1.24msC4::Biblio::
1.15msDBD::mysql::st::
1.14msC4::Auth::
1.03msYAML::Base::
644µsC4::Languages::
549µsYAML::Syck::
501µsData::Dumper::
431µsbase::
402µsstrict::
317µsUNIVERSAL::
243µsCGI::Session::Driver:: (includes 3 packages)
238µswarnings::
182µsoverload::
118µsC4::Koha::
111µsC4::ClassSource::
100µsconstant::
92µsAutoLoader::
80µsCGI::Session::ErrorHandler::
72µsText::Abbrev::
71µsC4::Boolean::
66µsC4::Members::
53µsCGI::Session::Serialize::
47µsDBI::dr::
39µsDBD::_::common::
34µsInternals::
32µsmro::
0sDBD::mysql::
0sYAML::
Packages - subroutine times rolled up to level 4 package name
Exclusive
Time
Package Name Prefix
394msDBI::st::
228msmain::
210msDBI::common::
68.7msDBI::db::
42.1msStorable::
34.2msC4::Context::
32.2msC4::Output::
24.3msHTML::Template::Pro::
24.1msCache::Memcached::
13.1msCGI::Carp::
11.6msCGI::
10.4msDBD::_::st::
9.85msCGI::Session::
8.87msCache::Memcached::GetParser::
8.25msDate::Calc::
6.29msMemoize::
5.98msFile::Spec::Unix::
3.89msDBI::
2.28msExporter::
1.96msMemoize::Memcached::
1.68msCGI::Util::
1.47msCGI::Cookie::
1.24msC4::Biblio::
1.15msDBD::mysql::st::
1.14msC4::Auth::
1.03msYAML::Base::
644µsC4::Languages::
549µsYAML::Syck::
501µsData::Dumper::
431µsbase::
402µsstrict::
317µsUNIVERSAL::
238µswarnings::
182µsoverload::
118µsC4::Koha::
112µsCGI::Session::Driver::mysql::
111µsC4::ClassSource::
100µsconstant::
94µsCGI::Session::Driver::DBI::
92µsAutoLoader::
80µsCGI::Session::ErrorHandler::
72µsText::Abbrev::
71µsC4::Boolean::
66µsC4::Members::
53µsCGI::Session::Serialize::yaml::
47µsDBI::dr::
39µsDBD::_::common::
36µsCGI::Session::Driver::
34µsInternals::
32µsmro::
0sDBD::mysql::
0sYAML::