Performance Profile Index
For starman worker -M FindBin --max-requests 50 --workers 2 --user=kohadev-koha --group kohadev-koha --pid /var/run/koha/kohadev/plack.pid --daemonize --access-log /var/log/koha/kohadev/plack.log --error-log /var/log/koha/kohadev/plack-error.log -E deployment --socket /var/run/koha/kohadev/plack.sock /etc/koha/sites/kohadev/plack.psgi
  Run on Fri Jan 8 14:08:18 2016
Reported on Fri Jan 8 14:08:34 2016

Profile of starman worker -M FindBin --max-requests 50 --workers 2 --user=kohadev-koha --group kohadev-koha --pid /var/run/koha/kohadev/plack.pid --daemonize --access-log /var/log/koha/kohadev/plack.log --error-log /var/log/koha/kohadev/plack-error.log -E deployment --socket /var/run/koha/kohadev/plack.sock /etc/koha/sites/kohadev/plack.psgi for 5.91s (of 6.90s), executing 1989470 statements and 651797 subroutine calls in 284 source files and 28 string evals.
SVG not supported

The Flame Graph above is a visualization of the time spent in distinct call stacks. The colors and x-axis position are not meaningful.

Top 15 Subroutines
Calls P F Exclusive
Time
Inclusive
Time
Subroutine
1300011482ms3.13sDBIx::Class::ResultSet::::_construct_results DBIx::Class::ResultSet::_construct_results
1400021390ms461msDBIx::Class::ResultSet::::_resolved_attrs DBIx::Class::ResultSet::_resolved_attrs
92711374ms437msClass::Accessor::Grouped::::__ANON__[Class/Accessor/Grouped.pm:774] Class::Accessor::Grouped::__ANON__[Class/Accessor/Grouped.pm:774]
1200011362ms362msKoha::Object::::AUTOLOAD Koha::Object::AUTOLOAD
1300011267ms3.42sKoha::Objects::::next Koha::Objects::next
254586264ms1.30sClass::C3::Componentised::::ensure_class_loaded Class::C3::Componentised::ensure_class_loaded (recurses: max depth 3, inclusive time 116ms)
2200031206ms425msDBIx::Class::SQLMaker::::_quote DBIx::Class::SQLMaker::_quote
2100021194ms576msDBIx::Class::SQLMaker::::_recurse_fields DBIx::Class::SQLMaker::_recurse_fields (recurses: max depth 1, inclusive time 469ms)
1300011176ms1.95sDBIx::Class::Storage::DBI::Cursor::::nextDBIx::Class::Storage::DBI::Cursor::next
2100022141ms439msDBD::mysql::st::::__ANON__[DBD/mysql.pm:810] DBD::mysql::st::__ANON__[DBD/mysql.pm:810]
100011110ms268msDBD::_::st::::bind_columns DBD::_::st::bind_columns
100011102ms102msDBI::st::::execute DBI::st::execute (xsub)
220001199.2ms163msSQL::Abstract::::_assert_pass_injection_guard SQL::Abstract::_assert_pass_injection_guard
104372287.6ms124msClass::Accessor::Grouped::::get_inherited Class::Accessor::Grouped::get_inherited
35289682.8ms435msTry::Tiny::::try Try::Tiny::try

You can view a treemap of subroutine exclusive time, grouped by package.
NYTProf also generates call-graph files in Graphviz format: inter-package calls, all inter-subroutine calls (probably too complex to render easily).

You can hover over some table cells and headings to view extra information.
Some table column headings can be clicked on to sort the table by that column.
Source Code Files — ordered by exclusive time then name
StmtsExclusive
Time
ReportsSource File
7110331.17slineDBIx/Class/ResultSet.pm
137951903mslineClass/Accessor/Grouped.pm (including 1 string eval)
199022462mslineDBIx/Class/SQLMaker.pm
81285372mslineDBIx/Class/Storage/DBI.pm
200018366mslineDBIx/Class/Storage/DBI/Cursor.pm
166044363mslineSQL/Abstract.pm
2298mslineKoha/Object.pm
63134257mslineDBD/mysql.pm
3228mslineKoha/Objects.pm
9663168mslineClass/C3/Componentised.pm
2018162mslineplack.pl
86370142mslineDBIx/Class/ResultSource.pm
126516123mslineDBIx/Class/Row.pm
2506490.1mslineDBIx/Class/Storage/BlockRunner.pm
1715670.5mslineDBIx/Class/Schema.pm
1794639.4mslineDBIx/Class/AccessorGroup.pm
1201638.8mslineDBIx/Class/Storage/DBI/mysql.pm
521338.5mslineDBIx/Class/ResultSourceProxy.pm
389938.4mslineModule/Find.pm
236.8mslineTry/Tiny.pm
632.5mslineDBI.pm (including 1 string eval)
68813131mslineSub/Quote.pm (including 16 string evals)
904929.9mslineHash/Merge.pm
240518.7mslineDBIx/Class/Relationship/Accessor.pm
1002117.9mslineContext/Preserve.pm
158117.0mslineDBIx/Class/ResultSourceProxy/Table.pm
2112.1mslineDBIx/Class/Storage/DBIHacks.pm
334011.8mslineMoo/_Utils.pm
311.5mslineKoha/Database.pm
1027010.3mslineDBIx/Class/_Util.pm
23659.31mslineDBIx/Class/Relationship/BelongsTo.pm
45168.22mslineSub/Defer.pm (including 1 string eval)
6347.59mslineMethod/Generate/Accessor.pm
27.24mslineFile/Find.pm
426.18mslineTemplate/Provider.pm
7696.01mslineDBIx/Class.pm
10105.08mslineDBIx/Class/ResultSource/Table.pm
124.69mslineKoha/Schema/Result/SpecialHoliday.pm
11093.78mslineDBIx/Class/InflateColumn.pm
21213.55mslineClass/XSAccessor.pm
93.55mslineDBIx/Class/SQLMaker/LimitDialects.pm
363.47mslineDBIx/Class/Storage.pm
153.40mslineDBI/Const/GetInfoType.pm
9693.30mslineDBIx/Class/Relationship/ProxyMethods.pm
3083.28mslineDBIx/Class/Relationship/ManyToMany.pm
873.27mslineTemplate/Constants.pm
572.97mslineB.pm
152.84mslineDBIx/Class/ResultSource/RowParser.pm
232.83mslineC4/Templates.pm
2652.77mslineMoo.pm (including 1 string eval)
5862.70mslineDBIx/Class/Relationship/HasMany.pm
12.54mslineApache/LogFormat/Compiler.pm
422.32mslineConfig_heavy.pl
352.29mslineDBIx/Class/Optional/Dependencies.pm
542.26mslineKoha/Schema/Result/Borrower.pm
3492.25mslineMethod/Generate/Constructor.pm
292.02mslineTemplate.pm
3342.00mslineDBIx/Class/Relationship/Base.pm
151.92mslineDBIx/Class/ResultSetColumn.pm
191.89mslineC4/Output.pm
151.86mslineDBIx/Class/ResultSource/RowParser/Util.pm
161.75mslineKoha/Schema/Result/Subscription.pm
231.63mslineTemplate/Config.pm
161.62mslineTemplate/Document.pm
1471.57mslineDBIx/Class/Carp.pm
171.55mslineDBIx/Class/Storage/TxnScopeGuard.pm
1991.55mslineDBIx/Class/Relationship/HasOne.pm
291.54mslineMRO/Compat.pm
201.54mslineTemplate/Service.pm
1551.49mslineDBIx/Class/Componentised.pm
291.45mslineKoha/Schema/Result/Item.pm
1241.32mslinestrictures.pm
341.27mslineKoha/Schema/Result/Branch.pm
121.23mslineKoha/Schema/Result/Systempreference.pm
141.22mslineKoha/Schema/Result/Permission.pm
131.22mslineKoha/Schema/Result/Aqcontact.pm
131.17mslineKoha/Schema/Result/BorrowerSync.pm
141.17mslineKoha/Schema/Result/AqorderUser.pm
131.13mslineKoha/Schema/Result/BorrowerDebarment.pm
221.10mslineKoha/Schema/Result/Aqorder.pm
121.09mslineKoha/Schema/Result/BorrowerModification.pm
111.07mslineKoha/Schema/Result/Deletedborrower.pm
11.05mslinebase.pm
161.03mslineTemplate/Base.pm
14997µslineKoha/Schema/Result/Accountline.pm
13979µslineKoha/Schema/Result/Suggestion.pm
15956µslineDBIx/Class/ResultSourceHandle.pm
28913µslineMoo/Object.pm
15910µslineKoha/Schema/Result/Virtualshelve.pm
34907µslineDBD/mysql/GetInfo.pm
19886µslineKoha/Schema/Result/Aqbookseller.pm
18840µslineKoha/Schema/Result/Issue.pm
14837µslineTemplate/Exception.pm
10828µslineDBIx/Class/SQLMaker/MySQL.pm
23807µslineKoha/Schema/Result/Biblio.pm
14793µslineKoha/Schema/Result/AuthorisedValuesBranch.pm
18782µslineKoha/Schema/Result/Reserve.pm
15776µslineKoha/Schema/Result/Biblioitem.pm
13771µslineKoha/Schema/Result/Serial.pm
17769µslineKoha/Schema/Result/Category.pm
14767µslineKoha/Schema/Result/AdditionalField.pm
18750µslineKoha/Schema/Result/Aqbudget.pm
12741µslineKoha/Schema/Result/ActionLog.pm
18739µslineMoo/HandleMoose/_TypeMap.pm
17737µslineKoha/Schema/Result/ImportRecord.pm
13720µslineKoha/Schema/Result/ImportBatch.pm
13710µslineKoha/Schema/Result/ImportItem.pm
12701µslineKoha/Schema/Result/CreatorLayout.pm
12699µslineKoha/Schema/Result/Deleteditem.pm
15699µslineKoha/Schema/Result/OldReserve.pm
13696µslineKoha/Schema/Result/MarcModificationTemplateAction.pm
13695µslineKoha/Schema/Result/Collection.pm
36692µslineImport/Into.pm
12690µslineKoha/Schema/Result/Deletedbiblioitem.pm
14689µslineKoha/Schema/Result/Rating.pm
12678µslineKoha/Schema/Result/Fieldmapping.pm
14668µslineKoha/Schema/Result/Itemtype.pm
14665µslineKoha/Schema/Result/TagAll.pm
16655µslineKoha/Schema/Result/HoldFillTarget.pm
10654µslineDBIx/Class/Relationship/CascadeActions.pm
171.10mslineCGI/Compile.pm (including 1 string eval)
15646µslineKoha/Schema/Result/Course.pm
12646µslineKoha/Schema/Result/Issuingrule.pm
15642µslineKoha/Schema/Result/CourseReserve.pm
14642µslineKoha/Schema/Result/OldIssue.pm
14632µslineKoha/Schema/Result/OpacNews.pm
14630µslineKoha/Schema/Result/MessageQueue.pm
7624µslineDBIx/Class/PK.pm
16624µslineKoha/Schema/Result/CourseItem.pm
13620µslineKoha/Schema/Result/CategoriesBranch.pm
15618µslineKoha/Schema/Result/MarcMatcher.pm
13602µslineKoha/Schema/Result/ItemsSearchField.pm
13601µslineKoha/Schema/Result/AuthSubfieldStructure.pm
13600µslineKoha/Schema/Result/SubscriptionNumberpattern.pm
15589µslineKoha/Schema/Result/Virtualshelfcontent.pm
12588µslineKoha/Schema/Result/CreatorTemplate.pm
14585µslineKoha/Schema/Result/Aqbasketgroup.pm
14578µslineKoha/Schema/Result/AuthorisedValue.pm
12578µslineKoha/Schema/Result/MarcSubfieldStructure.pm
14578µslineKoha/Schema/Result/Overduerule.pm
14578µslineKoha/Schema/Result/CourseInstructor.pm
12575µslineKoha/Schema/Result/ExportFormat.pm
13569µslineKoha/Schema/Result/PrintersProfile.pm
17569µslineKoha/Schema/Result/Matchpoint.pm
131568µslineDBI/Const/GetInfo/ODBC.pm
14567µslineKoha/Schema/Result/Letter.pm
15562µslineKoha/Schema/Result/Matchcheck.pm
14561µslineKoha/Schema/Result/BorrowerAttributeType.pm
14560µslineKoha/Schema/Result/MatchpointComponent.pm
14555µslineKoha/Schema/Result/AuthType.pm
18553µslineKoha/Schema/Result/MessageTransportType.pm
13551µslineKoha/Schema/Result/AuthTagStructure.pm
12541µslineKoha/Schema/Result/Z3950server.pm
12539µslineKoha/Schema/Result/UploadedFile.pm
14538µslineKoha/Schema/Result/Currency.pm
1871.02mslineDevel/GlobalDestruction.pm (including 1 string eval)
12535µslineKoha/Schema/Result/Alert.pm
16533µslineKoha/Schema/Result/OaiSet.pm
15530µslineKoha/Schema/Result/ItemsLastBorrower.pm
13529µslineKoha/Schema/Result/Discharge.pm
15528µslineKoha/Schema/Result/AqordersTransfer.pm
12528µslineKoha/Schema/Result/Message.pm
14526µslineKoha/Schema/Result/BorrowerMessageTransportPreference.pm
13526µslineKoha/Schema/Result/Localization.pm
13524µslineKoha/Schema/Result/Biblioimage.pm
12522µslineKoha/Schema/Result/SearchHistory.pm
14522µslineKoha/Schema/Result/Branchcategory.pm
13521µslineKoha/Schema/Result/DefaultBranchItemRule.pm
14518µslineKoha/Schema/Result/Branchtransfer.pm
12517µslineKoha/Schema/Result/Zebraqueue.pm
14517µslineKoha/Schema/Result/Review.pm
14514µslineKoha/Schema/Result/TagsApproval.pm
13508µslineKoha/Schema/Result/BorrowerAttributeTypesBranch.pm
13507µslineKoha/Schema/Result/BorrowerFile.pm
14507µslineKoha/Schema/Result/Aqbasketuser.pm
12500µslineKoha/Schema/Result/OaiSetsMapping.pm
12500µslineKoha/Schema/Result/MiscFile.pm
15499µslineKoha/Schema/Result/Subscriptionroutinglist.pm
12499µslineKoha/Schema/Result/Deletedbiblio.pm
19495µslineKoha/Schema/Result/Aqbasket.pm
11495µslineKoha/Schema/Result/LanguageScriptBidi.pm
12494µslineKoha/Schema/Result/NeedMergeAuthority.pm
15494µslineKoha/Schema/Result/MessageAttribute.pm
11493µslineKoha/Schema/Result/Statistic.pm
13491µslineKoha/Schema/Result/UserPermission.pm
13490µslineKoha/Schema/Result/ClassSortRule.pm
15488µslineKoha/Schema/Result/Aqinvoice.pm
12485µslineKoha/Schema/Result/SavedSql.pm
11481µslineKoha/Schema/Result/TmpHoldsqueue.pm
13481µslineKoha/Schema/Result/BorrowerAttribute.pm
14480µslineKoha/Schema/Result/PatronList.pm
14478µslineKoha/Schema/Result/OverduerulesTransportType.pm
12478µslineKoha/Schema/Result/ColumnsSetting.pm
12478µslineKoha/Schema/Result/ImportRecordMatch.pm
13477µslineKoha/Schema/Result/DefaultBorrowerCircRule.pm
13475µslineKoha/Schema/Result/AqbudgetsPlanning.pm
12475µslineKoha/Schema/Result/MatchpointComponentNorm.pm
13474µslineKoha/Schema/Result/ClassSource.pm
13473µslineKoha/Schema/Result/OaiSetsBiblio.pm
12473µslineKoha/Schema/Result/AudioAlert.pm
14472µslineKoha/Schema/Result/BranchItemRule.pm
14471µslineKoha/Schema/Result/TagsIndex.pm
12470µslineKoha/Schema/Result/RepeatableHoliday.pm
14468µslineKoha/Schema/Result/Serialitem.pm
14465µslineKoha/Schema/Result/PatronListPatron.pm
12463µslineKoha/Schema/Result/Aqbudgetperiod.pm
14463µslineKoha/Schema/Result/TransportCost.pm
13460µslineKoha/Schema/Result/MatcherMatchpoint.pm
12457µslineKoha/Schema/Result/ItemCirculationAlertPreference.pm
13457µslineKoha/Schema/Result/AqordersItem.pm
12457µslineDBIx/Class/Exception.pm
12452µslineKoha/Schema/Result/Quote.pm
14449µslineKoha/Schema/Result/BranchBorrowerCircRule.pm
12449µslineKoha/Schema/Result/DefaultCircRule.pm
10447µslineKoha/Schema.pm
12446µslineKoha/Schema/Result/CollectionsTracking.pm
13444µslineKoha/Schema/Result/CreatorImage.pm
12443µslineKoha/Schema/Result/AuthHeader.pm
12443µslineKoha/Schema/Result/ServicesThrottle.pm
13442µslineKoha/Schema/Result/Userflag.pm
10440µslineKoha/Schema/Result/ActionLogs.pm
12436µslineKoha/Schema/Result/Accountoffset.pm
12435µslineKoha/Schema/Result/City.pm
13435µslineKoha/Schema/Result/SubscriptionFrequency.pm
14435µslineKoha/Schema/Result/Aqbudgetborrower.pm
13435µslineKoha/Schema/Result/DefaultBranchCircRule.pm
12434µslineKoha/Schema/Result/Subscriptionhistory.pm
12432µslineKoha/Schema/Result/LanguageDescription.pm
17432µslineKoha/Schema/Result/BorrowerMessagePreference.pm
12430µslineKoha/Schema/Result/SocialData.pm
12426µslineKoha/Schema/Result/ImportBiblio.pm
12424µslineKoha/Schema/Result/MarcTagStructure.pm
15423µslineKoha/Schema/Result/MessageTransport.pm
12420µslineKoha/Schema/Result/ReportsDictionary.pm
14419µslineKoha/Schema/Result/AdditionalFieldValue.pm
12416µslineKoha/Schema/Result/Session.pm
15413µslineClass/XSAccessor/Heavy.pm
13408µslineKoha/Schema/Result/Patronimage.pm
12407µslineKoha/Schema/Result/BiblioFramework.pm
14399µslineKoha/Schema/Result/Aqcontract.pm
12399µslineKoha/Schema/Result/LanguageSubtagRegistry.pm
12398µslineKoha/Schema/Result/Printer.pm
12397µslineKoha/Schema/Result/Tag.pm
11392µslineKoha/Schema/Result/Browser.pm
11392µslineKoha/Schema/Result/Notify.pm
13386µslineKoha/Schema/Result/MarcModificationTemplate.pm
12384µslineKoha/Schema/Result/Linktracker.pm
12382µslineKoha/Schema/Result/LanguageRfc4646ToIso639.pm
12379µslineKoha/Schema/Result/OaiSetsDescription.pm
14377µslineKoha/Schema/Result/Virtualshelfshare.pm
12370µslineKoha/Schema/Result/SavedReport.pm
12350µslineKoha/Schema/Result/PluginData.pm
12335µslineKoha/Schema/Result/ImportAuth.pm
11330µslineKoha/Schema/Result/Stopword.pm
7327µslineDBIx/Class/Cursor.pm
14317µslineKoha/Schema/Result/Branchrelation.pm
15305µslineKoha/Schema/Result/CreatorBatch.pm
11302µslineKoha/Schema/Result/LanguageScriptMapping.pm
12288µslineKoha/Schema/Result/BranchTransferLimit.pm
851.53mslineCGI.pm (including 5 string evals)
12270µslineKoha/Schema/Result/PendingOfflineOperation.pm
8181µslineMoo/sification.pm
7170µslineDBIx/Class/PK/Auto.pm
8168µslineDBIx/Class/Core.pm
8163µslineDBIx/Class/Relationship.pm
8144µslineDBIx/Class/Relationship/Helpers.pm
2106µslineConfig.pm
1576µslineDBI/Const/GetInfo/ANSI.pm
572µslineDBIx/Class/StartupCheck.pm
552µslineMoo/_mro.pm
114µslineModule/Runtime.pm
13µslineConfig_git.pl
00sline(eval 161)[Text/MicroTemplate.pm:389]
00slineText/MicroTemplate.pm
00sline(eval 162)[Apache/LogFormat/Compiler.pm:151]
00slineIO/Socket.pm
00slinePlack/App/URLMap.pm
00slinenamespace/clean.pm
00slineB/Hooks/EndOfScope/XS.pm
00slineFile/Spec/Unix.pm
00slineXML/Parser/Expat.pm
00slineXML/Parser.pm
00slineCGI/Emulate/PSGI.pm
1137µsline/unknown-eval-invoker (including 1 string eval)
19895165.91sTotal (-46 statements are unaccounted for)
700520.8msAverage
588µsMedian
0.00018Deviation