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:16:49 2016
Reported on Fri Jan 8 14:17:08 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 2.33s (of 2.50s), executing 204616 statements and 82353 subroutine calls in 276 source files and 23 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
54586591ms1.95sClass::C3::Componentised::::ensure_class_loaded Class::C3::Componentised::ensure_class_loaded (recurses: max depth 3, inclusive time 145ms)
92711526ms592msClass::Accessor::Grouped::::__ANON__[Class/Accessor/Grouped.pm:774] Class::Accessor::Grouped::__ANON__[Class/Accessor/Grouped.pm:774]
192011111ms851msClass::Accessor::Grouped::::_mk_group_accessors Class::Accessor::Grouped::_mk_group_accessors
39321162.8ms677msClass::Accessor::Grouped::::__ANON__[Class/Accessor/Grouped.pm:942] Class::Accessor::Grouped::__ANON__[Class/Accessor/Grouped.pm:942]
3482159.9ms89.1msDBIx::Class::Schema::::_register_source DBIx::Class::Schema::_register_source
21021020957.2ms215msbase::::import base::import (recurses: max depth 3, inclusive time 142ms)
17417417449.9ms873msDBIx::Class::ResultSourceProxy::::add_columnsDBIx::Class::ResultSourceProxy::add_columns
53913630.4ms69.1msSub::Quote::::quote_sub Sub::Quote::quote_sub
45638327.7ms27.7msSub::Name::::subname Sub::Name::subname (xsub)
39321125.5ms703msClass::Accessor::Grouped::::make_group_accessor Class::Accessor::Grouped::make_group_accessor
192018923.7ms874msClass::Accessor::Grouped::::mk_group_accessors Class::Accessor::Grouped::mk_group_accessors
34402221.3ms24.1msClass::Accessor::Grouped::::get_inherited Class::Accessor::Grouped::get_inherited
1741121.2ms22.0msDBIx::Class::ResultSource::::add_columns DBIx::Class::ResultSource::add_columns
16021120.3ms792msDBIx::Class::Row::::register_column DBIx::Class::Row::register_column
5201118.8ms19.7msFile::Spec::Unix::::abs2rel File::Spec::Unix::abs2rel
See all 9539 subroutines

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
97763955mslineClass/Accessor/Grouped.pm (including 1 string eval)
3645455mslineClass/C3/Componentised.pm
9164105mslineDBIx/Class/Schema.pm
3837683.8mslineDBIx/Class/ResultSource.pm
521352.5mslineDBIx/Class/ResultSourceProxy.pm
1153555.4mslineSub/Quote.pm (including 11 string evals)
389939.0mslineModule/Find.pm
12332.0mslineDBD/mysql.pm
651631.4mslineDBIx/Class/Row.pm
24531.1mslineDBIx/Class/Storage/DBI.pm
14225.9mslineDBIx/Class/ResultSet.pm
240523.7mslineDBIx/Class/Relationship/Accessor.pm
322.0mslineKoha/Database.pm
333021.0mslineMoo/_Utils.pm
2118.8mslineDBIx/Class/Storage/DBIHacks.pm
194817.7mslineDBIx/Class/AccessorGroup.pm
158117.4mslineDBIx/Class/ResultSourceProxy/Table.pm
6413.5mslineDBIx/Class/Storage/BlockRunner.pm
1111.9mslineKoha/Schema/Result/Stopword.pm
446111.8mslineSub/Defer.pm (including 1 string eval)
1711.8mslineDBIx/Class/Storage/TxnScopeGuard.pm
12411.4mslinestrictures.pm
1310.1mslineKoha/Schema/Result/PrintersProfile.pm
2659.91mslineMoo.pm (including 1 string eval)
259.83mslineSQL/Abstract.pm
23659.44mslineDBIx/Class/Relationship/BelongsTo.pm
6349.42mslineMethod/Generate/Accessor.pm
3088.71mslineDBIx/Class/Relationship/ManyToMany.pm
26.94mslineFile/Find.pm
425.68mslineTemplate/Provider.pm
7695.43mslineDBIx/Class.pm
184.56mslineplack.pl
14.17mslineApache/LogFormat/Compiler.pm
11094.07mslineDBIx/Class/InflateColumn.pm
363.93mslineDBIx/Class/Storage.pm
19173.75mslineClass/XSAccessor.pm
9693.64mslineDBIx/Class/Relationship/ProxyMethods.pm
153.50mslineDBI/Const/GetInfoType.pm
423.28mslineConfig_heavy.pl
2703.24mslineDBIx/Class/_Util.pm
873.18mslineTemplate/Constants.pm
233.11mslineC4/Templates.pm
573.00mslineB.pm
152.72mslineDBIx/Class/ResultSource/RowParser.pm
5862.70mslineDBIx/Class/Relationship/HasMany.pm
22.52mslineTry/Tiny.pm
192.34mslineC4/Output.pm
3342.20mslineDBIx/Class/Relationship/Base.pm
3492.13mslineMethod/Generate/Constructor.pm
292.11mslineTemplate.pm
542.05mslineKoha/Schema/Result/Borrower.pm
351.93mslineDBIx/Class/Optional/Dependencies.pm
151.93mslineDBIx/Class/ResultSource/RowParser/Util.pm
151.80mslineDBIx/Class/ResultSetColumn.pm
1991.66mslineDBIx/Class/Relationship/HasOne.pm
201.60mslineTemplate/Service.pm
291.57mslineKoha/Schema/Result/Item.pm
291.54mslineMRO/Compat.pm
161.49mslineTemplate/Document.pm
1551.47mslineDBIx/Class/Componentised.pm
1391.46mslineDBIx/Class/Carp.pm
231.42mslineTemplate/Config.pm
161.36mslineKoha/Schema/Result/Subscription.pm
341.23mslineKoha/Schema/Result/Branch.pm
161.18mslineDBIx/Class/Storage/DBI/mysql.pm
121.17mslineKoha/Schema/Result/BorrowerModification.pm
111.15mslineKoha/Schema/Result/Deletedborrower.pm
221.15mslineKoha/Schema/Result/Aqorder.pm
161.12mslineTemplate/Base.pm
131.11mslineKoha/Schema/Result/BorrowerFile.pm
171.01mslineKoha/Schema/Result/Category.pm
19963µslineKoha/Schema/Result/Aqbasket.pm
15959µslineDBIx/Class/ResultSourceHandle.pm
14944µslineKoha/Schema/Result/PatronList.pm
19933µslineKoha/Schema/Result/Aqbookseller.pm
14923µslineKoha/Schema/Result/Letter.pm
12914µslineKoha/Schema/Result/Deleteditem.pm
17828µslineKoha/Schema/Result/ImportRecord.pm
13828µslineKoha/Schema/Result/MarcModificationTemplateAction.pm
12816µslineKoha/Schema/Result/RepeatableHoliday.pm
13813µslineKoha/Schema/Result/BorrowerSync.pm
12803µslineKoha/Schema/Result/City.pm
1796µslinebase.pm
18792µslineKoha/Schema/Result/Reserve.pm
15792µslineKoha/Schema/Result/Subscriptionroutinglist.pm
12787µslineKoha/Schema/Result/Issuingrule.pm
15785µslineKoha/Schema/Result/AqordersTransfer.pm
12784µslineKoha/Schema/Result/Deletedbiblioitem.pm
15783µslineKoha/Schema/Result/Biblioitem.pm
18778µslineKoha/Schema/Result/Issue.pm
14776µslineTemplate/Exception.pm
23773µslineKoha/Schema/Result/Biblio.pm
13767µslineKoha/Schema/Result/Suggestion.pm
14729µslineKoha/Schema/Result/Virtualshelfshare.pm
12720µslineKoha/Schema/Result/Z3950server.pm
12720µslineKoha/Schema/Result/Deletedbiblio.pm
14707µslineKoha/Schema/Result/OldIssue.pm
14707µslineKoha/Schema/Result/Overduerule.pm
15706µslineKoha/Schema/Result/OldReserve.pm
14698µslineKoha/Schema/Result/Accountline.pm
13693µslineKoha/Schema/Result/SubscriptionNumberpattern.pm
14691µslineKoha/Schema/Result/MessageQueue.pm
15670µslineKoha/Schema/Result/CreatorBatch.pm
18669µslineMoo/HandleMoose/_TypeMap.pm
16667µslineKoha/Schema/Result/CourseItem.pm
13665µslineKoha/Schema/Result/ImportBatch.pm
28663µslineMoo/Object.pm
15661µslineKoha/Schema/Result/MessageTransport.pm
12661µslineKoha/Schema/Result/CreatorTemplate.pm
13653µslineKoha/Schema/Result/Patronimage.pm
13649µslineKoha/Schema/Result/AuthSubfieldStructure.pm
11642µslineKoha/Schema/Result/Notify.pm
14642µslineKoha/Schema/Result/OpacNews.pm
12639µslineKoha/Schema/Result/Zebraqueue.pm
18638µslineKoha/Schema/Result/MessageTransportType.pm
14632µslineKoha/Schema/Result/Serialitem.pm
36631µslineImport/Into.pm
12630µslineKoha/Schema/Result/ReportsDictionary.pm
1871.10mslineDevel/GlobalDestruction.pm (including 1 string eval)
7620µslineDBIx/Class/PK.pm
15615µslineKoha/Schema/Result/CourseReserve.pm
12614µslineKoha/Schema/Result/SavedSql.pm
17606µslineKoha/Schema/Result/BorrowerMessagePreference.pm
14605µslineKoha/Schema/Result/TagAll.pm
12605µslineKoha/Schema/Result/AuthHeader.pm
11598µslineKoha/Schema/Result/LanguageScriptMapping.pm
15597µslineKoha/Schema/Result/MessageAttribute.pm
16597µslineKoha/Schema/Result/HoldFillTarget.pm
14596µslineKoha/Schema/Result/AuthType.pm
13596µslineKoha/Schema/Result/SubscriptionFrequency.pm
14594µslineKoha/Schema/Result/Rating.pm
15594µslineKoha/Schema/Result/Matchcheck.pm
15591µslineKoha/Schema/Result/MarcMatcher.pm
14591µslineKoha/Schema/Result/TagsIndex.pm
15590µslineKoha/Schema/Result/Aqinvoice.pm
14588µslineKoha/Schema/Result/Branchtransfer.pm
15588µslineKoha/Schema/Result/Course.pm
14585µslineKoha/Schema/Result/Itemtype.pm
12582µslineKoha/Schema/Result/Accountoffset.pm
13579µslineKoha/Schema/Result/Aqcontact.pm
14577µslineKoha/Schema/Result/Permission.pm
15576µslineKoha/Schema/Result/Virtualshelfcontent.pm
13575µslineKoha/Schema/Result/AuthTagStructure.pm
131572µslineDBI/Const/GetInfo/ODBC.pm
12572µslineKoha/Schema/Result/LanguageRfc4646ToIso639.pm
12568µslineKoha/Schema/Result/Linktracker.pm
12568µslineKoha/Schema/Result/CreatorLayout.pm
14565µslineKoha/Schema/Result/BorrowerMessageTransportPreference.pm
18563µslineKoha/Schema/Result/Aqbudget.pm
13562µslineKoha/Schema/Result/BorrowerDebarment.pm
13562µslineKoha/Schema/Result/Serial.pm
17561µslineKoha/Schema/Result/Matchpoint.pm
12560µslineKoha/Schema/Result/ColumnsSetting.pm
14559µslineKoha/Schema/Result/Branchcategory.pm
13558µslineKoha/Schema/Result/DefaultBorrowerCircRule.pm
12558µslineKoha/Schema/Result/MarcSubfieldStructure.pm
15556µslineKoha/Schema/Result/Virtualshelve.pm
14556µslineKoha/Schema/Result/OverduerulesTransportType.pm
14556µslineKoha/Schema/Result/TagsApproval.pm
14554µslineKoha/Schema/Result/AdditionalFieldValue.pm
16546µslineKoha/Schema/Result/OaiSet.pm
12544µslineKoha/Schema/Result/PendingOfflineOperation.pm
12544µslineKoha/Schema/Result/ExportFormat.pm
13543µslineKoha/Schema/Result/Biblioimage.pm
11542µslineKoha/Schema/Result/Statistic.pm
15542µslineKoha/Schema/Result/ItemsLastBorrower.pm
13538µslineKoha/Schema/Result/ClassSource.pm
13536µslineKoha/Schema/Result/Localization.pm
13536µslineKoha/Schema/Result/DefaultBranchCircRule.pm
14535µslineKoha/Schema/Result/TransportCost.pm
14526µslineKoha/Schema/Result/Currency.pm
12525µslineKoha/Schema/Result/DefaultCircRule.pm
13524µslineKoha/Schema/Result/DefaultBranchItemRule.pm
14523µslineKoha/Schema/Result/MatchpointComponent.pm
12520µslineKoha/Schema/Result/SearchHistory.pm
12519µslineKoha/Schema/Result/BiblioFramework.pm
11517µslineKoha/Schema/Result/TmpHoldsqueue.pm
12514µslineKoha/Schema/Result/Subscriptionhistory.pm
12513µslineKoha/Schema/Result/Aqbudgetperiod.pm
14506µslineKoha/Schema/Result/Branchrelation.pm
14506µslineKoha/Schema/Result/Aqcontract.pm
12504µslineKoha/Schema/Result/MarcTagStructure.pm
12504µslineKoha/Schema/Result/AudioAlert.pm
12501µslineKoha/Schema/Result/Alert.pm
13498µslineKoha/Schema/Result/ItemsSearchField.pm
14497µslineKoha/Schema/Result/AdditionalField.pm
12496µslineKoha/Schema/Result/LanguageDescription.pm
13496µslineKoha/Schema/Result/ImportItem.pm
13495µslineKoha/Schema/Result/MarcModificationTemplate.pm
13494µslineKoha/Schema/Result/ClassSortRule.pm
14494µslineKoha/Schema/Result/BorrowerAttributeType.pm
12492µslineKoha/Schema/Result/SpecialHoliday.pm
14492µslineKoha/Schema/Result/CourseInstructor.pm
12491µslineKoha/Schema/Result/UploadedFile.pm
14487µslineKoha/Schema/Result/BranchItemRule.pm
10484µslineKoha/Schema/Result/ActionLogs.pm
11479µslineKoha/Schema/Result/LanguageScriptBidi.pm
13478µslineKoha/Schema/Result/CategoriesBranch.pm
13476µslineKoha/Schema/Result/OaiSetsBiblio.pm
14476µslineKoha/Schema/Result/Review.pm
14476µslineKoha/Schema/Result/PatronListPatron.pm
12474µslineKoha/Schema/Result/ImportBiblio.pm
14473µslineKoha/Schema/Result/AuthorisedValuesBranch.pm
14470µslineKoha/Schema/Result/BranchBorrowerCircRule.pm
13470µslineKoha/Schema/Result/AqordersItem.pm
12470µslineKoha/Schema/Result/ItemCirculationAlertPreference.pm
12468µslineKoha/Schema/Result/Quote.pm
12466µslineKoha/Schema/Result/MiscFile.pm
13461µslineKoha/Schema/Result/BorrowerAttributeTypesBranch.pm
12460µslineKoha/Schema/Result/ServicesThrottle.pm
12460µslineKoha/Schema/Result/SavedReport.pm
14458µslineKoha/Schema/Result/Aqbudgetborrower.pm
14457µslineKoha/Schema/Result/AqorderUser.pm
12456µslineKoha/Schema/Result/Message.pm
12452µslineKoha/Schema/Result/ImportAuth.pm
11451µslineKoha/Schema/Result/Browser.pm
12451µslineKoha/Schema/Result/Session.pm
12450µslineKoha/Schema/Result/OaiSetsDescription.pm
12450µslineKoha/Schema/Result/BranchTransferLimit.pm
12444µslineKoha/Schema/Result/Tag.pm
13443µslineKoha/Schema/Result/Discharge.pm
13443µslineKoha/Schema/Result/BorrowerAttribute.pm
12442µslineKoha/Schema/Result/SocialData.pm
14442µslineKoha/Schema/Result/Aqbasketgroup.pm
13442µslineKoha/Schema/Result/CreatorImage.pm
12440µslineKoha/Schema/Result/PluginData.pm
12435µslineKoha/Schema/Result/CollectionsTracking.pm
12432µslineKoha/Schema/Result/ActionLog.pm
21432µslineContext/Preserve.pm
13431µslineKoha/Schema/Result/Userflag.pm
12430µslineKoha/Schema/Result/Fieldmapping.pm
12428µslineKoha/Schema/Result/MatchpointComponentNorm.pm
12425µslineKoha/Schema/Result/NeedMergeAuthority.pm
171.29mslineCGI/Compile.pm (including 1 string eval)
13421µslineKoha/Schema/Result/MatcherMatchpoint.pm
15416µslineClass/XSAccessor/Heavy.pm
10404µslineDBIx/Class/ResultSource/Table.pm
12395µslineKoha/Schema/Result/LanguageSubtagRegistry.pm
12383µslineDBIx/Class/Exception.pm
10381µslineKoha/Schema.pm
12372µslineKoha/Schema/Result/ImportRecordMatch.pm
13358µslineKoha/Schema/Result/UserPermission.pm
13341µslineKoha/Schema/Result/Collection.pm
13334µslineKoha/Schema/Result/AqbudgetsPlanning.pm
14320µslineKoha/Schema/Result/AuthorisedValue.pm
851.16mslineCGI.pm (including 5 string evals)
12318µslineKoha/Schema/Result/OaiSetsMapping.pm
10292µslineDBIx/Class/Relationship/CascadeActions.pm
14291µslineKoha/Schema/Result/Aqbasketuser.pm
12276µslineKoha/Schema/Result/Systempreference.pm
12274µslineKoha/Schema/Result/Printer.pm
4380µslineDBI.pm (including 1 string eval)
8222µslineMoo/sification.pm
8176µslineDBIx/Class/Core.pm
7173µslineDBIx/Class/PK/Auto.pm
8143µslineDBIx/Class/Relationship/Helpers.pm
8143µslineDBIx/Class/Relationship.pm
2104µslineConfig.pm
588µslineDBIx/Class/StartupCheck.pm
1578µslineDBI/Const/GetInfo/ANSI.pm
263µslineKoha/Objects.pm
551µslineMoo/_mro.pm
15µslineModule/Runtime.pm
14µ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
1139µsline/unknown-eval-invoker (including 1 string eval)
2046562.32sTotal (-40 statements are unaccounted for)
7418.40msAverage
594µsMedian
0.00015Deviation
Report produced by the NYTProf 6.02 Perl profiler, developed by Tim Bunce and Adam Kaplan.