C:\dev\ETSGO\etsgo>c:\Gotip\go\bin\go run main.go
gc 1 @0.130s 0%: 0+0+1.0 ms clock, 0+0/0/0+4.0 ms cpu, 4->4->0 MB, 5 MB goal, 4 P
gc 2 @0.164s 0%: 0+1.0+0 ms clock, 0+0/1.0/3.0+0 ms cpu, 4->4->0 MB, 5 MB goal, 4 P
gc 3 @0.202s 0%: 0+0.49+0.50 ms clock, 0+0/0/1.4+2.0 ms cpu, 4->4->0 MB, 5 MB goal, 4 P
gc 4 @0.245s 1%: 0+1.0+1.0 ms clock, 0+0/1.0/0+3.0 ms cpu, 4->4->1 MB, 5 MB goal, 4 P
# text/tabwriter
gc 1 @0.039s 6%: 0.50+9.0+1.5 ms clock, 1.5+5.5/1.5/3.5+4.5 ms cpu, 4->4->2 MB, 5 MB goal, 4 P
gc 2 @0.056s 9%: 0+13+2.0 ms clock, 0+6.0/1.0/1.0+8.0 ms cpu, 4->5->3 MB, 5 MB goal, 4 P
gc 3 @0.080s 11%: 0+14+2.0 ms clock, 0+0/9.0/0+8.0 ms cpu, 5->6->4 MB, 6 MB goal, 4 P
# database/sql/driver
gc 1 @0.043s 5%: 1.0+8.5+1.5 ms clock, 2.0+3.0/3.0/1.0+3.0 ms cpu, 4->4->2 MB, 5 MB goal, 4 P
gc 2 @0.061s 8%: 0+12+2.0 ms clock, 0+5.0/2.0/1.0+8.0 ms cpu, 4->5->3 MB, 5 MB goal, 4 P
gc 3 @0.087s 10%: 0+12+2.0 ms clock, 0+0/9.0/1.0+8.0 ms cpu, 6->6->4 MB, 7 MB goal, 4 P
gc 4 @0.115s 13%: 0+15+2.0 ms clock, 0+13/6.0/6.0+8.0 ms cpu, 8->8->5 MB, 9 MB goal, 4 P
# net/url
gc 1 @0.046s 3%: 0.50+8.5+2.0 ms clock, 1.0+0/4.0/4.5+4.0 ms cpu, 4->4->2 MB, 5 MB goal, 4 P
gc 2 @0.066s 8%: 0+10+2.0 ms clock, 0+4.0/4.0/0+8.0 ms cpu, 4->5->3 MB, 5 MB goal, 4 P
gc 3 @0.089s 11%: 0+13+2.0 ms clock, 0+11/3.0/4.0+8.0 ms cpu, 6->6->4 MB, 7 MB goal, 4 P
gc 4 @0.119s 14%: 0+15+5.0 ms clock, 0+3.0/12/7.0+20 ms cpu, 8->9->6 MB, 9 MB goal, 4 P
# runtime/pprof
gc 1 @0.039s 9%: 4.0+7.5+2.5 ms clock, 8.0+0/6.5/0+5.0 ms cpu, 4->4->2 MB, 5 MB goal, 4 P
gc 2 @0.069s 13%: 0+9.0+4.5 ms clock, 0+0/7.5/2.0+18 ms cpu, 4->4->3 MB, 5 MB goal, 4 P
gc 3 @0.098s 14%: 0+13+3.0 ms clock, 0+2.5/5.0/5.5+12 ms cpu, 7->8->6 MB, 8 MB goal, 4 P
gc 4 @0.136s 18%: 0+15+10 ms clock, 0+8.0/8.5/6.5+42 ms cpu, 10->11->8 MB, 11 MB goal, 4 P
gc 5 @0.208s 16%: 0+21+2.0 ms clock, 0+8.5/13/0.50+8.0 ms cpu, 15->15->10 MB, 16 MB goal, 4 P
# database/sql
gc 1 @0.043s 6%: 1.0+9.5+2.5 ms clock, 2.0+4.0/3.0/0+5.0 ms cpu, 4->4->3 MB, 5 MB goal, 4 P
gc 2 @0.065s 9%: 0+8.0+1.5 ms clock, 0+4.0/5.0/1.0+6.0 ms cpu, 5->5->4 MB, 6 MB goal, 4 P
gc 3 @0.095s 10%: 0+5.5+1.0 ms clock, 0+4.5/5.0/5.5+4.0 ms cpu, 7->7->5 MB, 8 MB goal, 4 P
gc 4 @0.126s 14%: 0+12+7.5 ms clock, 0+2.0/9.0/10+30 ms cpu, 11->11->8 MB, 12 MB goal, 4 P
gc 5 @0.181s 13%: 0+26+1.0 ms clock, 0+9.0/15/0+4.0 ms cpu, 16->17->12 MB, 17 MB goal, 4 P
gc 6 @0.253s 13%: 0+19+1.5 ms clock, 0+15/15/17+6.0 ms cpu, 22->22->15 MB, 23 MB goal, 4 P
gc 5 @0.912s 0%: 0+1.0+0 ms clock, 0+0/1.0/0+0 ms cpu, 4->4->1 MB, 5 MB goal, 4 P
gc 6 @2.067s 0%: 0+3.0+0 ms clock, 0+1.0/2.0/1.0+0 ms cpu, 4->4->1 MB, 5 MB goal, 4 P
# github.com/mattn/go-sqlite3
gc 1 @0.173s 0%: 0+1.0+0 ms clock, 0+0/1.0/1.0+0 ms cpu, 4->4->0 MB, 5 MB goal, 4 P
gc 2 @0.480s 0%: 0+1.0+1.0 ms clock, 0+0/0/2.0+4.0 ms cpu, 4->4->0 MB, 5 MB goal, 4 P
gc 3 @0.761s 0%: 0+2.0+1.0 ms clock, 0+0/0/3.0+3.0 ms cpu, 4->4->0 MB, 5 MB goal, 4 P
gc 7 @3.777s 0%: 0+1.0+0 ms clock, 0+0/1.0/3.0+0 ms cpu, 4->4->1 MB, 5 MB goal, 4 P
# github.com/mattn/go-sqlite3
gc 1 @0.015s 7%: 1.0+2.0+1.0 ms clock, 2.0+0/2.0/4.0+2.0 ms cpu, 4->4->2 MB, 5 MB goal, 4 P
gc 2 @0.026s 11%: 0+3.5+0.50 ms clock, 0+2.5/3.5/3.0+2.0 ms cpu, 4->4->3 MB, 5 MB goal, 4 P
gc 3 @0.039s 14%: 0+4.0+1.0 ms clock, 0+4.0/4.0/4.0+4.0 ms cpu, 6->6->5 MB, 7 MB goal, 4 P
gc 4 @0.060s 15%: 0+6.0+1.0 ms clock, 0+5.0/6.0/6.0+4.0 ms cpu, 9->10->7 MB, 10 MB goal, 4 P
gc 5 @0.092s 12%: 0+8.0+1.0 ms clock, 0+0/7.0/22+4.0 ms cpu, 14->15->9 MB, 15 MB goal, 4 P
gc 6 @0.125s 14%: 0+10+1.4 ms clock, 0+10/10/19+5.6 ms cpu, 19->19->12 MB, 20 MB goal, 4 P
gc 7 @0.174s 13%: 0+12+1.0 ms clock, 0+11/12/17+4.0 ms cpu, 25->25->17 MB, 26 MB goal, 4 P
gc 8 @0.235s 13%: 0+16+2.0 ms clock, 0+8.0/16/32+8.0 ms cpu, 34->34->24 MB, 35 MB goal, 4 P
# command-line-arguments
gc 1 @0.015s 8%: 1.0+5.0+1.0 ms clock, 2.0+1.0/3.0/4.0+2.0 ms cpu, 4->4->2 MB, 5 MB goal, 4 P
gc 2 @0.028s 11%: 0+4.0+1.0 ms clock, 0+0/3.0/6.0+4.0 ms cpu, 5->5->4 MB, 6 MB goal, 4 P
gc 3 @0.045s 14%: 0+5.0+1.0 ms clock, 0+5.0/5.0/5.0+4.0 ms cpu, 8->8->6 MB, 9 MB goal, 4 P
# command-line-arguments
gc 1 @0.020s 3%: 0.50+8.5+0 ms clock, 1.0+1.5/1.0/2.0+0 ms cpu, 4->5->3 MB, 5 MB goal, 4 P
gc 2 @0.032s 7%: 0+4.0+1.0 ms clock, 0+2.0/2.0/6.0+4.0 ms cpu, 5->5->4 MB, 6 MB goal, 4 P
gc 3 @0.053s 9%: 0+5.0+1.0 ms clock, 0+3.0/4.0/8.0+4.0 ms cpu, 8->8->7 MB, 9 MB goal, 4 P
gc 4 @0.082s 10%: 0+6.9+1.0 ms clock, 0+4.9/4.9/11+4.0 ms cpu, 13->13->11 MB, 14 MB goal, 4 P
gc 5 @0.125s 10%: 0+13+1.0 ms clock, 0+7.0/11/16+4.0 ms cpu, 21->22->19 MB, 22 MB goal, 4 P
gc 6 @0.219s 9%: 0+21+1.0 ms clock, 0+10/21/29+4.3 ms cpu, 36->38->31 MB, 38 MB goal, 4 P
gc 1 @0.046s 2%: 1.2+1.7+1.1 ms clock, 2.4+0/0/1.7+2.2 ms cpu, 4->4->2 MB, 5 MB goal, 4 P
gc 2 @0.068s 2%: 0+5.0+0 ms clock, 0+2.0/0/0+0 ms cpu, 4->4->2 MB, 5 MB goal, 4 P
gc 3 @0.084s 3%: 0+13+0.98 ms clock, 0+3.5/1.5/2.5+3.9 ms cpu, 5->7->6 MB, 6 MB goal, 4 P
gc 4 @0.120s 4%: 0+3.9+2.2 ms clock, 0+0/0/3.9+8.8 ms cpu, 7->7->4 MB, 9 MB goal, 4 P
gc 5 @0.163s 4%: 0+8.0+0 ms clock, 0+4.0/4.0/8.0+0 ms cpu, 10->10->9 MB, 11 MB goal, 4 P
gc 6 @0.177s 6%: 0+9.0+0.50 ms clock, 0+1.4/9.0/0+2.0 ms cpu, 13->13->13 MB, 18 MB goal, 4 P
gc 7 @0.302s 5%: 0+15+1.0 ms clock, 0+8.0/8.0/14+4.0 ms cpu, 27->27->18 MB, 28 MB goal, 4 P
gc 8 @0.414s 5%: 0+20+1.0 ms clock, 0+0/20/0+4.0 ms cpu, 29->30->18 MB, 37 MB goal, 4 P
gc 9 @0.612s 5%: 0+33+1.0 ms clock, 0+33/16/17+4.0 ms cpu, 43->43->37 MB, 44 MB goal, 4 P
gc 10 @0.649s 7%: 0+35+0.50 ms clock, 0+16/35/19+2.0 ms cpu, 53->53->53 MB, 75 MB goal, 4 P
gc 11 @1.270s 5%: 0+73+1.0 ms clock, 0+73/36/38+4.0 ms cpu, 109->109->75 MB, 110 MB goal, 4 P
gc 12 @1.351s 7%: 0+147+0.50 ms clock, 0+44/103/43+2.0 ms cpu, 106->107->106 MB, 150 MB goal, 4 P
gc 13 @2.500s 6%: 0+121+0 ms clock, 0+121/63/58+0 ms cpu, 218->218->150 MB, 219 MB goal, 4 P
gc 14 @2.675s 7%: 0+240+0.52 ms clock, 0+0/189/57+2.1 ms cpu, 213->216->212 MB, 301 MB goal, 4 P
gc 15 @4.855s 6%: 0+307+0.33 ms clock, 0+307/189/118+1.3 ms cpu, 434->434->300 MB, 435 MB goal, 4 P
Ready. 
Loaded 1002662 serials
gc 16 @6.000s 5%: 0+459+0.50 ms clock, 0+0/206/259+2.0 ms cpu, 453->456->285 MB, 601 MB goal, 4 P
gc 17 @6.461s 9%: 23+0+269 ms clock, 69+0/206/259+809 ms cpu, 285->285->283 MB, 285 MB goal, 4 P (forced)
GC took 396.077ms
gc 18 @38.937s 1%: 1.0+447+2.0 ms clock, 4.0+0/232/221+8.0 ms cpu, 494->496->284 MB, 566 MB goal, 4 P