graphblog.test
cluster_L
L
File: graphblog.test
Type: cpu
Time: Jul 23, 2017 at 1:21pm (BST)
Duration: 28.171529206s
27.73s of 28.66s total (96.76%)
Dropped 77 nodes (cum <= 0.14s)
Dropped 3 edges (freq <= 0.03s)
N1
runtime.mapaccess1_fast32
5.30s(18.49%)
of 6.39s(22.30%)
N9
runtime.aeshash32
1.25s(4.36%)
N1->N9
1.09s
N2
runtime.mapiternext
4.43s(15.46%)
of 4.51s(15.74%)
N67
runtime.writebarrierptr
0 of 0.16s(0.56%)
N2->N67
0.06s
N3
runtime.mach_semaphore_wait
3.29s(11.48%)
N4
runtime.mapassign
2.47s(8.62%)
of 3.01s(10.50%)
N4->N9
0.14s
N16
runtime.typedmemmove
0.21s(0.73%)
of 0.33s(1.15%)
N4->N16
0.33s
N20
runtime.newobject
0.11s(0.38%)
of 3.73s(13.01%)
N4->N20
0.06s
N5
runtime.mach_semaphore_signal
2.21s(7.71%)
N6
runtime.mallocgc
1.44s(5.02%)
of 4.49s(15.67%)
N10
runtime.heapBitsSetType
0.98s(3.42%)
N6->N10
0.98s
N21
runtime.systemstack
0.03s(0.1%)
of 7.14s(24.91%)
N6->N21
0.24s
N34
runtime.(*mcache).nextFree
0 of 0.62s(2.16%)
N6->N34
0.62s
N41
runtime.gcStart
0 of 1.13s(3.94%)
N6->N41
1.13s
N7
github.com/philpearl/graphblog.nodes.longestShortestPath
1.43s(4.99%)
of 22.29s(77.77%)
N7->N1
6.39s
N7->N2
2.65s
N7->N4
3s
N8
runtime.mapiterinit
1.38s(4.82%)
of 3.44s(12.00%)
N7->N8
3.44s
N11
container/list.(*List).PushBack
0.69s(2.41%)
of 4.41s(15.39%)
N7->N11
4.41s
N49
runtime.makemap
0 of 0.87s(3.04%)
N7->N49
0.87s
N8->N2
1.86s
N18
runtime.fastrand
0.17s(0.59%)
N8->N18
0.17s
N8->N67
0.03s
N11->N20
3.67s
N11->N67
0.05s
N12
runtime.mach_semaphore_timedwait
0.67s(2.34%)
N13
runtime.memclrNoHeapPointers
0.49s(1.71%)
N14
runtime.memmove
0.39s(1.36%)
N15
runtime.scanobject
0.33s(1.15%)
of 0.64s(2.23%)
N17
runtime.greyobject
0.18s(0.63%)
of 0.19s(0.66%)
N15->N17
0.18s
N19
runtime.heapBitsForObject
0.16s(0.56%)
N15->N19
0.13s
N16->N14
0.12s
N20->N6
3.62s
N35
runtime.(*mcache).nextFree.func1
0 of 0.44s(1.54%)
N21->N35
0.44s
N37
runtime.(*mheap).alloc.func1
0 of 0.16s(0.56%)
N21->N37
0.16s
N39
runtime.gcBgMarkWorker.func2
0 of 0.92s(3.21%)
N21->N39
0.92s
N50
runtime.mallocgc.func1
0 of 0.23s(0.8%)
N21->N50
0.23s
N60
runtime.semasleep.func1
0 of 3.96s(13.82%)
N21->N60
3.96s
N63
runtime.startTheWorldWithSema
0 of 1.13s(3.94%)
N21->N63
1.13s
N22
runtime.writebarrierptr_prewrite1
0.03s(0.1%)
of 0.16s(0.56%)
N22->N21
0.13s
N23
runtime.findrunnable
0.02s(0.07%)
of 3.39s(11.83%)
N65
runtime.stopm
0 of 3.34s(11.65%)
N23->N65
3.32s
N24
runtime.(*mcentral).cacheSpan
0.01s(0.035%)
of 0.44s(1.54%)
N25
runtime.(*mcentral).grow
0.01s(0.035%)
of 0.39s(1.36%)
N24->N25
0.39s
N26
runtime.(*mheap).alloc
0.01s(0.035%)
of 0.49s(1.71%)
N25->N26
0.28s
N26->N13
0.48s
N27
runtime.(*mheap).alloc_m
0.01s(0.035%)
of 0.16s(0.56%)
N28
runtime.gcDrain
0.01s(0.035%)
of 0.94s(3.28%)
N28->N15
0.64s
N33
runtime.(*gcWork).balance
0 of 0.27s(0.94%)
N28->N33
0.27s
N29
runtime.mcall
0.01s(0.035%)
of 3.67s(12.81%)
N56
runtime.park_m
0 of 3.65s(12.74%)
N29->N56
3.65s
N30
runtime.semasleep
0.01s(0.035%)
of 3.30s(11.51%)
N30->N21
3.29s
N31
github.com/philpearl/graphblog.BenchmarkDiameter.func1
0 of 22.30s(77.81%)
N32
github.com/philpearl/graphblog.nodes.diameter
0 of 22.29s(77.77%)
N31->N32
22.29s
N32->N7
22.29s
N46
runtime.handoff
0 of 0.27s(0.94%)
N33->N46
0.27s
N34->N21
0.59s
N36
runtime.(*mcache).refill
0 of 0.44s(1.54%)
N35->N36
0.44s
N36->N24
0.44s
N37->N27
0.16s
N38
runtime.gcBgMarkWorker
0 of 1.71s(5.97%)
N38->N21
0.94s
N40
runtime.gcMarkDone
0 of 0.70s(2.44%)
N38->N40
0.69s
N39->N28
0.92s
N40->N21
0.67s
N41->N21
1.13s
N42
runtime.gcstopm
0 of 0.36s(1.26%)
N55
runtime.notewakeup
0 of 2.21s(7.71%)
N42->N55
0.34s
N43
runtime.goexit
0 of 24.05s(83.91%)
N43->N38
1.71s
N68
testing.(*B).run1.func1
0 of 22.31s(77.84%)
N43->N68
22.31s
N44
runtime.gopreempt_m
0 of 0.83s(2.90%)
N45
runtime.goschedImpl
0 of 0.84s(2.93%)
N44->N45
0.83s
N59
runtime.schedule
0 of 4.48s(15.63%)
N45->N59
0.83s
N46->N14
0.27s
N47
runtime.largeAlloc
0 of 0.23s(0.8%)
N47->N26
0.21s
N48
runtime.mach_semrelease
0 of 2.21s(7.71%)
N48->N5
2.21s
N52
runtime.newarray
0 of 0.87s(3.04%)
N49->N52
0.87s
N50->N47
0.23s
N51
runtime.morestack
0 of 0.89s(3.11%)
N53
runtime.newstack
0 of 0.89s(3.11%)
N51->N53
0.89s
N52->N6
0.87s
N53->N44
0.83s
N54
runtime.notesleep
0 of 3.30s(11.51%)
N54->N30
3.30s
N62
runtime.semawakeup
0 of 2.21s(7.71%)
N55->N62
2.21s
N56->N59
3.65s
N57
runtime.resetspinning
0 of 0.24s(0.84%)
N66
runtime.wakep
0 of 1.37s(4.78%)
N57->N66
0.24s
N58
runtime.runSafePointFn
0 of 0.49s(1.71%)
N58->N55
0.47s
N59->N23
3.39s
N59->N42
0.36s
N59->N57
0.24s
N59->N58
0.49s
N61
runtime.semasleep1
0 of 3.96s(13.82%)
N60->N61
3.96s
N61->N3
3.29s
N61->N12
0.67s
N62->N48
2.21s
N63->N66
1.13s
N64
runtime.startm
0 of 1.37s(4.78%)
N64->N55
1.37s
N65->N54
3.30s
N66->N64
1.37s
N67->N22
0.16s
N69
testing.(*B).runN
0 of 22.31s(77.84%)
N68->N69
22.31s
N69->N31
22.30s