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:31:06 2016
Reported on Fri Jan 8 14:31:40 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.16s (of 2.37s), executing 418369 statements and 129630 subroutine calls in 352 source files and 51 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
92711402ms455msClass::Accessor::Grouped::::__ANON__[Class/Accessor/Grouped.pm:774] Class::Accessor::Grouped::__ANON__[Class/Accessor/Grouped.pm:774]
72486254ms1.34sClass::C3::Componentised::::ensure_class_loaded Class::C3::Componentised::ensure_class_loaded (recurses: max depth 3, inclusive time 119ms)
19221179.0ms674msClass::Accessor::Grouped::::_mk_group_accessors Class::Accessor::Grouped::_mk_group_accessors
39441156.3ms534msClass::Accessor::Grouped::::__ANON__[Class/Accessor/Grouped.pm:942] Class::Accessor::Grouped::__ANON__[Class/Accessor/Grouped.pm:942]
23523522853.8ms172msbase::::import base::import (recurses: max depth 3, inclusive time 104ms)
101144.1ms59.8msTemplate::Parser::::_parse Template::Parser::_parse
17417417440.5ms700msDBIx::Class::ResultSourceProxy::::add_columns DBIx::Class::ResultSourceProxy::add_columns
41752230.1ms34.6msClass::Accessor::Grouped::::get_inherited Class::Accessor::Grouped::get_inherited
3482128.1ms49.9msDBIx::Class::Schema::::_register_source DBIx::Class::Schema::_register_source
458110425.1ms25.1msSub::Name::::subname Sub::Name::subname (xsub)
39441124.6ms558msClass::Accessor::Grouped::::make_group_accessor Class::Accessor::Grouped::make_group_accessor
1741121.5ms22.3msDBIx::Class::ResultSource::::add_columns DBIx::Class::ResultSource::add_columns
17417417419.7ms73.8msDBIx::Class::ResultSourceProxy::Table::::tableDBIx::Class::ResultSourceProxy::Table::table
871119.2ms24.0msDBIx::Class::Storage::DBIHacks::::_resolve_column_info DBIx::Class::Storage::DBIHacks::_resolve_column_info
5201119.0ms19.7msFile::Spec::Unix::::abs2rel File::Spec::Unix::abs2rel

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
101449773mslineClass/Accessor/Grouped.pm (including 1 string eval)
4200153mslineClass/C3/Componentised.pm
44306105mslineDBIx/Class/ResultSource.pm
9469884.0mslineTemplate/Parser.pm
1165774.7mslineDBIx/Class/Storage/DBI.pm
2845160.2mslineDBIx/Class/ResultSet.pm
986057.4mslineDBIx/Class/Schema.pm
1771950.8mslineSQL/Abstract.pm
389938.5mslineModule/Find.pm
521337.7mslineDBIx/Class/ResultSourceProxy.pm
1134435.1mslineDBIx/Class/Storage/DBIHacks.pm
1662949.5mslineSub/Quote.pm (including 17 string evals)
158122.8mslineDBIx/Class/ResultSourceProxy/Table.pm
738621.7mslineDBIx/Class/Row.pm
854621.1mslineDBIx/Class/SQLMaker.pm
205118.7mslineDBD/mysql.pm
236517.3mslineDBIx/Class/Relationship/BelongsTo.pm
240515.6mslineDBIx/Class/Relationship/Accessor.pm
146415.5mslineTemplate/Provider.pm
515.4mslineC4/Languages.pm
226415.4mslineDBIx/Class/Storage/BlockRunner.pm
334215.1mslineMoo/_Utils.pm
35414.8mslineC4/Auth.pm
3713.9mslineTemplate/Grammar.pm
514513.2mslineTemplate/Directive.pm
3212.8mslineC4/Auth_with_cas.pm
311.0mslineKoha/Database.pm
449.81mslinemainpage.pl
3379.23mslineTemplate/Document.pm (including 10 string evals)
45278.34mslineSub/Defer.pm (including 1 string eval)
47.34mslineFile/Find.pm
276.81mslineKoha/Borrower/Discharge.pm
29696.65mslineParser.yp
2656.08mslineMoo.pm (including 1 string eval)
26745.99mslineDBIx/Class/AccessorGroup.pm
6345.94mslineMethod/Generate/Accessor.pm
6945.87mslineTemplate/Context.pm
3816.12mslineCGI/Session.pm (including 3 string evals)
235.62mslineLWP/UserAgent.pm
11675.48mslineC4/Templates.pm
7695.45mslineDBIx/Class.pm
10775.04mslineDBIx/Class/Storage/DBI/mysql.pm
335.00mslineC4/Tags.pm
24.91mslineKoha/Object.pm
3084.64mslineDBIx/Class/Relationship/ManyToMany.pm
1265.94mslineJSON.pm (including 4 string evals)
11504.14mslineDBIx/Class/_Util.pm
1594.12mslineTemplate/Stash.pm
11094.07mslineDBIx/Class/InflateColumn.pm
24.05mslineTry/Tiny.pm
2023.75mslineTemplate/Plugins.pm
10693.68mslineCGI/Cookie.pm
21893.67mslineClass/XSAccessor.pm
9693.64mslineDBIx/Class/Relationship/ProxyMethods.pm
433.63mslineTemplate/VMethods.pm
153.60mslineDBI/Const/GetInfoType.pm
573.58mslineB.pm
23.56mslineKoha/Objects.pm
9133.50mslineHash/Merge.pm
93.37mslineDBIx/Class/SQLMaker/LimitDialects.pm
253.29mslineTemplate/Filters.pm
1033.23mslineTemplate/Config.pm
153.05mslineDBIx/Class/ResultSource/RowParser.pm
363.00mslineDBIx/Class/Storage.pm
872.98mslineTemplate/Constants.pm
5862.87mslineDBIx/Class/Relationship/HasMany.pm
362.87mslineC4/Output.pm
12.55mslineC4/Context.pm
372.51mslineCGI/Session/Driver/mysql.pm
12.49mslineApache/LogFormat/Compiler.pm
422.39mslineConfig_heavy.pl
312.38mslineC4/Suggestions.pm
542.32mslineKoha/Schema/Result/Borrower.pm
522.24mslineDBIx/Class/Storage/DBI/Cursor.pm
542.20mslineTemplate.pm
352.19mslineDBIx/Class/Optional/Dependencies.pm
172.17mslineAuthen/CAS/Client.pm
3342.16mslineDBIx/Class/Relationship/Base.pm
882.12mslineDateTime/TimeZone/Local/Unix.pm
3492.08mslineMethod/Generate/Constructor.pm
162.05mslineJSON/XS.pm
152.05mslineDBIx/Class/ResultSource/RowParser/Util.pm
251.91mslineTemplate/Plugin/String.pm
721.82mslineTemplate/Service.pm
611.79mslineCGI/Session/Driver/DBI.pm
211.73mslineAuthen/CAS/Client/Response.pm
1991.67mslineDBIx/Class/Relationship/HasOne.pm
9011.62mslineContext/Preserve.pm
211.61mslineC4/Search/History.pm
1551.60mslineDBIx/Class/Componentised.pm
291.60mslineKoha/Schema/Result/Item.pm
1471.56mslineDBIx/Class/Carp.pm
291.51mslineMRO/Compat.pm
151.49mslineLWP/Protocol.pm
121.47mslineKoha/Schema/Result/BorrowerModification.pm
581.47mslineDBIx/Class/ResultSetColumn.pm
161.43mslineKoha/Borrower/Modifications.pm
491.39mslineTemplate/Iterator.pm
141.37mslineKoha/Schema/Result/Rating.pm
141.35mslineKoha/Schema/Result/Letter.pm
721.31mslineTemplate/Base.pm
141.24mslineKoha/Schema/Result/MessageQueue.pm
171.23mslineDBIx/Class/Storage/TxnScopeGuard.pm
341.22mslineKoha/Schema/Result/Branch.pm
1241.19mslinestrictures.pm
141.17mslineKoha/Schema/Result/Branchcategory.pm
151.16mslineKoha/Template/Plugin/Branches.pm
111.12mslineKoha/Schema/Result/Deletedborrower.pm
141.12mslineTemplate/Exception.pm
151.05mslineDBIx/Class/ResultSourceHandle.pm
231.05mslineattributes.pm
221.04mslineKoha/Schema/Result/Aqorder.pm
161.04mslineKoha/Schema/Result/Subscription.pm
11.02mslinebase.pm
161.02mslineKoha/Schema/Result/HoldFillTarget.pm
341.00mslineDBD/mysql/GetInfo.pm
13971µslineKoha/Schema/Result/Discharge.pm
79955µslineFile/Compare.pm
2951µslineC4/NewsChannels.pm
21940µslineC4/Review.pm
12939µslineKoha/Schema/Result/MarcSubfieldStructure.pm
13929µslineKoha/Schema/Result/PrintersProfile.pm
19912µslineKoha/Schema/Result/Aqbasket.pm
27910µslineTemplate/Stash/XS.pm
19895µslineKoha/Schema/Result/Aqbookseller.pm
27894µslineCGI/Session/Serialize/yaml.pm (including 2 string evals)
17858µslineKoha/Schema/Result/Matchpoint.pm
12846µslineKoha/Schema/Result/Deleteditem.pm
18842µslineKoha/Schema/Result/Aqbudget.pm
13834µslineKoha/Schema/Result/MarcModificationTemplateAction.pm
12831µslineKoha/Schema/Result/Linktracker.pm
13825µslineKoha/Schema/Result/ImportBatch.pm
14823µslineKoha/Schema/Result/Aqbasketuser.pm
15821µslineKoha/Schema/Result/Biblioitem.pm
18817µslineKoha/Schema/Result/Reserve.pm
13786µslineKoha/Schema/Result/Suggestion.pm
15778µslineKoha/Schema/Result/Aqinvoice.pm
12777µslineKoha/Schema/Result/UploadedFile.pm
14773µslineKoha/Schema/Result/Branchtransfer.pm
18766µslineKoha/Schema/Result/Issue.pm
17760µslineKoha/Schema/Result/Category.pm
23753µslineKoha/Schema/Result/Biblio.pm
98747µslineDBIx/Class/ResultSource/Table.pm
18738µslineMoo/HandleMoose/_TypeMap.pm
12738µslineKoha/Schema/Result/Deletedbiblioitem.pm
17736µslineKoha/Schema/Result/ImportRecord.pm
14730µslineKoha/Schema/Result/Aqcontract.pm
14729µslineKoha/Schema/Result/OldIssue.pm
12726µslineKoha/Schema/Result/Z3950server.pm
7723µslineHTTP/Request.pm
10707µslineDBIx/Class/Relationship/CascadeActions.pm
12707µslineKoha/Schema/Result/SpecialHoliday.pm
12706µslineKoha/Schema/Result/CreatorTemplate.pm
12694µslineKoha/Schema/Result/Issuingrule.pm
11694µslineKoha/Schema/Result/Statistic.pm
18692µslineDigest/MD5.pm
15688µslineKoha/Schema/Result/OldReserve.pm
15686µslineKoha/Schema/Result/Virtualshelve.pm
27682µslineTemplate/Plugin.pm
14680µslineKoha/Schema/Result/MatchpointComponent.pm
14679µslineKoha/Schema/Result/Accountline.pm
14677µslineKoha/Schema/Result/BorrowerAttributeType.pm
13670µslineKoha/Schema/Result/AuthSubfieldStructure.pm
13652µslineKoha/Schema/Result/UserPermission.pm
15633µslineKoha/Template/Plugin/Koha.pm
17618µslineKoha/Schema/Result/BorrowerMessagePreference.pm
14616µslineKoha/Schema/Result/Review.pm
14612µslineKoha/Schema/Result/Itemtype.pm
12605µslineKoha/Schema/Result/CreatorLayout.pm
13602µslineKoha/Schema/Result/AqordersItem.pm
15602µslineKoha/Schema/Result/Course.pm
14602µslineKoha/Schema/Result/OpacNews.pm
36599µslineImport/Into.pm
18598µslineKoha/Schema/Result/MessageTransportType.pm
12594µslineKoha/Schema/Result/Deletedbiblio.pm
13593µslineKoha/Schema/Result/Aqcontact.pm
28593µslineMoo/Object.pm
15592µslineKoha/Schema/Result/CreatorBatch.pm
131590µslineDBI/Const/GetInfo/ODBC.pm
12585µslineKoha/Schema/Result/CollectionsTracking.pm
13580µslineKoha/Schema/Result/MatcherMatchpoint.pm
15579µslineKoha/Schema/Result/MessageTransport.pm
14576µslineKoha/Schema/Result/AdditionalField.pm
7576µslineDBIx/Class/PK.pm
14574µslineKoha/Schema/Result/TransportCost.pm
13572µslineKoha/Schema/Result/SubscriptionNumberpattern.pm
12572µslineKoha/Schema/Result/AuthHeader.pm
14569µslineKoha/Schema/Result/Overduerule.pm
14565µslineKoha/Schema/Result/BorrowerMessageTransportPreference.pm
13565µslineKoha/Schema/Result/AqbudgetsPlanning.pm
17952µslineCGI/Compile.pm (including 1 string eval)
15560µslineKoha/Schema/Result/Virtualshelfcontent.pm
15559µslineKoha/Schema/Result/CourseReserve.pm
15557µslineKoha/Schema/Result/AqordersTransfer.pm
12549µslineKoha/Schema/Result/BranchTransferLimit.pm
14546µslineKoha/Schema/Result/Branchrelation.pm
5546µslineURI/QueryParam.pm
15545µslineKoha/Schema/Result/ItemsLastBorrower.pm
14544µslineKoha/Schema/Result/AqorderUser.pm
16544µslineKoha/Schema/Result/OaiSet.pm
14543µslineKoha/Schema/Result/Aqbasketgroup.pm
13538µslineKoha/Schema/Result/Biblioimage.pm
12536µslineKoha/Schema/Result/SearchHistory.pm
12536µslineKoha/Schema/Result/MiscFile.pm
13531µslineKoha/Schema/Result/ImportItem.pm
13531µslineKoha/Schema/Result/CategoriesBranch.pm
14528µslineKoha/Schema/Result/AuthType.pm
14526µslineKoha/Schema/Result/AuthorisedValuesBranch.pm
13525µslineKoha/Schema/Result/DefaultBorrowerCircRule.pm
13524µslineKoha/Schema/Result/Localization.pm
14524µslineKoha/Schema/Result/TagsApproval.pm
14522µslineKoha/Schema/Result/AdditionalFieldValue.pm
15521µslineKoha/Schema/Result/MessageAttribute.pm
13519µslineKoha/Schema/Result/SubscriptionFrequency.pm
12514µslineKoha/Schema/Result/ItemCirculationAlertPreference.pm
12514µslineKoha/Schema/Result/Accountoffset.pm
12511µslineKoha/Schema/Result/City.pm
13511µslineKoha/Schema/Result/Collection.pm
12511µslineKoha/Schema/Result/Aqbudgetperiod.pm
13508µslineKoha/Schema/Result/ItemsSearchField.pm
14508µslineKoha/Schema/Result/TagsIndex.pm
14506µslineKoha/Schema/Result/AuthorisedValue.pm
13506µslineKoha/Schema/Result/BorrowerSync.pm
15505µslineKoha/Schema/Result/Subscriptionroutinglist.pm
15504µslineKoha/Schema/Result/Matchcheck.pm
14504µslineKoha/Schema/Result/Aqbudgetborrower.pm
14503µslineKoha/Schema/Result/BranchItemRule.pm
13503µslineKoha/Schema/Result/BorrowerAttribute.pm
13499µslineKoha/Schema/Result/BorrowerDebarment.pm
14498µslineKoha/Schema/Result/Virtualshelfshare.pm
11498µslineKoha/Schema/Result/Notify.pm
14498µslineKoha/Schema/Result/CourseInstructor.pm
104496µslinekoha-tmpl/intranet-tmpl/prog/en/modules/intranet-main.tt
13496µslineKoha/Schema/Result/OaiSetsBiblio.pm
13493µslineKoha/Template/Plugin/AudioAlerts.pm
15492µslineKoha/Schema/Result/MarcMatcher.pm
7601µslineDBI.pm (including 1 string eval)
14489µslineKoha/Schema/Result/Currency.pm
13489µslineKoha/Schema/Result/BorrowerFile.pm
12486µslineKoha/Schema/Result/Session.pm
12486µslineKoha/Schema/Result/Tag.pm
12482µslineKoha/Schema/Result/ImportBiblio.pm
14481µslineKoha/Schema/Result/PatronList.pm
14481µslineKoha/Schema/Result/Permission.pm
12481µslineKoha/Schema/Result/SocialData.pm
12480µslineKoha/Schema/Result/ExportFormat.pm
12479µslineKoha/Schema/Result/Zebraqueue.pm
14479µslineKoha/Schema/Result/TagAll.pm
13477µslineKoha/Schema/Result/DefaultBranchCircRule.pm
14470µslineKoha/Schema/Result/BranchBorrowerCircRule.pm
13468µslineKoha/Schema/Result/ClassSortRule.pm
13468µslineKoha/Schema/Result/BorrowerAttributeTypesBranch.pm
12468µslineKoha/Schema/Result/AudioAlert.pm
12468µslineKoha/Schema/Result/Systempreference.pm
12467µslineKoha/Schema/Result/LanguageSubtagRegistry.pm
14467µslineKoha/Schema/Result/OverduerulesTransportType.pm
12467µslineKoha/Schema/Result/RepeatableHoliday.pm
12467µslineKoha/Schema/Result/PendingOfflineOperation.pm
13464µslineKoha/Schema/Result/DefaultBranchItemRule.pm
13462µslineKoha/Schema/Result/ClassSource.pm
12462µslineKoha/Schema/Result/PluginData.pm
12460µslineKoha/Schema/Result/ImportAuth.pm
13458µslineKoha/Schema/Result/MarcModificationTemplate.pm
12458µslineKoha/Schema/Result/Message.pm
14458µslineKoha/Schema/Result/PatronListPatron.pm
12454µslineKoha/Schema/Result/MatchpointComponentNorm.pm
12448µslineKoha/Schema/Result/ActionLog.pm
12445µslineKoha/Schema/Result/LanguageRfc4646ToIso639.pm
13445µslineKoha/Schema/Result/Userflag.pm
12444µslineKoha/Schema/Result/MarcTagStructure.pm
13444µslineKoha/Schema/Result/CreatorImage.pm
12443µslineKoha/Schema/Result/DefaultCircRule.pm
12442µslineKoha/Schema/Result/OaiSetsMapping.pm
12437µslineKoha/Schema/Result/ColumnsSetting.pm
12436µslineKoha/Schema/Result/ReportsDictionary.pm
11435µslineKoha/Schema/Result/Browser.pm
12434µslineKoha/Schema/Result/OaiSetsDescription.pm
12425µslineKoha/Schema/Result/Fieldmapping.pm
12422µslineKoha/Schema/Result/Alert.pm
12417µslineKoha/Schema/Result/LanguageDescription.pm
13415µslineKoha/Schema/Result/Serial.pm
15409µslineClass/XSAccessor/Heavy.pm
12407µslineKoha/Schema/Result/NeedMergeAuthority.pm
12406µslineKoha/Schema/Result/ServicesThrottle.pm
1874.89mslineDevel/GlobalDestruction.pm (including 1 string eval)
11393µslineKoha/Schema/Result/LanguageScriptBidi.pm
11385µslineKoha/Schema/Result/LanguageScriptMapping.pm
12384µslineDBIx/Class/Exception.pm
25383µslineCGI/Session/Driver.pm
12372µslineKoha/Schema/Result/BiblioFramework.pm
10370µslineKoha/Schema.pm
13351µslineKoha/Schema/Result/AuthTagStructure.pm
10350µslineKoha/Schema/Result/ActionLogs.pm
7342µslineDBIx/Class/Cursor.pm
16340µslineKoha/Schema/Result/CourseItem.pm
11337µslineKoha/Schema/Result/Stopword.pm
13329µslineKoha/Schema/Result/Patronimage.pm
12308µslineKoha/Schema/Result/SavedSql.pm
12284µslineKoha/Schema/Result/Subscriptionhistory.pm
11276µslineKoha/Schema/Result/TmpHoldsqueue.pm
25272µslineCGI/Session/ErrorHandler.pm
12271µslineKoha/Schema/Result/Printer.pm
1741.66mslineCGI.pm (including 7 string evals)
64253µslinekoha-tmpl/intranet-tmpl/prog/en/includes/doc-head-close.inc
12242µslineKoha/Schema/Result/Quote.pm
12225µslineKoha/Schema/Result/ImportRecordMatch.pm
14214µslineKoha/Schema/Result/Serialitem.pm
60211µslinekoha-tmpl/intranet-tmpl/prog/en/includes/header.inc
10205µslineDBIx/Class/SQLMaker/MySQL.pm
11197µslinelocale.pm
10189µslineCGI/Session/ID/md5.pm
18177µslinekoha-tmpl/intranet-tmpl/prog/en/includes/patron-search-box.inc
8171µslineDBIx/Class/Core.pm
1170µslineC4/Members.pm
8170µslineMoo/sification.pm
2158µslineXSLoader.pm
7155µslineDBIx/Class/PK/Auto.pm
12152µslineKoha/Schema/Result/SavedReport.pm
8148µslineDBIx/Class/Relationship.pm
8146µslineDBIx/Class/Relationship/Helpers.pm
2147µslineEncode/Alias.pm (including 1 string eval)
16126µslinekoha-tmpl/intranet-tmpl/prog/en/includes/doc-head-open.inc
126115µslineText/Abbrev.pm
5110µslineDBIx/Class/StartupCheck.pm
2108µslineConfig.pm
779µslinekoha-tmpl/intranet-tmpl/prog/en/includes/intranet-bottom.inc
1579µslineDBI/Const/GetInfo/ANSI.pm
2376µslinekoha-tmpl/intranet-tmpl/prog/en/includes/home-search.inc
556µslineMoo/_mro.pm
1654µslinekoha-tmpl/intranet-tmpl/prog/en/includes/intranetstylesheet.inc
347µslineDateTime/TimeZone/Local.pm
628µslinecommon/sense.pm
125µslineModule/Runtime.pm
414µslineLWP.pm
13µslineLWP/MemberMixin.pm
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
10slineConfig_git.pl
00slinenamespace/clean.pm
00slineB/Hooks/EndOfScope/XS.pm
00slineFile/Spec/Unix.pm
00slineXML/Parser/Expat.pm
00slineXML/Parser.pm
00slinedeprecate.pm
00slineEncode.pm
00slineKoha/DateUtils.pm
00slineDateTime.pm
00slineCGI/Emulate/PSGI.pm
26143µsline/unknown-eval-invoker (including 1 string eval)
4184372.15sTotal (-68 statements are unaccounted for)
11886.12msAverage
612µsMedian
0.00026Deviation