NYTProf plack.psgi

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.38s (of 6.35s), executing 1941470 statements and 653798 subroutine calls in 282 source files and 28 string evals.

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
13000	1	1	506ms	3.07s	DBIx::Class::ResultSet::_construct_results
927	1	1	391ms	442ms	Class::Accessor::Grouped::__ANON__[Class/Accessor/Grouped.pm:774]
14000	2	1	373ms	441ms	DBIx::Class::ResultSet::_resolved_attrs
2545	8	6	255ms	1.29s	Class::C3::Componentised::ensure_class_loaded (recurses: max depth 3, inclusive time 116ms)
22000	3	1	184ms	441ms	DBIx::Class::SQLMaker::::_quote DBIx::Class::SQLMaker::_quote
21000	2	1	175ms	568ms	DBIx::Class::SQLMaker::_recurse_fields (recurses: max depth 1, inclusive time 477ms)
13000	1	1	162ms	1.91s	DBIx::Class::Storage::DBI::Cursor::next
21000	2	2	138ms	427ms	DBD::mysql::st::__ANON__[DBD/mysql.pm:810]
22000	1	1	137ms	202ms	SQL::Abstract::_assert_pass_injection_guard
13000	1	1	134ms	3.22s	DBIx::Class::ResultSet::::next DBIx::Class::ResultSet::next
1000	1	1	104ms	260ms	DBD::_::st::::bind_columns DBD::_::st::bind_columns
10437	2	2	102ms	132ms	Class::Accessor::Grouped::get_inherited
3528	9	6	97.0ms	432ms	Try::Tiny::::try Try::Tiny::try
1000	1	1	95.1ms	95.1ms	DBI::st::::execute DBI::st::execute (xsub)
26645	10	7	75.3ms	75.3ms	next::::method next::method

See all 9729 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
Stmts	Exclusive Time	Reports	Source File
711033	1.21s	line	DBIx/Class/ResultSet.pm
149951	946ms	line	Class/Accessor/Grouped.pm (including 1 string eval)
199022	446ms	line	DBIx/Class/SQLMaker.pm
81285	372ms	line	DBIx/Class/Storage/DBI.pm
166044	370ms	line	SQL/Abstract.pm
200018	344ms	line	DBIx/Class/Storage/DBI/Cursor.pm
63134	246ms	line	DBD/mysql.pm
9663	161ms	line	Class/C3/Componentised.pm
102516	147ms	line	DBIx/Class/Row.pm
50370	125ms	line	DBIx/Class/ResultSource.pm
2018	105ms	line	plack.pl
25064	86.9ms	line	DBIx/Class/Storage/BlockRunner.pm
17156	77.1ms	line	DBIx/Class/Schema.pm
12016	43.7ms	line	DBIx/Class/Storage/DBI/mysql.pm
3899	41.2ms	line	Module/Find.pm
17946	39.2ms	line	DBIx/Class/AccessorGroup.pm
6	38.2ms	line	DBI.pm (including 1 string eval)
5213	35.5ms	line	DBIx/Class/ResultSourceProxy.pm
68813	127ms	line	Sub/Quote.pm (including 16 string evals)
2	32.6ms	line	Try/Tiny.pm
2	25.5ms	line	File/Find.pm
2405	20.0ms	line	DBIx/Class/Relationship/Accessor.pm
3340	19.3ms	line	Moo/_Utils.pm
1581	17.7ms	line	DBIx/Class/ResultSourceProxy/Table.pm
10021	17.5ms	line	Context/Preserve.pm
9049	16.3ms	line	Hash/Merge.pm
3	12.1ms	line	Koha/Database.pm
10270	10.1ms	line	DBIx/Class/_Util.pm
2365	9.26ms	line	DBIx/Class/Relationship/BelongsTo.pm
4516	7.99ms	line	Sub/Defer.pm (including 1 string eval)
21	7.26ms	line	DBIx/Class/Storage/DBIHacks.pm
42	5.90ms	line	Template/Provider.pm
634	5.71ms	line	Method/Generate/Accessor.pm
769	5.15ms	line	DBIx/Class.pm
1010	4.80ms	line	DBIx/Class/ResultSource/Table.pm
1109	4.73ms	line	DBIx/Class/InflateColumn.pm
2121	3.94ms	line	Class/XSAccessor.pm
969	3.63ms	line	DBIx/Class/Relationship/ProxyMethods.pm
1	3.50ms	line	Apache/LogFormat/Compiler.pm
308	3.48ms	line	DBIx/Class/Relationship/ManyToMany.pm
15	3.35ms	line	DBIx/Class/ResultSource/RowParser.pm
57	3.30ms	line	B.pm
15	3.27ms	line	DBI/Const/GetInfoType.pm
9	3.26ms	line	DBIx/Class/SQLMaker/LimitDialects.pm
23	3.13ms	line	C4/Templates.pm
36	3.13ms	line	DBIx/Class/Storage.pm
87	2.97ms	line	Template/Constants.pm
54	2.61ms	line	Koha/Schema/Result/Borrower.pm
586	2.60ms	line	DBIx/Class/Relationship/HasMany.pm
265	2.48ms	line	Moo.pm (including 1 string eval)
42	2.43ms	line	Config_heavy.pl
35	2.22ms	line	DBIx/Class/Optional/Dependencies.pm
334	2.19ms	line	DBIx/Class/Relationship/Base.pm
29	2.15ms	line	Template.pm
349	2.06ms	line	Method/Generate/Constructor.pm
19	2.04ms	line	C4/Output.pm
15	1.97ms	line	DBIx/Class/ResultSource/RowParser/Util.pm
155	1.93ms	line	DBIx/Class/Componentised.pm
15	1.92ms	line	DBIx/Class/ResultSetColumn.pm
199	1.72ms	line	DBIx/Class/Relationship/HasOne.pm
23	1.57ms	line	Template/Config.pm
20	1.52ms	line	Template/Service.pm
16	1.50ms	line	Template/Document.pm
29	1.45ms	line	MRO/Compat.pm
29	1.40ms	line	Koha/Schema/Result/Item.pm
147	1.39ms	line	DBIx/Class/Carp.pm
17	1.33ms	line	DBIx/Class/Storage/TxnScopeGuard.pm
12	1.23ms	line	Koha/Schema/Result/BorrowerModification.pm
18	1.20ms	line	Moo/HandleMoose/_TypeMap.pm
22	1.19ms	line	Koha/Schema/Result/Aqorder.pm
124	1.19ms	line	strictures.pm
16	1.16ms	line	Template/Base.pm
34	1.10ms	line	Koha/Schema/Result/Branch.pm
1	1.06ms	line	base.pm
11	1.03ms	line	Koha/Schema/Result/TmpHoldsqueue.pm
13	1.02ms	line	Koha/Schema/Result/MarcModificationTemplate.pm
15	1.02ms	line	DBIx/Class/ResultSourceHandle.pm
34	974µs	line	DBD/mysql/GetInfo.pm
12	960µs	line	Koha/Schema/Result/LanguageSubtagRegistry.pm
13	923µs	line	Koha/Schema/Result/MatcherMatchpoint.pm
15	922µs	line	Koha/Schema/Result/Virtualshelve.pm
18	921µs	line	Koha/Schema/Result/Reserve.pm
19	898µs	line	Koha/Schema/Result/Aqbasket.pm
12	889µs	line	Koha/Schema/Result/Deleteditem.pm
17	864µs	line	Koha/Schema/Result/Matchpoint.pm
10	850µs	line	DBIx/Class/Relationship/CascadeActions.pm
10	844µs	line	DBIx/Class/SQLMaker/MySQL.pm
15	837µs	line	Koha/Schema/Result/Biblioitem.pm
13	829µs	line	Koha/Schema/Result/MarcModificationTemplateAction.pm
15	828µs	line	Koha/Schema/Result/AqordersTransfer.pm
19	820µs	line	Koha/Schema/Result/Aqbookseller.pm
8	806µs	line	DBIx/Class/Core.pm
14	796µs	line	Koha/Schema/Result/MatchpointComponent.pm
15	788µs	line	Koha/Schema/Result/OldReserve.pm
13	774µs	line	Koha/Schema/Result/Suggestion.pm
13	764µs	line	Koha/Schema/Result/UserPermission.pm
7	762µs	line	DBIx/Class/PK.pm
11	760µs	line	Koha/Schema/Result/Deletedborrower.pm
23	745µs	line	Koha/Schema/Result/Biblio.pm
18	743µs	line	Koha/Schema/Result/Issue.pm
17	742µs	line	Koha/Schema/Result/ImportRecord.pm
12	737µs	line	Koha/Schema/Result/Deletedbiblioitem.pm
17	735µs	line	Koha/Schema/Result/BorrowerMessagePreference.pm
14	732µs	line	Koha/Schema/Result/Virtualshelfshare.pm
17	1.17ms	line	CGI/Compile.pm (including 1 string eval)
14	711µs	line	Template/Exception.pm
13	710µs	line	Koha/Schema/Result/AqbudgetsPlanning.pm
13	710µs	line	Koha/Schema/Result/ImportBatch.pm
14	706µs	line	Koha/Schema/Result/OldIssue.pm
13	697µs	line	Koha/Schema/Result/PrintersProfile.pm
18	690µs	line	Koha/Schema/Result/Aqbudget.pm
12	678µs	line	Koha/Schema/Result/Issuingrule.pm
13	677µs	line	Koha/Schema/Result/Patronimage.pm
12	667µs	line	Koha/Schema/Result/CreatorTemplate.pm
13	652µs	line	Koha/Schema/Result/SubscriptionNumberpattern.pm
13	646µs	line	Koha/Schema/Result/Serial.pm
14	641µs	line	Koha/Schema/Result/Accountline.pm
11	641µs	line	Koha/Schema/Result/LanguageScriptMapping.pm
13	638µs	line	Koha/Schema/Result/AuthSubfieldStructure.pm
15	636µs	line	Koha/Schema/Result/Matchcheck.pm
11	630µs	line	Koha/Schema/Result/Statistic.pm
12	625µs	line	Koha/Schema/Result/Z3950server.pm
14	624µs	line	Koha/Schema/Result/Overduerule.pm
14	624µs	line	Koha/Schema/Result/TransportCost.pm
17	622µs	line	Koha/Schema/Result/Category.pm
28	619µs	line	Moo/Object.pm
14	616µs	line	Koha/Schema/Result/AdditionalField.pm
15	610µs	line	Koha/Schema/Result/Virtualshelfcontent.pm
16	604µs	line	Koha/Schema/Result/CourseItem.pm
15	601µs	line	Koha/Schema/Result/CreatorBatch.pm
13	600µs	line	Koha/Schema/Result/ImportItem.pm
12	597µs	line	Koha/Schema/Result/CreatorLayout.pm
36	596µs	line	Import/Into.pm
13	588µs	line	Koha/Schema/Result/BorrowerDebarment.pm
12	586µs	line	Koha/Schema/Result/MarcSubfieldStructure.pm
16	586µs	line	Koha/Schema/Result/HoldFillTarget.pm
131	584µs	line	DBI/Const/GetInfo/ODBC.pm
14	581µs	line	Koha/Schema/Result/Serialitem.pm
14	579µs	line	Koha/Schema/Result/AuthType.pm
14	578µs	line	Koha/Schema/Result/Letter.pm
14	576µs	line	Koha/Schema/Result/Aqbasketgroup.pm
13	575µs	line	Koha/Schema/Result/DefaultBranchCircRule.pm
15	564µs	line	Koha/Schema/Result/MessageTransport.pm
15	564µs	line	Koha/Schema/Result/Course.pm
14	559µs	line	Koha/Schema/Result/Itemtype.pm
14	557µs	line	Koha/Schema/Result/MessageQueue.pm
12	557µs	line	Koha/Schema/Result/ReportsDictionary.pm
16	552µs	line	Koha/Schema/Result/OaiSet.pm
14	546µs	line	Koha/Schema/Result/Branchtransfer.pm
16	544µs	line	Koha/Schema/Result/Subscription.pm
13	541µs	line	Koha/Schema/Result/Biblioimage.pm
14	539µs	line	Koha/Schema/Result/PatronList.pm
18	536µs	line	Koha/Schema/Result/MessageTransportType.pm
14	529µs	line	Koha/Schema/Result/AuthorisedValue.pm
14	526µs	line	Koha/Schema/Result/OverduerulesTransportType.pm
15	522µs	line	Koha/Schema/Result/MessageAttribute.pm
12	522µs	line	Koha/Schema/Result/Systempreference.pm
14	521µs	line	Koha/Schema/Result/Review.pm
15	521µs	line	Koha/Schema/Result/Aqinvoice.pm
13	521µs	line	Koha/Schema/Result/AuthTagStructure.pm
13	518µs	line	Koha/Schema/Result/BorrowerFile.pm
13	517µs	line	Koha/Schema/Result/Aqcontact.pm
14	517µs	line	Koha/Schema/Result/Aqcontract.pm
12	517µs	line	Koha/Schema/Result/Accountoffset.pm
14	516µs	line	Koha/Schema/Result/TagAll.pm
12	513µs	line	Koha/Schema/Result/Subscriptionhistory.pm
14	513µs	line	Koha/Schema/Result/Currency.pm
14	508µs	line	Koha/Schema/Result/TagsApproval.pm
12	508µs	line	Koha/Schema/Result/Deletedbiblio.pm
12	505µs	line	Koha/Schema/Result/UploadedFile.pm
15	505µs	line	Koha/Schema/Result/MarcMatcher.pm
14	502µs	line	Koha/Schema/Result/BorrowerAttributeType.pm
13	497µs	line	Koha/Schema/Result/ItemsSearchField.pm
14	497µs	line	Koha/Schema/Result/Branchrelation.pm
13	492µs	line	Koha/Schema/Result/Localization.pm
13	490µs	line	Koha/Schema/Result/SubscriptionFrequency.pm
14	490µs	line	Koha/Schema/Result/Permission.pm
12	490µs	line	Koha/Schema/Result/MarcTagStructure.pm
12	489µs	line	Koha/Schema/Result/OaiSetsMapping.pm
12	487µs	line	Koha/Schema/Result/Fieldmapping.pm
14	482µs	line	Koha/Schema/Result/AdditionalFieldValue.pm
11	480µs	line	Koha/Schema/Result/Notify.pm
12	479µs	line	Koha/Schema/Result/PendingOfflineOperation.pm
12	476µs	line	Koha/Schema/Result/BranchTransferLimit.pm
10	476µs	line	Koha/Schema.pm
14	473µs	line	Koha/Schema/Result/BranchBorrowerCircRule.pm
15	472µs	line	Koha/Schema/Result/Subscriptionroutinglist.pm
13	471µs	line	Koha/Schema/Result/Collection.pm
12	470µs	line	Koha/Schema/Result/Aqbudgetperiod.pm
13	469µs	line	Koha/Schema/Result/ClassSource.pm
13	466µs	line	Koha/Schema/Result/AqordersItem.pm
12	465µs	line	Koha/Schema/Result/AuthHeader.pm
12	464µs	line	Koha/Schema/Result/SavedReport.pm
12	464µs	line	Koha/Schema/Result/LanguageRfc4646ToIso639.pm
12	463µs	line	Koha/Schema/Result/ImportAuth.pm
14	463µs	line	Koha/Schema/Result/PatronListPatron.pm
13	460µs	line	Koha/Schema/Result/Discharge.pm
12	460µs	line	Koha/Schema/Result/ColumnsSetting.pm
12	458µs	line	Koha/Schema/Result/SocialData.pm
14	457µs	line	Koha/Schema/Result/TagsIndex.pm
12	456µs	line	Koha/Schema/Result/MiscFile.pm
12	454µs	line	Koha/Schema/Result/Zebraqueue.pm
13	453µs	line	Koha/Schema/Result/Userflag.pm
12	452µs	line	Koha/Schema/Result/ImportRecordMatch.pm
14	452µs	line	Koha/Schema/Result/Branchcategory.pm
14	451µs	line	Koha/Schema/Result/CourseInstructor.pm
13	447µs	line	Koha/Schema/Result/CategoriesBranch.pm
12	446µs	line	Koha/Schema/Result/RepeatableHoliday.pm
14	446µs	line	Koha/Schema/Result/BranchItemRule.pm
13	446µs	line	Koha/Schema/Result/BorrowerAttribute.pm
12	446µs	line	Koha/Schema/Result/SpecialHoliday.pm
14	445µs	line	Koha/Schema/Result/Aqbasketuser.pm
14	444µs	line	Koha/Schema/Result/AqorderUser.pm
12	444µs	line	Koha/Schema/Result/DefaultCircRule.pm
13	443µs	line	Koha/Schema/Result/DefaultBranchItemRule.pm
12	443µs	line	Koha/Schema/Result/ServicesThrottle.pm
12	443µs	line	Koha/Schema/Result/ExportFormat.pm
13	439µs	line	Koha/Schema/Result/CreatorImage.pm
14	438µs	line	Koha/Schema/Result/OpacNews.pm
12	437µs	line	Koha/Schema/Result/LanguageDescription.pm
12	436µs	line	Koha/Schema/Result/Alert.pm
12	435µs	line	Koha/Schema/Result/MatchpointComponentNorm.pm
14	434µs	line	Koha/Schema/Result/AuthorisedValuesBranch.pm
12	431µs	line	Koha/Schema/Result/Message.pm
15	429µs	line	Class/XSAccessor/Heavy.pm
12	428µs	line	Koha/Schema/Result/NeedMergeAuthority.pm
12	423µs	line	Koha/Schema/Result/Session.pm
15	423µs	line	Koha/Schema/Result/CourseReserve.pm
12	421µs	line	Koha/Schema/Result/AudioAlert.pm
12	407µs	line	Koha/Schema/Result/Printer.pm
13	407µs	line	Koha/Schema/Result/OaiSetsBiblio.pm
13	407µs	line	Koha/Schema/Result/DefaultBorrowerCircRule.pm
12	403µs	line	Koha/Schema/Result/Linktracker.pm
11	401µs	line	Koha/Schema/Result/LanguageScriptBidi.pm
12	393µs	line	Koha/Schema/Result/CollectionsTracking.pm
14	390µs	line	Koha/Schema/Result/Rating.pm
187	842µs	line	Devel/GlobalDestruction.pm (including 1 string eval)
12	378µs	line	DBIx/Class/Exception.pm
11	375µs	line	Koha/Schema/Result/Browser.pm
10	373µs	line	Koha/Schema/Result/ActionLogs.pm
12	368µs	line	Koha/Schema/Result/OaiSetsDescription.pm
12	364µs	line	Koha/Schema/Result/ImportBiblio.pm
12	364µs	line	Koha/Schema/Result/Tag.pm
12	350µs	line	Koha/Schema/Result/PluginData.pm
12	348µs	line	Koha/Schema/Result/SavedSql.pm
7	344µs	line	DBIx/Class/Cursor.pm
14	343µs	line	Koha/Schema/Result/BorrowerMessageTransportPreference.pm
15	333µs	line	Koha/Schema/Result/ItemsLastBorrower.pm
12	328µs	line	Koha/Schema/Result/City.pm
85	1.35ms	line	CGI.pm (including 5 string evals)
14	322µs	line	Koha/Schema/Result/Aqbudgetborrower.pm
12	313µs	line	Koha/Schema/Result/ItemCirculationAlertPreference.pm
13	310µs	line	Koha/Schema/Result/ClassSortRule.pm
11	303µs	line	Koha/Schema/Result/Stopword.pm
12	302µs	line	Koha/Schema/Result/BiblioFramework.pm
13	278µs	line	Koha/Schema/Result/BorrowerSync.pm
8	223µs	line	DBIx/Class/Relationship.pm
13	220µs	line	Koha/Schema/Result/BorrowerAttributeTypesBranch.pm
7	201µs	line	DBIx/Class/PK/Auto.pm
8	185µs	line	DBIx/Class/Relationship/Helpers.pm
8	169µs	line	Moo/sification.pm
12	164µs	line	Koha/Schema/Result/Quote.pm
12	111µs	line	Koha/Schema/Result/ActionLog.pm
2	92µs	line	Config.pm
15	81µs	line	DBI/Const/GetInfo/ANSI.pm
5	66µs	line	DBIx/Class/StartupCheck.pm
12	61µs	line	Koha/Schema/Result/SearchHistory.pm
5	51µs	line	Moo/_mro.pm
1	4µs	line	Module/Runtime.pm
1	3µs	line	Config_git.pl
0	0s	line	(eval 161)[Text/MicroTemplate.pm:389]
0	0s	line	Text/MicroTemplate.pm
0	0s	line	(eval 162)[Apache/LogFormat/Compiler.pm:151]
0	0s	line	IO/Socket.pm
0	0s	line	Plack/App/URLMap.pm
0	0s	line	namespace/clean.pm
0	0s	line	B/Hooks/EndOfScope/XS.pm
0	0s	line	File/Spec/Unix.pm
0	0s	line	XML/Parser/Expat.pm
0	0s	line	XML/Parser.pm
0	0s	line	CGI/Emulate/PSGI.pm
11	41µs	line	/unknown-eval-invoker (including 1 string eval)
1941511	5.37s	Total (-41 statements are unaccounted for)
6884	19.1ms	Average
	586µs	Median
	0.00018	Deviation