>>> bench-local

*** neotest: node
date:	Thu, 08 Mar 2018 14:27:03 +0200
xnode:	neotest@z6001.ivan.nexedi.com (2401:5180:0:6f::1 192.168.0.16)
uname:	Linux z6001-COMP-2784 4.13.0-36-generic #40-Ubuntu SMP Fri Feb 16 20:07:48 UTC 2018 x86_64 x86_64 x86_64 GNU/Linux
cpu:	Intel(R) Xeon(R) CPU           X5650  @ 2.67GHz
cpu/[0-23]/freq: acpi-cpufreq/performance [2.66GHz - 2.66GHz]
cpu/[0-23]/idle: intel_idle/menu: POLL·0/0 C1·3/6 C1E·10/20 C3·20/80 C6·200/800 # elat/tres µs
WARNING: cpu: C-state exit-latency is max 200μs - up to that can add to networked and IPC request-reply latency
disk/sda: ADATA SU800       rev 8BS  119,2G
nic/enp1s0: Broadcom Limited NetXtreme BCM5764M Gigabit Ethernet PCIe rev 10
nic/enp1s0/features: rx tx sg tso !ufo gso gro !lro rxvlan txvlan !ntuple !rxhash ...
nic/enp1s0/coalesce: rxc: 20μs/5f/0μs-irq/5f-irq,  txc: 72μs/53f/0μs-irq/5f-irq
nic/enp1s0/status:   up, speed=1000, mtu=1500, txqlen=1000, gro_flush_timeout=0.000µs
WARNING: nic/enp1s0: RX coalesce latency is max 20μs - that will add to networked request-reply latency
sw/python:          Python 2.7.12
sw/go:              go version go1.10 linux/amd64
sw/sqlite:          sqlite 3.22.0 (py mod 2.6.0)
sw/mysqld:          mysqld  Ver 10.1.25-MariaDB-1 for debian-linux-gnu on x86_64 (Ubuntu 17.10)
sw/neo:             v1.8-1607-gca0d828-dirty
sw/zodb:            5.3.0
sw/zeo:             5.1.1
sw/mysqlclient:     1.3.12
sw/wendelin.core:   0.11

*** cpu:

node:	z6001
cluster:
Benchmarkpystone 1 114808 pystone/s	# POLL·2 C1·76 C1E·0 C3·19 C6·413
Benchmarkpystone 1 114083 pystone/s	# POLL·0 C1·46 C1E·1 C3·18 C6·371
Benchmarkpystone 1 113317 pystone/s	# POLL·0 C1·89 C1E·1 C3·15 C6·345
Benchmarkpystone 1 114699 pystone/s	# POLL·2 C1·109 C1E·3 C3·18 C6·391
Benchmarkpystone 1 113506 pystone/s	# POLL·1 C1·81 C1E·1 C3·17 C6·372
Benchmarkcrc32/py/4K 198369	5.080 µs/op	# POLL·0 C1·78 C1E·3 C3·7 C6·537
Benchmarkcrc32/py/4K 197752	5.112 µs/op	# POLL·2 C1·67 C1E·1 C3·16 C6·416
Benchmarkcrc32/py/4K 197287	5.107 µs/op	# POLL·0 C1·101 C1E·0 C3·9 C6·442
Benchmarkcrc32/py/4K 197890	5.103 µs/op	# POLL·0 C1·91 C1E·1 C3·15 C6·477
Benchmarkcrc32/py/4K 197808	5.108 µs/op	# POLL·0 C1·96 C1E·2 C3·17 C6·461
Benchmarkcrc32/go/4K 1000000	1.763 µs/op	# POLL·0 C1·178 C1E·128 C3·103 C6·908
Benchmarkcrc32/go/4K 1000000	1.723 µs/op	# POLL·4 C1·214 C1E·120 C3·82 C6·879
Benchmarkcrc32/go/4K 1000000	1.723 µs/op	# POLL·0 C1·149 C1E·151 C3·104 C6·905
Benchmarkcrc32/go/4K 1000000	1.900 µs/op	# POLL·5 C1·195 C1E·117 C3·88 C6·912
Benchmarkcrc32/go/4K 1000000	1.722 µs/op	# POLL·4 C1·153 C1E·132 C3·90 C6·877
Benchmarksha1/py/4K 116970	14.618 µs/op	# POLL·0 C1·86 C1E·0 C3·13 C6·477
Benchmarksha1/py/4K 116972	14.616 µs/op	# POLL·1 C1·79 C1E·2 C3·14 C6·492
Benchmarksha1/py/4K 117103	14.580 µs/op	# POLL·0 C1·77 C1E·1 C3·8 C6·533
Benchmarksha1/py/4K 116931	20.973 µs/op	# POLL·0 C1·86 C1E·1 C3·20 C6·498
Benchmarksha1/py/4K 116972	14.624 µs/op	# POLL·1 C1·74 C1E·2 C3·8 C6·556
Benchmarksha1/go/4K 200000	10.324 µs/op	# POLL·1 C1·180 C1E·145 C3·58 C6·1104
Benchmarksha1/go/4K 200000	10.324 µs/op	# POLL·3 C1·134 C1E·151 C3·75 C6·993
Benchmarksha1/go/4K 200000	10.479 µs/op	# POLL·1 C1·158 C1E·133 C3·93 C6·1133
Benchmarksha1/go/4K 200000	10.324 µs/op	# POLL·0 C1·203 C1E·148 C3·106 C6·1028
Benchmarksha1/go/4K 200000	10.323 µs/op	# POLL·0 C1·142 C1E·115 C3·85 C6·1000
Benchmarkunzlib/py/wczdata 32988	36.684 µs/op	# POLL·0 C1·81 C1E·6 C3·18 C6·594
Benchmarkunzlib/py/wczdata 33259	36.024 µs/op	# POLL·2 C1·73 C1E·1 C3·23 C6·430
Benchmarkunzlib/py/wczdata 33107	36.425 µs/op	# POLL·4 C1·104 C1E·2 C3·13 C6·614
Benchmarkunzlib/py/wczdata 33021	36.658 µs/op	# POLL·0 C1·76 C1E·0 C3·12 C6·536
Benchmarkunzlib/py/wczdata 33365	35.969 µs/op	# POLL·2 C1·104 C1E·4 C3·11 C6·502
Benchmarkunzlib/go/wczdata 50000	31.556 µs/op	# POLL·2 C1·322 C1E·501 C3·158 C6·4004
Benchmarkunzlib/go/wczdata 50000	31.486 µs/op	# POLL·0 C1·372 C1E·516 C3·115 C6·4090
Benchmarkunzlib/go/wczdata 50000	31.454 µs/op	# POLL·3 C1·255 C1E·727 C3·140 C6·4226
Benchmarkunzlib/go/wczdata 50000	31.509 µs/op	# POLL·6 C1·369 C1E·361 C3·111 C6·4001
Benchmarkunzlib/go/wczdata 50000	31.372 µs/op	# POLL·2 C1·299 C1E·530 C3·117 C6·4149
Benchmarkunzlib/py/prod1-avg 103719	18.587 µs/op	# POLL·0 C1·73 C1E·1 C3·25 C6·612
Benchmarkunzlib/py/prod1-avg 104425	18.185 µs/op	# POLL·0 C1·68 C1E·3 C3·15 C6·727
Benchmarkunzlib/py/prod1-avg 105130	17.986 µs/op	# POLL·3 C1·89 C1E·1 C3·14 C6·579
Benchmarkunzlib/py/prod1-avg 104581	18.920 µs/op	# POLL·3 C1·93 C1E·0 C3·5 C6·521
Benchmarkunzlib/py/prod1-avg 103474	18.529 µs/op	# POLL·0 C1·73 C1E·1 C3·14 C6·442
Benchmarkunzlib/go/prod1-avg 200000	9.954 µs/op	# POLL·2 C1·335 C1E·360 C3·123 C6·4263
Benchmarkunzlib/go/prod1-avg 200000	10.096 µs/op	# POLL·6 C1·277 C1E·499 C3·128 C6·4311
Benchmarkunzlib/go/prod1-avg 200000	9.912 µs/op	# POLL·3 C1·2099 C1E·397 C3·184 C6·3669
Benchmarkunzlib/go/prod1-avg 200000	10.042 µs/op	# POLL·1 C1·368 C1E·484 C3·112 C6·4214
Benchmarkunzlib/go/prod1-avg 200000	9.877 µs/op	# POLL·5 C1·479 C1E·594 C3·140 C6·4188
node:	z6001
cluster:

*** disk: random direct (no kernel cache) 4K-read latency

--- . (ext4 /dev/sda1) ioping statistics ---
15.5 k requests completed in 2.93 s, 60.7 MiB read, 5.29 k iops, 20.7 MiB/s
generated 15.5 k requests in 3.00 s, 60.7 MiB, 5.18 k iops, 20.2 MiB/s
min/avg/max/mdev = 126.0 us / 188.9 us / 322.6 us / 40.9 us
Benchmarkdisk/randread/direct/4K-min 1 126.0 us/op
Benchmarkdisk/randread/direct/4K-avg 1 188.9 us/op
< 126.0 us	0	| 
< 133.2 us	778	| **
< 140.4 us	1368	| ****
< 147.6 us	1246	| ****
< 154.7 us	298	| 
< 161.9 us	330	| *
< 169.1 us	954	| ***
< 176.3 us	3042	| *********
< 183.5 us	692	| **
< 190.7 us	145	| 
< 197.9 us	22	| 
< 205.1 us	506	| *
< 212.3 us	646	| **
< 219.5 us	1162	| ***
< 226.7 us	1916	| ******
< 233.9 us	458	| *
< 241.1 us	249	| 
< 248.3 us	3	| 
< 255.5 us	33	| 
< 262.6 us	358	| *
< 269.8 us	634	| **
<       +∞	599	| *
# POLL·4 C1·3327 C1E·7073 C3·5167 C6·745

--- . (ext4 /dev/sda1) ioping statistics ---
13.9 k requests completed in 2.94 s, 54.1 MiB read, 4.71 k iops, 18.4 MiB/s
generated 13.9 k requests in 3.00 s, 54.1 MiB, 4.62 k iops, 18.0 MiB/s
min/avg/max/mdev = 140.2 us / 212.2 us / 331.7 us / 40.4 us
Benchmarkdisk/randread/direct/4K-min 1 140.2 us/op
Benchmarkdisk/randread/direct/4K-avg 1 212.2 us/op
< 146.7 us	7	| 
< 153.8 us	226	| 
< 160.9 us	1098	| ***
< 168.0 us	1515	| *****
< 175.2 us	227	| 
< 182.3 us	37	| 
< 189.4 us	640	| **
< 196.5 us	2960	| **********
< 203.6 us	822	| **
< 210.7 us	217	| 
< 217.8 us	42	| 
< 224.9 us	185	| 
< 232.0 us	772	| **
< 239.2 us	786	| **
< 246.3 us	1158	| ****
< 253.4 us	1219	| ****
< 260.5 us	220	| 
< 267.6 us	8	| 
< 274.7 us	78	| 
< 281.8 us	395	| *
< 288.9 us	593	| **
<       +∞	555	| **
# POLL·5 C1·1608 C1E·7099 C3·8852 C6·10668

--- . (ext4 /dev/sda1) ioping statistics ---
15.5 k requests completed in 2.93 s, 60.7 MiB read, 5.29 k iops, 20.7 MiB/s
generated 15.5 k requests in 3.00 s, 60.7 MiB, 5.18 k iops, 20.2 MiB/s
min/avg/max/mdev = 126.2 us / 188.9 us / 923.5 us / 41.4 us
Benchmarkdisk/randread/direct/4K-min 1 126.2 us/op
Benchmarkdisk/randread/direct/4K-avg 1 188.9 us/op
< 127.0 us	1	| 
< 134.2 us	892	| **
< 141.3 us	2055	| ******
< 148.4 us	401	| *
< 155.5 us	201	| 
< 162.6 us	562	| *
< 169.7 us	925	| **
< 176.8 us	3053	| *********
< 183.9 us	600	| *
< 191.1 us	100	| 
< 198.2 us	29	| 
< 205.3 us	524	| *
< 212.4 us	734	| **
< 219.5 us	1288	| ****
< 226.6 us	1804	| *****
< 233.7 us	429	| *
< 240.9 us	182	| 
< 248.0 us	2	| 
< 255.1 us	34	| 
< 262.2 us	363	| *
< 269.3 us	665	| **
<       +∞	588	| *
# POLL·4 C1·3849 C1E·6386 C3·4306 C6·1776

--- . (ext4 /dev/sda1) ioping statistics ---
13.9 k requests completed in 2.94 s, 54.3 MiB read, 4.73 k iops, 18.5 MiB/s
generated 13.9 k requests in 3.00 s, 54.3 MiB, 4.64 k iops, 18.1 MiB/s
min/avg/max/mdev = 137.3 us / 211.3 us / 371.1 us / 40.3 us
Benchmarkdisk/randread/direct/4K-min 1 137.3 us/op
Benchmarkdisk/randread/direct/4K-avg 1 211.3 us/op
< 147.0 us	12	| 
< 153.9 us	234	| 
< 160.9 us	962	| ***
< 167.8 us	1758	| ******
< 174.7 us	249	| 
< 181.6 us	21	| 
< 188.6 us	408	| *
< 195.5 us	2936	| **********
< 202.4 us	986	| ***
< 209.4 us	321	| *
< 216.3 us	50	| 
< 223.2 us	170	| 
< 230.2 us	652	| **
< 237.1 us	551	| *
< 244.0 us	766	| **
< 250.9 us	1863	| ******
< 257.9 us	321	| *
< 264.8 us	43	| 
< 271.7 us	21	| 
< 278.7 us	171	| 
< 285.6 us	501	| *
<       +∞	812	| **
# POLL·2 C1·1711 C1E·7536 C3·10969 C6·8345

--- . (ext4 /dev/sda1) ioping statistics ---
14.3 k requests completed in 2.95 s, 56.0 MiB read, 4.86 k iops, 19.0 MiB/s
generated 14.3 k requests in 3.00 s, 56.0 MiB, 4.78 k iops, 18.7 MiB/s
min/avg/max/mdev = 134.2 us / 205.6 us / 903.1 us / 41.0 us
Benchmarkdisk/randread/direct/4K-min 1 134.2 us/op
Benchmarkdisk/randread/direct/4K-avg 1 205.6 us/op
< 146.4 us	3	| 
< 155 us	1715	| *****
< 163.6 us	1612	| *****
< 172.2 us	363	| *
< 180.8 us	36	| 
< 189.4 us	1960	| ******
< 198.0 us	2274	| *******
< 206.6 us	517	| *
< 215.2 us	52	| 
< 223.8 us	121	| 
< 232.4 us	569	| *
< 241.0 us	1872	| ******
< 249.6 us	1691	| *****
< 258.2 us	281	| 
< 266.8 us	20	| 
< 275.4 us	72	| 
< 284.1 us	372	| *
< 292.7 us	518	| *
< 301.3 us	157	| 
< 309.9 us	10	| 
< 318.5 us	8	| 
<       +∞	3	| 
# POLL·2 C1·586 C1E·9021 C3·17101 C6·2664

*** disk: random cached 4K-read latency

--- . (ext4 /dev/sda1) ioping statistics ---
1.91 M requests completed in 2.84 s, 7.29 GiB read, 673.1 k iops, 2.57 GiB/s
generated 1.91 M requests in 3.00 s, 7.29 GiB, 636.6 k iops, 2.43 GiB/s
min/avg/max/mdev = 802 ns / 1.49 us / 96.4 us / 345 ns
Benchmarkdisk/randread/pagecache/4K-min 1 802 ns/op
Benchmarkdisk/randread/pagecache/4K-avg 1 1.49 us/op
< 1.27 us	170830	| ****
< 1.49 us	800667	| ********************
< 1.71 us	805871	| *********************
< 1.93 us	124465	| ***
< 2.14 us	6352	| 
< 2.36 us	677	| 
< 2.58 us	73	| 
< 2.80 us	8	| 
< 3.02 us	1	| 
< 3.24 us	1	| 
< 3.46 us	0	| 
< 3.68 us	0	| 
< 3.90 us	1	| 
< 4.12 us	0	| 
< 4.34 us	1	| 
< 4.55 us	0	| 
< 4.77 us	0	| 
< 4.99 us	0	| 
< 5.21 us	0	| 
< 5.43 us	0	| 
< 5.65 us	0	| 
<       +∞	716	| 
# POLL·1 C1·85 C1E·1 C3·19 C6·663

--- . (ext4 /dev/sda1) ioping statistics ---
2.08 M requests completed in 2.82 s, 7.93 GiB read, 736.8 k iops, 2.81 GiB/s
generated 2.08 M requests in 3.00 s, 7.93 GiB, 692.9 k iops, 2.64 GiB/s
min/avg/max/mdev = 810 ns / 1.36 us / 66.2 us / 263 ns
Benchmarkdisk/randread/pagecache/4K-min 1 810 ns/op
Benchmarkdisk/randread/pagecache/4K-avg 1 1.36 us/op
< 1.56 us	1905276	| *********************************************
< 1.60 us	60331	| *
< 1.64 us	41454	| 
< 1.68 us	24879	| 
< 1.72 us	17416	| 
< 1.76 us	11508	| 
< 1.80 us	7139	| 
< 1.84 us	4138	| 
< 1.88 us	2348	| 
< 1.92 us	1279	| 
< 1.96 us	794	| 
< 2.00 us	484	| 
< 2.04 us	273	| 
< 2.08 us	209	| 
< 2.12 us	125	| 
< 2.16 us	94	| 
< 2.20 us	69	| 
< 2.24 us	52	| 
< 2.28 us	25	| 
< 2.32 us	21	| 
< 2.36 us	13	| 
<       +∞	741	| 
# POLL·2 C1·76 C1E·2 C3·17 C6·641

--- . (ext4 /dev/sda1) ioping statistics ---
2.12 M requests completed in 2.84 s, 8.09 GiB read, 747.9 k iops, 2.85 GiB/s
generated 2.12 M requests in 3.00 s, 8.09 GiB, 707.1 k iops, 2.70 GiB/s
min/avg/max/mdev = 783 ns / 1.34 us / 95.2 us / 275 ns
Benchmarkdisk/randread/pagecache/4K-min 1 783 ns/op
Benchmarkdisk/randread/pagecache/4K-avg 1 1.34 us/op
< 1.43 us	1584260	| *************************************
< 1.47 us	167444	| ***
< 1.52 us	151502	| ***
< 1.57 us	83655	| *
< 1.61 us	54316	| *
< 1.66 us	31449	| 
< 1.71 us	20579	| 
< 1.75 us	12081	| 
< 1.80 us	6878	| 
< 1.85 us	3747	| 
< 1.89 us	1874	| 
< 1.94 us	1026	| 
< 1.99 us	559	| 
< 2.03 us	341	| 
< 2.08 us	208	| 
< 2.13 us	164	| 
< 2.17 us	90	| 
< 2.22 us	75	| 
< 2.27 us	44	| 
< 2.31 us	20	| 
< 2.36 us	20	| 
<       +∞	762	| 
# POLL·0 C1·116 C1E·2 C3·16 C6·737

--- . (ext4 /dev/sda1) ioping statistics ---
2.12 M requests completed in 2.82 s, 8.10 GiB read, 751.6 k iops, 2.87 GiB/s
generated 2.12 M requests in 3.00 s, 8.10 GiB, 707.6 k iops, 2.70 GiB/s
min/avg/max/mdev = 785 ns / 1.33 us / 39.4 us / 259 ns
Benchmarkdisk/randread/pagecache/4K-min 1 785 ns/op
Benchmarkdisk/randread/pagecache/4K-avg 1 1.33 us/op
< 1.17 us	162849	| ***
< 1.38 us	1270641	| *****************************
< 1.59 us	590773	| *************
< 1.79 us	90057	| **
< 2.00 us	6778	| 
< 2.21 us	642	| 
< 2.42 us	97	| 
< 2.63 us	18	| 
< 2.84 us	5	| 
< 3.05 us	2	| 
< 3.26 us	1	| 
< 3.47 us	1	| 
< 3.68 us	0	| 
< 3.89 us	0	| 
< 4.10 us	0	| 
< 4.31 us	0	| 
< 4.51 us	0	| 
< 4.72 us	0	| 
< 4.93 us	0	| 
< 5.14 us	0	| 
< 5.35 us	0	| 
<       +∞	706	| 
# POLL·0 C1·83 C1E·2 C3·13 C6·769

--- . (ext4 /dev/sda1) ioping statistics ---
1.93 M requests completed in 2.84 s, 7.36 GiB read, 679.6 k iops, 2.59 GiB/s
generated 1.93 M requests in 3.00 s, 7.36 GiB, 643.4 k iops, 2.45 GiB/s
min/avg/max/mdev = 806 ns / 1.47 us / 36.4 us / 322 ns
Benchmarkdisk/randread/pagecache/4K-min 1 806 ns/op
Benchmarkdisk/randread/pagecache/4K-avg 1 1.47 us/op
< 1.35 us	395032	| **********
< 1.55 us	980280	| *************************
< 1.74 us	483659	| ************
< 1.93 us	65626	| *
< 2.13 us	4096	| 
< 2.32 us	678	| 
< 2.51 us	104	| 
< 2.71 us	12	| 
< 2.90 us	1	| 
< 3.09 us	1	| 
< 3.29 us	1	| 
< 3.48 us	0	| 
< 3.67 us	0	| 
< 3.87 us	0	| 
< 4.06 us	0	| 
< 4.25 us	0	| 
< 4.44 us	0	| 
< 4.64 us	0	| 
< 4.83 us	1	| 
< 5.02 us	0	| 
< 5.22 us	0	| 
<       +∞	716	| 
# POLL·1 C1·92 C1E·0 C3·12 C6·742

dataset:	wczblk1-8
node:
cluster:	z6001

*** FileStorage
Benchmarkfs1-zhash.py 2127 38.3 µs/object	# crc32:14640593  nread=8540363  t=0.081s	# POLL·0 C1·89 C1E·0 C3·21 C6·478
Benchmarkfs1-zhash.py 2127 37.0 µs/object	# crc32:14640593  nread=8540363  t=0.079s	# POLL·2 C1·85 C1E·1 C3·26 C6·450
Benchmarkfs1-zhash.py 2127 37.6 µs/object	# crc32:14640593  nread=8540363  t=0.080s	# POLL·1 C1·94 C1E·2 C3·17 C6·518
Benchmarkfs1-zhash.py 2127 37.0 µs/object	# crc32:14640593  nread=8540363  t=0.079s	# POLL·0 C1·105 C1E·2 C3·19 C6·532
Benchmarkfs1-zhash.py 2127 37.2 µs/object	# crc32:14640593  nread=8540363  t=0.079s	# POLL·2 C1·76 C1E·1 C3·17 C6·548

Benchmarkfs1-zhash.go 2127 6.0 µs/object	# crc32:14640593  nread=8540363  t=12.748744ms	# POLL·0 C1·91 C1E·59 C3·25 C6·300
Benchmarkfs1-zhash.go 2127 6.1 µs/object	# crc32:14640593  nread=8540363  t=12.9086ms	# POLL·1 C1·110 C1E·63 C3·26 C6·258
Benchmarkfs1-zhash.go 2127 6.1 µs/object	# crc32:14640593  nread=8540363  t=12.899958ms	# POLL·0 C1·97 C1E·58 C3·30 C6·229
Benchmarkfs1-zhash.go 2127 6.0 µs/object	# crc32:14640593  nread=8540363  t=12.695673ms	# POLL·3 C1·114 C1E·66 C3·37 C6·248
Benchmarkfs1-zhash.go 2127 6.0 µs/object	# crc32:14640593  nread=8540363  t=12.807936ms	# POLL·2 C1·87 C1E·62 C3·30 C6·266
Benchmarkfs1-zhash.go+prefetch128 2127 8.5 µs/object	# crc32:14640593  nread=8540363  t=17.994822ms	# POLL·1 C1·280 C1E·316 C3·254 C6·472
Benchmarkfs1-zhash.go+prefetch128 2127 8.3 µs/object	# crc32:14640593  nread=8540363  t=17.708437ms	# POLL·2 C1·245 C1E·246 C3·333 C6·433
Benchmarkfs1-zhash.go+prefetch128 2127 7.5 µs/object	# crc32:14640593  nread=8540363  t=15.979161ms	# POLL·2 C1·332 C1E·355 C3·236 C6·386
Benchmarkfs1-zhash.go+prefetch128 2127 8.3 µs/object	# crc32:14640593  nread=8540363  t=17.67212ms	# POLL·4 C1·225 C1E·254 C3·270 C6·503
Benchmarkfs1-zhash.go+prefetch128 2127 8.3 µs/object	# crc32:14640593  nread=8540363  t=17.628403ms	# POLL·1 C1·246 C1E·395 C3·255 C6·486

# 1 clients in parallel
Benchmarkfs1-zwrk.go·1 3000000	227053.9 req/s  4.404 latency-µs/object	# POLL·3 C1·157 C1E·107 C3·140 C6·5512
Benchmarkfs1-zwrk.go·1 3000000	230678.4 req/s  4.335 latency-µs/object	# POLL·6 C1·181 C1E·110 C3·133 C6·5924
Benchmarkfs1-zwrk.go·1 3000000	230164.7 req/s  4.345 latency-µs/object	# POLL·10 C1·142 C1E·93 C3·62 C6·5257
Benchmarkfs1-zwrk.go·1 3000000	223751.4 req/s  4.469 latency-µs/object	# POLL·3 C1·150 C1E·90 C3·110 C6·5519
Benchmarkfs1-zwrk.go·1 3000000	230932.1 req/s  4.330 latency-µs/object	# POLL·8 C1·209 C1E·191 C3·67 C6·5384

# 2 clients in parallel
Benchmarkfs1-zwrk.go·2 10000000	439036.4 req/s  4.555 latency-µs/object	# POLL·15 C1·169 C1E·132 C3·114 C6·7651
Benchmarkfs1-zwrk.go·2 10000000	438995.4 req/s  4.556 latency-µs/object	# POLL·16 C1·160 C1E·108 C3·107 C6·7391
Benchmarkfs1-zwrk.go·2 10000000	436941.2 req/s  4.577 latency-µs/object	# POLL·15 C1·179 C1E·144 C3·140 C6·7919
Benchmarkfs1-zwrk.go·2 10000000	440296.6 req/s  4.542 latency-µs/object	# POLL·20 C1·217 C1E·135 C3·113 C6·7603
Benchmarkfs1-zwrk.go·2 10000000	436606.6 req/s  4.581 latency-µs/object	# POLL·24 C1·222 C1E·96 C3·89 C6·6940

# 3 clients in parallel
Benchmarkfs1-zwrk.go·3 10000000	664915.3 req/s  4.512 latency-µs/object	# POLL·4 C1·189 C1E·124 C3·135 C6·13434
Benchmarkfs1-zwrk.go·3 10000000	663404.1 req/s  4.522 latency-µs/object	# POLL·6 C1·192 C1E·97 C3·78 C6·12795
Benchmarkfs1-zwrk.go·3 10000000	663751.9 req/s  4.520 latency-µs/object	# POLL·13 C1·181 C1E·131 C3·118 C6·12751
Benchmarkfs1-zwrk.go·3 10000000	670377.2 req/s  4.475 latency-µs/object	# POLL·8 C1·215 C1E·110 C3·88 C6·11747
Benchmarkfs1-zwrk.go·3 10000000	663546.0 req/s  4.521 latency-µs/object	# POLL·10 C1·201 C1E·127 C3·96 C6·12607

# 4 clients in parallel
Benchmarkfs1-zwrk.go·4 20000000	877043.2 req/s  4.561 latency-µs/object	# POLL·15 C1·142 C1E·114 C3·176 C6·18682
Benchmarkfs1-zwrk.go·4 20000000	863029.0 req/s  4.635 latency-µs/object	# POLL·13 C1·217 C1E·128 C3·101 C6·18952
Benchmarkfs1-zwrk.go·4 20000000	866275.3 req/s  4.617 latency-µs/object	# POLL·14 C1·172 C1E·129 C3·110 C6·18754
Benchmarkfs1-zwrk.go·4 20000000	868343.2 req/s  4.606 latency-µs/object	# POLL·12 C1·256 C1E·129 C3·148 C6·16741
Benchmarkfs1-zwrk.go·4 20000000	867158.2 req/s  4.613 latency-µs/object	# POLL·20 C1·205 C1E·161 C3·755 C6·16852

# 8 clients in parallel
Benchmarkfs1-zwrk.go·8 30000000	1759831.7 req/s  4.546 latency-µs/object	# POLL·12 C1·249 C1E·132 C3·202 C6·12255
Benchmarkfs1-zwrk.go·8 30000000	1756630.4 req/s  4.554 latency-µs/object	# POLL·16 C1·197 C1E·224 C3·172 C6·12163
Benchmarkfs1-zwrk.go·8 30000000	1769194.8 req/s  4.522 latency-µs/object	# POLL·21 C1·370 C1E·171 C3·197 C6·14090
Benchmarkfs1-zwrk.go·8 30000000	1742002.5 req/s  4.592 latency-µs/object	# POLL·17 C1·243 C1E·241 C3·152 C6·13503
Benchmarkfs1-zwrk.go·8 30000000	1742466.1 req/s  4.591 latency-µs/object	# POLL·10 C1·262 C1E·164 C3·147 C6·12501

# 12 clients in parallel
Benchmarkfs1-zwrk.go·12 30000000	2570206.2 req/s  4.669 latency-µs/object	# POLL·25 C1·263 C1E·184 C3·229 C6·4877
Benchmarkfs1-zwrk.go·12 30000000	2586621.1 req/s  4.639 latency-µs/object	# POLL·25 C1·277 C1E·171 C3·216 C6·4400
Benchmarkfs1-zwrk.go·12 50000000	2550760.9 req/s  4.704 latency-µs/object	# POLL·33 C1·263 C1E·192 C3·232 C6·8318
Benchmarkfs1-zwrk.go·12 50000000	2549814.0 req/s  4.706 latency-µs/object	# POLL·43 C1·240 C1E·150 C3·175 C6·6321
Benchmarkfs1-zwrk.go·12 30000000	2586121.7 req/s  4.640 latency-µs/object	# POLL·22 C1·310 C1E·155 C3·225 C6·5151

# 16 clients in parallel
Benchmarkfs1-zwrk.go·16 50000000	2906647.2 req/s  5.505 latency-µs/object	# POLL·16 C1·297 C1E·159 C3·350 C6·6999
Benchmarkfs1-zwrk.go·16 50000000	2893607.1 req/s  5.529 latency-µs/object	# POLL·32 C1·393 C1E·216 C3·293 C6·6285
Benchmarkfs1-zwrk.go·16 50000000	2884530.5 req/s  5.547 latency-µs/object	# POLL·17 C1·224 C1E·168 C3·306 C6·6795
Benchmarkfs1-zwrk.go·16 50000000	2900422.1 req/s  5.516 latency-µs/object	# POLL·24 C1·334 C1E·246 C3·274 C6·5989
Benchmarkfs1-zwrk.go·16 50000000	2912571.5 req/s  5.493 latency-µs/object	# POLL·13 C1·379 C1E·183 C3·538 C6·6460

*** ZEO
Benchmarkzeo/py/fs1-zhash.py 2127 673.0 µs/object	# crc32:14640593  nread=8540363  t=1.432s	# POLL·3 C1·16483 C1E·4845 C3·2920 C6·1246
Benchmarkzeo/py/fs1-zhash.py 2127 655.6 µs/object	# crc32:14640593  nread=8540363  t=1.395s	# POLL·2 C1·15899 C1E·4966 C3·2522 C6·1780
Benchmarkzeo/py/fs1-zhash.py 2127 707.0 µs/object	# crc32:14640593  nread=8540363  t=1.504s	# POLL·1 C1·12622 C1E·4694 C3·3991 C6·2205
Benchmarkzeo/py/fs1-zhash.py 2127 679.0 µs/object	# crc32:14640593  nread=8540363  t=1.445s	# POLL·4 C1·13336 C1E·5057 C3·3310 C6·2173
Benchmarkzeo/py/fs1-zhash.py 2127 659.2 µs/object	# crc32:14640593  nread=8540363  t=1.403s	# POLL·2 C1·15585 C1E·5149 C3·3270 C6·1200

Benchmarkzeo/py/fs1-zhash.go 2127 283.2 µs/object	# crc32:14640593  nread=8540363  t=602.722565ms	# POLL·4 C1·139 C1E·5196 C3·4365 C6·3007
Benchmarkzeo/py/fs1-zhash.go 2127 268.6 µs/object	# crc32:14640593  nread=8540363  t=571.551818ms	# POLL·3 C1·269 C1E·4983 C3·5005 C6·2168
Benchmarkzeo/py/fs1-zhash.go 2127 260.2 µs/object	# crc32:14640593  nread=8540363  t=553.731959ms	# POLL·1 C1·154 C1E·5511 C3·4294 C6·2599
Benchmarkzeo/py/fs1-zhash.go 2127 275.4 µs/object	# crc32:14640593  nread=8540363  t=586.050277ms	# POLL·3 C1·175 C1E·5369 C3·4705 C6·2266
Benchmarkzeo/py/fs1-zhash.go 2127 247.9 µs/object	# crc32:14640593  nread=8540363  t=527.428594ms	# POLL·4 C1·300 C1E·5248 C3·4612 C6·2236
Benchmarkzeo/py/fs1-zhash.go+prefetch128 2127 100.2 µs/object	# crc32:14640593  nread=8540363  t=213.216483ms	# POLL·16 C1·2013 C1E·6654 C3·1526 C6·1666
Benchmarkzeo/py/fs1-zhash.go+prefetch128 2127 100.9 µs/object	# crc32:14640593  nread=8540363  t=214.641558ms	# POLL·5 C1·1839 C1E·6406 C3·1802 C6·1702
Benchmarkzeo/py/fs1-zhash.go+prefetch128 2127 103.8 µs/object	# crc32:14640593  nread=8540363  t=220.783122ms	# POLL·4 C1·1742 C1E·6760 C3·1671 C6·1607
Benchmarkzeo/py/fs1-zhash.go+prefetch128 2127 100.6 µs/object	# crc32:14640593  nread=8540363  t=214.143111ms	# POLL·14 C1·1470 C1E·6758 C3·721 C6·2492
Benchmarkzeo/py/fs1-zhash.go+prefetch128 2127 101.0 µs/object	# crc32:14640593  nread=8540363  t=214.965459ms	# POLL·13 C1·1969 C1E·6560 C3·808 C6·2523

# 1 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·1 100000	4521.0 req/s  221.188 latency-µs/object	# POLL·194 C1·68533 C1E·246041 C3·215321 C6·72075
Benchmarkzeo/py/fs1-zwrk.go·1 100000	4574.1 req/s  218.621 latency-µs/object	# POLL·150 C1·69620 C1E·249993 C3·210869 C6·71462
Benchmarkzeo/py/fs1-zwrk.go·1 100000	4752.4 req/s  210.419 latency-µs/object	# POLL·182 C1·81265 C1E·243402 C3·211120 C6·66070
Benchmarkzeo/py/fs1-zwrk.go·1 100000	4570.9 req/s  218.774 latency-µs/object	# POLL·168 C1·75736 C1E·243124 C3·209780 C6·73074
Benchmarkzeo/py/fs1-zwrk.go·1 100000	4621.4 req/s  216.386 latency-µs/object	# POLL·144 C1·69845 C1E·249217 C3·215403 C6·67335

# 2 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·2 100000	6373.5 req/s  313.799 latency-µs/object	# POLL·168 C1·15501 C1E·263817 C3·182496 C6·25313
Benchmarkzeo/py/fs1-zwrk.go·2 100000	6206.9 req/s  322.221 latency-µs/object	# POLL·178 C1·16593 C1E·256904 C3·185970 C6·27568
Benchmarkzeo/py/fs1-zwrk.go·2 100000	6388.6 req/s  313.057 latency-µs/object	# POLL·180 C1·16401 C1E·262862 C3·182165 C6·25311
Benchmarkzeo/py/fs1-zwrk.go·2 100000	6214.3 req/s  321.838 latency-µs/object	# POLL·167 C1·16251 C1E·258219 C3·185166 C6·27808
Benchmarkzeo/py/fs1-zwrk.go·2 100000	6378.9 req/s  313.536 latency-µs/object	# POLL·179 C1·16085 C1E·263402 C3·182265 C6·25339

# 3 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·3 100000	7099.9 req/s  422.543 latency-µs/object	# POLL·199 C1·18091 C1E·332191 C3·112903 C6·22654
Benchmarkzeo/py/fs1-zwrk.go·3 100000	7100.1 req/s  422.527 latency-µs/object	# POLL·204 C1·18484 C1E·327730 C3·115953 C6·23601
Benchmarkzeo/py/fs1-zwrk.go·3 100000	6952.8 req/s  431.482 latency-µs/object	# POLL·221 C1·18269 C1E·321405 C3·122542 C6·23013
Benchmarkzeo/py/fs1-zwrk.go·3 100000	6814.9 req/s  440.211 latency-µs/object	# POLL·206 C1·17661 C1E·313656 C3·130650 C6·23592
Benchmarkzeo/py/fs1-zwrk.go·3 100000	6944.9 req/s  431.971 latency-µs/object	# POLL·204 C1·18338 C1E·321816 C3·122667 C6·22579

# 4 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·4 100000	7182.7 req/s  556.892 latency-µs/object	# POLL·218 C1·18819 C1E·329955 C3·116667 C6·20045
Benchmarkzeo/py/fs1-zwrk.go·4 100000	6933.0 req/s  576.950 latency-µs/object	# POLL·179 C1·18044 C1E·315476 C3·130401 C6·21570
Benchmarkzeo/py/fs1-zwrk.go·4 100000	7198.2 req/s  555.691 latency-µs/object	# POLL·189 C1·18632 C1E·332288 C3·114015 C6·20036
Benchmarkzeo/py/fs1-zwrk.go·4 100000	7170.5 req/s  557.841 latency-µs/object	# POLL·237 C1·18739 C1E·331510 C3·113845 C6·21585
Benchmarkzeo/py/fs1-zwrk.go·4 100000	7077.9 req/s  565.143 latency-µs/object	# POLL·203 C1·18379 C1E·324937 C3·121048 C6·20524

# 8 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·8 100000	7436.3 req/s  1075.804 latency-µs/object	# POLL·189 C1·20009 C1E·349119 C3·97445 C6·18859
Benchmarkzeo/py/fs1-zwrk.go·8 100000	7133.6 req/s  1121.458 latency-µs/object	# POLL·188 C1·19201 C1E·328773 C3·117557 C6·20378
Benchmarkzeo/py/fs1-zwrk.go·8 100000	7512.1 req/s  1064.942 latency-µs/object	# POLL·190 C1·20467 C1E·355494 C3·91729 C6·17796
Benchmarkzeo/py/fs1-zwrk.go·8 100000	7466.7 req/s  1071.428 latency-µs/object	# POLL·196 C1·19777 C1E·351344 C3·96754 C6·17192
Benchmarkzeo/py/fs1-zwrk.go·8 100000	7480.8 req/s  1069.409 latency-µs/object	# POLL·189 C1·19738 C1E·353100 C3·94922 C6·17356

# 12 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·12 100000	7590.9 req/s  1580.835 latency-µs/object	# POLL·211 C1·21049 C1E·379607 C3·67808 C6·17563
Benchmarkzeo/py/fs1-zwrk.go·12 100000	7581.2 req/s  1582.871 latency-µs/object	# POLL·233 C1·20719 C1E·376721 C3·71135 C6·17789
Benchmarkzeo/py/fs1-zwrk.go·12 100000	7732.0 req/s  1551.985 latency-µs/object	# POLL·193 C1·21332 C1E·396843 C3·50738 C6·17390
Benchmarkzeo/py/fs1-zwrk.go·12 100000	7695.0 req/s  1559.448 latency-µs/object	# POLL·212 C1·21400 C1E·389495 C3·59102 C6·15631
Benchmarkzeo/py/fs1-zwrk.go·12 100000	7536.1 req/s  1592.343 latency-µs/object	# POLL·204 C1·20621 C1E·373778 C3·73567 C6·18067

# 16 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·16 100000	7396.7 req/s  2163.130 latency-µs/object	# POLL·226 C1·21068 C1E·364940 C3·82373 C6·18949
Benchmarkzeo/py/fs1-zwrk.go·16 100000	7787.2 req/s  2054.659 latency-µs/object	# POLL·224 C1·21805 C1E·403783 C3·43547 C6·17152
Benchmarkzeo/py/fs1-zwrk.go·16 100000	7737.7 req/s  2067.789 latency-µs/object	# POLL·207 C1·22017 C1E·398023 C3·49956 C6·16820
Benchmarkzeo/py/fs1-zwrk.go·16 100000	7782.0 req/s  2056.037 latency-µs/object	# POLL·232 C1·21963 C1E·400738 C3·47039 C6·16715
Benchmarkzeo/py/fs1-zwrk.go·16 100000	7566.2 req/s  2114.658 latency-µs/object	# POLL·207 C1·20664 C1E·377348 C3·70357 C6·18882

*** NEO/py sqlite (logging disabled)
Benchmarkneo/py(!log)/sqlite-zhash.py 2127 664.4 µs/object	# crc32:14640593  nread=8540363  t=1.414s	# POLL·0 C1·101 C1E·11 C3·7389 C6·1939
Benchmarkneo/py(!log)/sqlite-zhash.py 2127 682.7 µs/object	# crc32:14640593  nread=8540363  t=1.453s	# POLL·0 C1·166 C1E·25 C3·7957 C6·1191
Benchmarkneo/py(!log)/sqlite-zhash.py 2127 683.4 µs/object	# crc32:14640593  nread=8540363  t=1.454s	# POLL·0 C1·166 C1E·19 C3·7634 C6·1527
Benchmarkneo/py(!log)/sqlite-zhash.py 2127 711.6 µs/object	# crc32:14640593  nread=8540363  t=1.514s	# POLL·1 C1·139 C1E·9 C3·8306 C6·814
Benchmarkneo/py(!log)/sqlite-zhash.py 2127 621.6 µs/object	# crc32:14640593  nread=8540363  t=1.323s	# POLL·1 C1·2727 C1E·1027 C3·7327 C6·4006

Benchmarkneo/py(!log)/sqlite-zhash.go 2127 275.4 µs/object	# crc32:14640593  nread=8540363  t=585.962726ms	# POLL·3 C1·105 C1E·5101 C3·4727 C6·2076
Benchmarkneo/py(!log)/sqlite-zhash.go 2127 304.3 µs/object	# crc32:14640593  nread=8540363  t=647.448803ms	# POLL·3 C1·86 C1E·8801 C3·4752 C6·2359
Benchmarkneo/py(!log)/sqlite-zhash.go 2127 260.5 µs/object	# crc32:14640593  nread=8540363  t=554.354569ms	# POLL·4 C1·108 C1E·4670 C3·6328 C6·566
Benchmarkneo/py(!log)/sqlite-zhash.go 2127 302.8 µs/object	# crc32:14640593  nread=8540363  t=644.352549ms	# POLL·4 C1·94 C1E·6819 C3·4918 C6·2854
Benchmarkneo/py(!log)/sqlite-zhash.go 2127 314.1 µs/object	# crc32:14640593  nread=8540363  t=668.387835ms	# POLL·5 C1·121 C1E·7248 C3·5674 C6·1798
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 2127 178.1 µs/object	# crc32:14640593  nread=8540363  t=378.953503ms	# POLL·2 C1·824 C1E·9034 C3·1810 C6·1479
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 2127 175.6 µs/object	# crc32:14640593  nread=8540363  t=373.615725ms	# POLL·6 C1·706 C1E·8674 C3·1597 C6·1687
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 2127 178.9 µs/object	# crc32:14640593  nread=8540363  t=380.637362ms	# POLL·5 C1·738 C1E·8953 C3·1633 C6·1669
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 2127 174.4 µs/object	# crc32:14640593  nread=8540363  t=371.046637ms	# POLL·6 C1·655 C1E·8849 C3·1902 C6·1497
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 2127 175.1 µs/object	# crc32:14640593  nread=8540363  t=372.569355ms	# POLL·5 C1·733 C1E·7387 C3·3113 C6·1007

# 1 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3104.5 req/s  322.112 latency-µs/object	# POLL·11 C1·165 C1E·147894 C3·143220 C6·64804
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3464.0 req/s  288.686 latency-µs/object	# POLL·20 C1·856 C1E·176100 C3·128343 C6·60478
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3308.8 req/s  302.227 latency-µs/object	# POLL·17 C1·198 C1E·183979 C3·140654 C6·59760
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3246.5 req/s  308.023 latency-µs/object	# POLL·12 C1·316 C1E·195517 C3·128728 C6·48356
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3236.4 req/s  308.989 latency-µs/object	# POLL·15 C1·204 C1E·165754 C3·122873 C6·65865

# 2 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5685.1 req/s  351.798 latency-µs/object	# POLL·34 C1·531 C1E·422607 C3·108454 C6·26016
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5729.0 req/s  349.099 latency-µs/object	# POLL·21 C1·772 C1E·431868 C3·100289 C6·26566
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5615.9 req/s  356.133 latency-µs/object	# POLL·32 C1·573 C1E·415671 C3·114597 C6·31263
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5521.6 req/s  362.213 latency-µs/object	# POLL·26 C1·595 C1E·395277 C3·115642 C6·43082
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5638.9 req/s  354.681 latency-µs/object	# POLL·23 C1·678 C1E·451440 C3·83060 C6·34746

# 3 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5379.5 req/s  557.676 latency-µs/object	# POLL·24 C1·1450 C1E·373635 C3·134246 C6·41617
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5630.4 req/s  532.823 latency-µs/object	# POLL·22 C1·721 C1E·443060 C3·108990 C6·27975
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5637.0 req/s  532.200 latency-µs/object	# POLL·27 C1·332 C1E·417032 C3·116098 C6·30021
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5594.8 req/s  536.216 latency-µs/object	# POLL·26 C1·590 C1E·415315 C3·119129 C6·33406
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5611.8 req/s  534.592 latency-µs/object	# POLL·30 C1·929 C1E·430499 C3·106967 C6·37221

# 4 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5575.9 req/s  717.367 latency-µs/object	# POLL·24 C1·490 C1E·342829 C3·159769 C6·30862
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5592.8 req/s  715.210 latency-µs/object	# POLL·21 C1·783 C1E·361443 C3·145435 C6·34401
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5568.9 req/s  718.272 latency-µs/object	# POLL·19 C1·1339 C1E·390096 C3·123026 C6·35570
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5495.2 req/s  727.913 latency-µs/object	# POLL·24 C1·616 C1E·396078 C3·124056 C6·40696
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5736.3 req/s  697.315 latency-µs/object	# POLL·39 C1·471 C1E·455942 C3·86354 C6·27590

# 8 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5758.0 req/s  1389.378 latency-µs/object	# POLL·47 C1·897 C1E·443481 C3·94394 C6·31717
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5593.5 req/s  1430.242 latency-µs/object	# POLL·27 C1·1011 C1E·420231 C3·106944 C6·28974
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5521.6 req/s  1448.847 latency-µs/object	# POLL·42 C1·900 C1E·367369 C3·154110 C6·33646
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5635.1 req/s  1419.667 latency-µs/object	# POLL·30 C1·908 C1E·401130 C3·134093 C6·36211
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5623.0 req/s  1422.736 latency-µs/object	# POLL·34 C1·740 C1E·386171 C3·130884 C6·30522

# 12 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5713.0 req/s  2100.479 latency-µs/object	# POLL·38 C1·427 C1E·417671 C3·111457 C6·19814
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5595.1 req/s  2144.729 latency-µs/object	# POLL·24 C1·502 C1E·369243 C3·145095 C6·31188
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5533.8 req/s  2168.477 latency-µs/object	# POLL·49 C1·2917 C1E·409864 C3·186781 C6·41575
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5552.4 req/s  2161.241 latency-µs/object	# POLL·26 C1·576 C1E·428545 C3·103261 C6·38600
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5433.2 req/s  2208.623 latency-µs/object	# POLL·26 C1·410 C1E·408135 C3·116896 C6·30250

# 16 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5589.6 req/s  2862.475 latency-µs/object	# POLL·34 C1·801 C1E·412302 C3·117980 C6·28365
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5718.9 req/s  2797.745 latency-µs/object	# POLL·31 C1·797 C1E·392099 C3·144385 C6·20018
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5627.9 req/s  2842.995 latency-µs/object	# POLL·33 C1·2211 C1E·403477 C3·128987 C6·31952
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5610.8 req/s  2851.626 latency-µs/object	# POLL·44 C1·1396 C1E·376752 C3·139964 C6·28930
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5584.6 req/s  2865.002 latency-µs/object	# POLL·32 C1·757 C1E·391585 C3·121858 C6·32294
2018-03-08 15:02:48.0781 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/py sql (logging disabled)
2018-03-08 15:02:48 139946179108224 [Note] mysqld (mysqld 10.1.25-MariaDB-1) starting as process 8136 ...
Benchmarkneo/py(!log)/sql-zhash.py 2127 1227.1 µs/object	# crc32:14640593  nread=8540363  t=2.611s	# POLL·0 C1·170 C1E·40 C3·14044 C6·5450
Benchmarkneo/py(!log)/sql-zhash.py 2127 940.0 µs/object	# crc32:14640593  nread=8540363  t=2.000s	# POLL·2 C1·830 C1E·474 C3·12399 C6·4719
Benchmarkneo/py(!log)/sql-zhash.py 2127 971.4 µs/object	# crc32:14640593  nread=8540363  t=2.067s	# POLL·1 C1·198 C1E·1337 C3·13215 C6·3565
Benchmarkneo/py(!log)/sql-zhash.py 2127 842.0 µs/object	# crc32:14640593  nread=8540363  t=1.792s	# POLL·2 C1·173 C1E·2135 C3·12675 C6·3094
Benchmarkneo/py(!log)/sql-zhash.py 2127 809.7 µs/object	# crc32:14640593  nread=8540363  t=1.723s	# POLL·2 C1·241 C1E·2286 C3·12752 C6·2840

Benchmarkneo/py(!log)/sql-zhash.go 2127 446.0 µs/object	# crc32:14640593  nread=8540363  t=949.165512ms	# POLL·5 C1·169 C1E·10799 C3·5902 C6·6294
Benchmarkneo/py(!log)/sql-zhash.go 2127 445.9 µs/object	# crc32:14640593  nread=8540363  t=948.902159ms	# POLL·4 C1·180 C1E·10448 C3·5571 C6·6052
Benchmarkneo/py(!log)/sql-zhash.go 2127 453.4 µs/object	# crc32:14640593  nread=8540363  t=964.780924ms	# POLL·6 C1·113 C1E·13170 C3·9880 C6·1625
Benchmarkneo/py(!log)/sql-zhash.go 2127 443.9 µs/object	# crc32:14640593  nread=8540363  t=944.688256ms	# POLL·0 C1·119 C1E·9609 C3·11720 C6·955
Benchmarkneo/py(!log)/sql-zhash.go 2127 414.2 µs/object	# crc32:14640593  nread=8540363  t=881.49924ms	# POLL·2 C1·1321 C1E·12154 C3·4203 C6·7089
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 2127 243.2 µs/object	# crc32:14640593  nread=8540363  t=517.603812ms	# POLL·2 C1·4545 C1E·8508 C3·4185 C6·3983
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 2127 264.9 µs/object	# crc32:14640593  nread=8540363  t=563.733815ms	# POLL·3 C1·3963 C1E·8814 C3·4186 C6·4384
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 2127 231.0 µs/object	# crc32:14640593  nread=8540363  t=491.565856ms	# POLL·2 C1·5072 C1E·5807 C3·8838 C6·1447
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 2127 296.8 µs/object	# crc32:14640593  nread=8540363  t=631.523037ms	# POLL·8 C1·1786 C1E·8467 C3·8603 C6·2044
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 2127 308.5 µs/object	# crc32:14640593  nread=8540363  t=656.424629ms	# POLL·2 C1·926 C1E·7778 C3·9663 C6·2089

# 1 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·1 50000	2376.6 req/s  420.775 latency-µs/object	# POLL·18 C1·23412 C1E·251999 C3·251677 C6·71973
Benchmarkneo/py(!log)/sql-zwrk.go·1 30000	2756.9 req/s  362.732 latency-µs/object	# POLL·14 C1·53402 C1E·154231 C3·147823 C6·58999
Benchmarkneo/py(!log)/sql-zwrk.go·1 30000	2330.8 req/s  429.043 latency-µs/object	# POLL·20 C1·3729 C1E·198001 C3·188344 C6·29771
Benchmarkneo/py(!log)/sql-zwrk.go·1 50000	2433.2 req/s  410.990 latency-µs/object	# POLL·37 C1·23460 C1E·277513 C3·217444 C6·99149
Benchmarkneo/py(!log)/sql-zwrk.go·1 30000	2828.4 req/s  353.555 latency-µs/object	# POLL·12 C1·54865 C1E·157882 C3·133234 C6·66446

# 2 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	3873.0 req/s  516.394 latency-µs/object	# POLL·9 C1·85726 C1E·197756 C3·168784 C6·91622
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	3849.9 req/s  519.493 latency-µs/object	# POLL·15 C1·83799 C1E·194169 C3·179903 C6·82843
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	3866.8 req/s  517.224 latency-µs/object	# POLL·13 C1·88736 C1E·215080 C3·168162 C6·87134
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	3794.4 req/s  527.089 latency-µs/object	# POLL·15 C1·80598 C1E·218979 C3·192145 C6·75009
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	4088.8 req/s  489.141 latency-µs/object	# POLL·19 C1·95086 C1E·192263 C3·154796 C6·102853

# 3 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	4061.4 req/s  738.667 latency-µs/object	# POLL·18 C1·113012 C1E·214075 C3·137318 C6·97879
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	4020.6 req/s  746.159 latency-µs/object	# POLL·12 C1·108850 C1E·175941 C3·168510 C6·85943
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	3931.5 req/s  763.060 latency-µs/object	# POLL·19 C1·109046 C1E·200753 C3·158846 C6·87094
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	4095.2 req/s  732.566 latency-µs/object	# POLL·19 C1·115231 C1E·221901 C3·135484 C6·102608
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	4133.2 req/s  725.827 latency-µs/object	# POLL·15 C1·117484 C1E·229072 C3·136549 C6·94436

# 4 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·4 50000	3953.6 req/s  1011.735 latency-µs/object	# POLL·24 C1·100041 C1E·194407 C3·185712 C6·68970
Benchmarkneo/py(!log)/sql-zwrk.go·4 50000	4032.2 req/s  992.009 latency-µs/object	# POLL·22 C1·108777 C1E·161662 C3·191056 C6·76051
Benchmarkneo/py(!log)/sql-zwrk.go·4 50000	3959.5 req/s  1010.217 latency-µs/object	# POLL·23 C1·93905 C1E·196558 C3·164023 C6·90190
Benchmarkneo/py(!log)/sql-zwrk.go·4 50000	4046.0 req/s  988.639 latency-µs/object	# POLL·30 C1·94491 C1E·210520 C3·172088 C6·83147
Benchmarkneo/py(!log)/sql-zwrk.go·4 50000	3682.3 req/s  1086.280 latency-µs/object	# POLL·18 C1·69519 C1E·242958 C3·205845 C6·52522

# 8 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·8 50000	3740.4 req/s  2138.825 latency-µs/object	# POLL·27 C1·92776 C1E·180434 C3·212239 C6·53691
Benchmarkneo/py(!log)/sql-zwrk.go·8 50000	4160.6 req/s  1922.818 latency-µs/object	# POLL·19 C1·111026 C1E·187544 C3·174932 C6·83872
Benchmarkneo/py(!log)/sql-zwrk.go·8 50000	4113.0 req/s  1945.063 latency-µs/object	# POLL·17 C1·113295 C1E·199037 C3·158346 C6·88132
Benchmarkneo/py(!log)/sql-zwrk.go·8 50000	4132.5 req/s  1935.892 latency-µs/object	# POLL·25 C1·118104 C1E·158832 C3·169941 C6·86581
Benchmarkneo/py(!log)/sql-zwrk.go·8 50000	3934.2 req/s  2033.451 latency-µs/object	# POLL·21 C1·114445 C1E·178403 C3·155874 C6·93075

# 12 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·12 100000	4107.0 req/s  2921.864 latency-µs/object	# POLL·38 C1·218083 C1E·345380 C3·274724 C6·157698
Benchmarkneo/py(!log)/sql-zwrk.go·12 50000	4050.4 req/s  2962.703 latency-µs/object	# POLL·34 C1·116445 C1E·171674 C3·165934 C6·86810
Benchmarkneo/py(!log)/sql-zwrk.go·12 50000	3957.5 req/s  3032.183 latency-µs/object	# POLL·20 C1·122544 C1E·219413 C3·144881 C6·93939
Benchmarkneo/py(!log)/sql-zwrk.go·12 100000	4125.9 req/s  2908.460 latency-µs/object	# POLL·37 C1·218183 C1E·327478 C3·294809 C6·151969
Benchmarkneo/py(!log)/sql-zwrk.go·12 100000	4150.6 req/s  2891.140 latency-µs/object	# POLL·38 C1·218567 C1E·288477 C3·315991 C6·139943

# 16 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	4075.7 req/s  3925.670 latency-µs/object	# POLL·25 C1·113987 C1E·218293 C3·168401 C6·76114
Benchmarkneo/py(!log)/sql-zwrk.go·16 100000	4166.9 req/s  3839.751 latency-µs/object	# POLL·68 C1·217378 C1E·328439 C3·293441 C6·147032
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	4082.3 req/s  3919.394 latency-µs/object	# POLL·23 C1·111436 C1E·172892 C3·186821 C6·73400
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	3586.0 req/s  4461.806 latency-µs/object	# POLL·28 C1·70247 C1E·227923 C3·214662 C6·47471
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	3969.8 req/s  4030.443 latency-µs/object	# POLL·18 C1·114236 C1E·205413 C3·161911 C6·86869
2018-03-08 15:13:49.5870 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/go fs1
unexpected packet: Retry Later in PrimaryBootstrapHandler
Connection to None lost
Benchmarkneo/go/fs1-zhash.py 2127 548.8 µs/object	# crc32:14640593  nread=8540363  t=1.168s
# POLL·1 C1·539 C1E·5160 C3·9662 C6·3804
Benchmarkneo/go/fs1-zhash.py 2127 503.3 µs/object	# crc32:14640593  nread=8540363  t=1.071s	# POLL·4 C1·188 C1E·2925 C3·12938 C6·2022
Benchmarkneo/go/fs1-zhash.py 2127 558.5 µs/object	# crc32:14640593  nread=8540363  t=1.189s	# POLL·2 C1·436 C1E·2957 C3·9747 C6·4617
Benchmarkneo/go/fs1-zhash.py 2127 433.2 µs/object	# crc32:14640593  nread=8540363  t=0.922s	# POLL·2 C1·7533 C1E·5927 C3·5537 C6·5147
Benchmarkneo/go/fs1-zhash.py 2127 501.6 µs/object	# crc32:14640593  nread=8540363  t=1.067s	# POLL·1 C1·939 C1E·2897 C3·10966 C6·2359

Benchmarkneo/go/fs1-zhash.go 2127 106.8 µs/object	# crc32:14640593  nread=8540363  t=227.252929ms	# POLL·4 C1·1918 C1E·17595 C3·711 C6·655
Benchmarkneo/go/fs1-zhash.go 2127 108.9 µs/object	# crc32:14640593  nread=8540363  t=231.78749ms	# POLL·8 C1·1060 C1E·18409 C3·218 C6·1207
Benchmarkneo/go/fs1-zhash.go 2127 97.6 µs/object	# crc32:14640593  nread=8540363  t=207.716772ms	# POLL·3 C1·2106 C1E·16512 C3·434 C6·825
Benchmarkneo/go/fs1-zhash.go 2127 113.4 µs/object	# crc32:14640593  nread=8540363  t=241.343464ms	# POLL·1 C1·1185 C1E·18451 C3·556 C6·724
Benchmarkneo/go/fs1-zhash.go 2127 103.4 µs/object	# crc32:14640593  nread=8540363  t=219.963872ms	# POLL·10 C1·1404 C1E·17406 C3·197 C6·1325
Benchmarkneo/go/fs1-zhash.go+prefetch128 2127 38.3 µs/object	# crc32:14640593  nread=8540363  t=81.444147ms	# POLL·25 C1·4112 C1E·5167 C3·370 C6·638
Benchmarkneo/go/fs1-zhash.go+prefetch128 2127 36.7 µs/object	# crc32:14640593  nread=8540363  t=78.108318ms	# POLL·40 C1·3951 C1E·5304 C3·408 C6·591
Benchmarkneo/go/fs1-zhash.go+prefetch128 2127 36.4 µs/object	# crc32:14640593  nread=8540363  t=77.391263ms	# POLL·49 C1·4111 C1E·5214 C3·531 C6·468
Benchmarkneo/go/fs1-zhash.go+prefetch128 2127 39.1 µs/object	# crc32:14640593  nread=8540363  t=83.273607ms	# POLL·35 C1·4194 C1E·5181 C3·467 C6·627
Benchmarkneo/go/fs1-zhash.go+prefetch128 2127 35.0 µs/object	# crc32:14640593  nread=8540363  t=74.50628ms	# POLL·24 C1·4093 C1E·4537 C3·472 C6·585

# 1 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·1 200000	10646.4 req/s  93.928 latency-µs/object	# POLL·139 C1·193092 C1E·1512589 C3·37887 C6·72191
Benchmarkneo/go/fs1-zwrk.go·1 200000	10457.8 req/s  95.623 latency-µs/object	# POLL·132 C1·200193 C1E·1533063 C3·41909 C6·65312
Benchmarkneo/go/fs1-zwrk.go·1 200000	10842.6 req/s  92.229 latency-µs/object	# POLL·109 C1·208542 C1E·1471757 C3·39369 C6·74289
Benchmarkneo/go/fs1-zwrk.go·1 200000	10481.7 req/s  95.405 latency-µs/object	# POLL·125 C1·186445 C1E·1544466 C3·33173 C6·67635
Benchmarkneo/go/fs1-zwrk.go·1 200000	10610.4 req/s  94.247 latency-µs/object	# POLL·134 C1·201974 C1E·1512489 C3·43738 C6·64334

# 2 clients in parallel
E0308 15:15:56.682233   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59228: 192.168.0.16:5554 - 192.168.0.16:59228: accept: node link is not listening for incoming connections
Benchmarkneo/go/fs1-zwrk.go·2 300000	22369.8 req/s  89.406 latency-µs/object	# POLL·211 C1·154716 C1E·882509 C3·20418 C6·29945
Benchmarkneo/go/fs1-zwrk.go·2 300000	22271.4 req/s  89.801 latency-µs/object	# POLL·206 C1·152995 C1E·875489 C3·19982 C6·32498
Benchmarkneo/go/fs1-zwrk.go·2 300000	22458.0 req/s  89.055 latency-µs/object	# POLL·197 C1·149966 C1E·865473 C3·20643 C6·29650
Benchmarkneo/go/fs1-zwrk.go·2 300000	22354.2 req/s  89.469 latency-µs/object	# POLL·213 C1·150182 C1E·880276 C3·19119 C6·32496
Benchmarkneo/go/fs1-zwrk.go·2 300000	22375.5 req/s  89.384 latency-µs/object	# POLL·238 C1·154162 C1E·875511 C3·21221 C6·30575

# 3 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·3 500000	31713.9 req/s  94.596 latency-µs/object	# POLL·519 C1·159090 C1E·1221994 C3·19588 C6·26804
Benchmarkneo/go/fs1-zwrk.go·3 500000	31783.3 req/s  94.389 latency-µs/object	# POLL·563 C1·163043 C1E·1215363 C3·20017 C6·27359
Benchmarkneo/go/fs1-zwrk.go·3 500000	31820.7 req/s  94.278 latency-µs/object	# POLL·553 C1·161157 C1E·1223514 C3·19475 C6·26426
Benchmarkneo/go/fs1-zwrk.go·3 500000	31762.3 req/s  94.452 latency-µs/object	# POLL·591 C1·160655 C1E·1218661 C3·19358 C6·25774
E0308 15:18:14.976785   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59356: 192.168.0.16:5554 - 192.168.0.16:59356: accept: node link is not listening for incoming connections
Benchmarkneo/go/fs1-zwrk.go·3 500000	31833.0 req/s  94.242 latency-µs/object	# POLL·555 C1·159989 C1E·1219321 C3·19184 C6·26431

# 4 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·4 1000000	43126.0 req/s  92.751 latency-µs/object	# POLL·2144 C1·183550 C1E·2257693 C3·27598 C6·32445
Benchmarkneo/go/fs1-zwrk.go·4 1000000	43106.2 req/s  92.794 latency-µs/object	# POLL·2158 C1·185029 C1E·2256638 C3·28286 C6·31846
Benchmarkneo/go/fs1-zwrk.go·4 1000000	43155.3 req/s  92.689 latency-µs/object	# POLL·2075 C1·186080 C1E·2251410 C3·27638 C6·32114
Benchmarkneo/go/fs1-zwrk.go·4 1000000	43151.7 req/s  92.696 latency-µs/object	# POLL·2032 C1·185851 C1E·2258060 C3·27771 C6·32706
Benchmarkneo/go/fs1-zwrk.go·4 1000000	43130.6 req/s  92.742 latency-µs/object	# POLL·2045 C1·183486 C1E·2253773 C3·28461 C6·31729

# 8 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·8 1000000	78002.4 req/s  102.561 latency-µs/object	# POLL·62435 C1·695562 C1E·1944901 C3·3866 C6·2681
Benchmarkneo/go/fs1-zwrk.go·8 1000000	78144.0 req/s  102.375 latency-µs/object	# POLL·62226 C1·698485 C1E·1937068 C3·4527 C6·2136
E0308 15:20:53.378678   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59572: 192.168.0.16:5554 - 192.168.0.16:59572: accept: node link is not listening for incoming connections
E0308 15:20:53.378701   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59572: 192.168.0.16:5554 - 192.168.0.16:59572: accept: node link is not listening for incoming connections
E0308 15:20:53.379408   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59566: 192.168.0.16:5554 - 192.168.0.16:59566: accept: node link is not listening for incoming connections
Benchmarkneo/go/fs1-zwrk.go·8 1000000	78154.3 req/s  102.362 latency-µs/object	# POLL·61911 C1·694738 C1E·1939910 C3·3836 C6·2206
Benchmarkneo/go/fs1-zwrk.go·8 1000000	78126.5 req/s  102.398 latency-µs/object	# POLL·62648 C1·701612 C1E·1938342 C3·3688 C6·3321
Benchmarkneo/go/fs1-zwrk.go·8 1000000	78247.2 req/s  102.240 latency-µs/object	# POLL·62276 C1·698621 C1E·1937701 C3·4289 C6·1952

# 12 clients in parallel
E0308 15:21:33.016327   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59688: 192.168.0.16:5554 - 192.168.0.16:59688: accept: node link is not listening for incoming connections
Benchmarkneo/go/fs1-zwrk.go·12 1000000	92479.9 req/s  129.758 latency-µs/object	# POLL·88357 C1·1016334 C1E·624561 C3·2282 C6·1836
Benchmarkneo/go/fs1-zwrk.go·12 1000000	92402.3 req/s  129.867 latency-µs/object	# POLL·88857 C1·1022111 C1E·630849 C3·1576 C6·2391
Benchmarkneo/go/fs1-zwrk.go·12 1000000	92461.3 req/s  129.784 latency-µs/object	# POLL·88765 C1·1020800 C1E·623726 C3·1487 C6·2180
Benchmarkneo/go/fs1-zwrk.go·12 1000000	92401.2 req/s  129.868 latency-µs/object	# POLL·89355 C1·1024083 C1E·624353 C3·2664 C6·1419
E0308 15:22:21.981577   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59910: 192.168.0.16:5554 - 192.168.0.16:59910: accept: node link is not listening for incoming connections
E0308 15:22:21.981577   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59910: 192.168.0.16:5554 - 192.168.0.16:59910: accept: node link is not listening for incoming connections
E0308 15:22:21.981590   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59910: 192.168.0.16:5554 - 192.168.0.16:59910: accept: node link is not listening for incoming connections
E0308 15:22:21.981590   11407 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:59910: 192.168.0.16:5554 - 192.168.0.16:59910: accept: node link is not listening for incoming connections
Benchmarkneo/go/fs1-zwrk.go·12 1000000	92433.7 req/s  129.823 latency-µs/object	# POLL·89216 C1·1024717 C1E·622039 C3·1430 C6·2257

# 16 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·16 2000000	102274.3 req/s  156.442 latency-µs/object	# POLL·213752 C1·2396974 C1E·1084831 C3·3477 C6·3013
Benchmarkneo/go/fs1-zwrk.go·16 2000000	102512.4 req/s  156.079 latency-µs/object	# POLL·215049 C1·2398086 C1E·1085652 C3·3349 C6·2756
Benchmarkneo/go/fs1-zwrk.go·16 2000000	102456.4 req/s  156.164 latency-µs/object	# POLL·215641 C1·2407522 C1E·1083224 C3·4220 C6·2048
Benchmarkneo/go/fs1-zwrk.go·16 2000000	102507.1 req/s  156.087 latency-µs/object	# POLL·214903 C1·2404629 C1E·1085769 C3·4247 C6·1999
Benchmarkneo/go/fs1-zwrk.go·16 2000000	102654.4 req/s  155.863 latency-µs/object	# POLL·214362 C1·2403779 C1E·1084592 C3·4315 C6·2189
2018/03/08 15:24:55 accept tcp 192.168.0.16:5554: use of closed network connection
2018-03-08 15:24:55.4991 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/go fs1 (sha1 disabled on: storage, client)
# NEO/go (Sgo): skipping SHA1 computations
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 2127 78.2 µs/object	# crc32:14640593  nread=8540363  t=166.484831ms
# POLL·1 C1·4140 C1E·12816 C3·372 C6·1091
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 2127 73.8 µs/object	# crc32:14640593  nread=8540363  t=157.124369ms
# POLL·6 C1·4386 C1E·12153 C3·306 C6·517
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 2127 78.3 µs/object	# crc32:14640593  nread=8540363  t=166.56179ms
# POLL·6 C1·4379 C1E·12744 C3·235 C6·611
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 2127 80.5 µs/object	# crc32:14640593  nread=8540363  t=171.383952ms
# POLL·4 C1·3695 C1E·13910 C3·289 C6·819
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 2127 70.3 µs/object	# crc32:14640593  nread=8540363  t=149.662515ms
# POLL·9 C1·4832 C1E·11601 C3·173 C6·543
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 2127 26.6 µs/object	# crc32:14640593  nread=8540363  t=56.502043ms
# POLL·34 C1·5580 C1E·2661 C3·562 C6·546
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 2127 25.4 µs/object	# crc32:14640593  nread=8540363  t=54.111585ms
# POLL·38 C1·5619 C1E·2645 C3·349 C6·478
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 2127 25.9 µs/object	# crc32:14640593  nread=8540363  t=55.199088ms
# POLL·45 C1·5687 C1E·2664 C3·506 C6·475
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 2127 25.8 µs/object	# crc32:14640593  nread=8540363  t=54.812414ms
# POLL·45 C1·5987 C1E·2329 C3·602 C6·496
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 2127 26.3 µs/object	# crc32:14640593  nread=8540363  t=55.971857ms
# POLL·32 C1·5806 C1E·2647 C3·578 C6·510

# 1 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	15027.3 req/s  66.545 latency-µs/object
# POLL·159 C1·482980 C1E·1134790 C3·15773 C6·33010
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	15312.5 req/s  65.306 latency-µs/object
# POLL·119 C1·494812 C1E·1120876 C3·17678 C6·29689
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	15371.8 req/s  65.054 latency-µs/object
# POLL·173 C1·496805 C1E·1121243 C3·22405 C6·27660
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	15025.6 req/s  66.553 latency-µs/object
# POLL·145 C1·489371 C1E·1128887 C3·17563 C6·31820
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	15187.3 req/s  65.845 latency-µs/object
# POLL·134 C1·493304 C1E·1114277 C3·17785 C6·19868

# 2 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	31353.4 req/s  63.789 latency-µs/object
# POLL·671 C1·849709 C1E·721625 C3·41688 C6·57541
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	31397.4 req/s  63.699 latency-µs/object
# POLL·645 C1·852514 C1E·718337 C3·40044 C6·59198
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	31558.3 req/s  63.375 latency-µs/object
# POLL·676 C1·857477 C1E·703871 C3·41907 C6·58351
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	31392.8 req/s  63.709 latency-µs/object
# POLL·639 C1·854006 C1E·706261 C3·41725 C6·59871
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	31515.2 req/s  63.461 latency-µs/object
# POLL·591 C1·853943 C1E·706126 C3·42346 C6·58096

# 3 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	43724.5 req/s  68.611 latency-µs/object
# POLL·1916 C1·1147226 C1E·1389299 C3·69272 C6·75063
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	43706.0 req/s  68.641 latency-µs/object
# POLL·2069 C1·1146733 C1E·1391827 C3·71696 C6·74723
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	43857.3 req/s  68.404 latency-µs/object
# POLL·2062 C1·1153032 C1E·1385187 C3·70307 C6·74519
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	43867.5 req/s  68.388 latency-µs/object
# POLL·2002 C1·1148034 C1E·1380672 C3·68013 C6·75763
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	43820.6 req/s  68.461 latency-µs/object
# POLL·1981 C1·1148034 C1E·1380319 C3·68283 C6·75676

# 4 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	57667.9 req/s  69.363 latency-µs/object
# POLL·3037 C1·811695 C1E·1395255 C3·71163 C6·56393
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	57661.0 req/s  69.371 latency-µs/object
# POLL·3084 C1·814275 C1E·1392226 C3·66161 C6·62434
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	57510.6 req/s  69.552 latency-µs/object
# POLL·3031 C1·811029 C1E·1397478 C3·71177 C6·58401
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	57577.5 req/s  69.472 latency-µs/object
# POLL·2972 C1·816447 C1E·1394071 C3·68119 C6·60577
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	57721.3 req/s  69.299 latency-µs/object
# POLL·3076 C1·817932 C1E·1389874 C3·70545 C6·57848

# 8 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 2000000	99816.2 req/s  80.147 latency-µs/object
# POLL·108356 C1·2891259 C1E·3461784 C3·52832 C6·35117
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 2000000	99886.6 req/s  80.091 latency-µs/object
# POLL·109595 C1·2929444 C1E·3454178 C3·54073 C6·34352
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 2000000	100109.6 req/s  79.912 latency-µs/object
# POLL·110132 C1·2919371 C1E·3453771 C3·53618 C6·35798
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 2000000	99979.0 req/s  80.017 latency-µs/object
# POLL·109274 C1·2927823 C1E·3451766 C3·55500 C6·33609
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 2000000	99851.1 req/s  80.119 latency-µs/object
# POLL·109769 C1·2930503 C1E·3454877 C3·54164 C6·33802

# 12 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	115603.2 req/s  103.803 latency-µs/object
# POLL·221092 C1·3474654 C1E·1215819 C3·9315 C6·8272
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	115644.0 req/s  103.767 latency-µs/object
# POLL·221591 C1·3488487 C1E·1216842 C3·8892 C6·8327
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	115708.7 req/s  103.709 latency-µs/object
# POLL·222157 C1·3484767 C1E·1215797 C3·9071 C6·9203
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	115731.1 req/s  103.689 latency-µs/object
# POLL·221288 C1·3476940 C1E·1219999 C3·9469 C6·8316
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	115830.2 req/s  103.600 latency-µs/object
# POLL·221598 C1·3481908 C1E·1210604 C3·9539 C6·7919

# 16 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	125770.5 req/s  127.216 latency-µs/object
# POLL·195135 C1·2691133 C1E·726655 C3·5893 C6·4235
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	126019.9 req/s  126.964 latency-µs/object
# POLL·194680 C1·2705023 C1E·726449 C3·5712 C6·4619
E0308 15:37:03.573221   15199 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:33000: 192.168.0.16:5554 - 192.168.0.16:33000: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	125931.1 req/s  127.054 latency-µs/object
# POLL·195033 C1·2707019 C1E·728770 C3·6213 C6·4581
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	126224.3 req/s  126.758 latency-µs/object
# POLL·195304 C1·2695487 C1E·717437 C3·5743 C6·4085
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	126056.6 req/s  126.927 latency-µs/object
# POLL·195251 C1·2708498 C1E·725743 C3·5616 C6·4324
2018/03/08 15:37:53 accept tcp 192.168.0.16:5554: use of closed network connection
2018-03-08 15:37:53.9496 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/go sqlite
Connection to None lost
Benchmarkneo/go/sqlite-zhash.py 2127 485.7 µs/object	# crc32:14640593  nread=8540363  t=1.034s
# POLL·3 C1·643 C1E·6296 C3·11862 C6·2298
Benchmarkneo/go/sqlite-zhash.py 2127 531.0 µs/object	# crc32:14640593  nread=8540363  t=1.130s	# POLL·1 C1·159 C1E·7682 C3·8461 C6·5275
Benchmarkneo/go/sqlite-zhash.py 2127 560.8 µs/object	# crc32:14640593  nread=8540363  t=1.193s	# POLL·3 C1·90 C1E·6922 C3·9068 C6·4337
Benchmarkneo/go/sqlite-zhash.py 2127 512.5 µs/object	# crc32:14640593  nread=8540363  t=1.091s	# POLL·1 C1·4234 C1E·9349 C3·8072 C6·4228
Benchmarkneo/go/sqlite-zhash.py 2127 565.0 µs/object	# crc32:14640593  nread=8540363  t=1.202s	# POLL·2 C1·485 C1E·7526 C3·9108 C6·4624

Benchmarkneo/go/sqlite-zhash.go 2127 173.4 µs/object	# crc32:14640593  nread=8540363  t=368.964162ms	# POLL·5 C1·268 C1E·17731 C3·2813 C6·3117
Benchmarkneo/go/sqlite-zhash.go 2127 202.6 µs/object	# crc32:14640593  nread=8540363  t=431.058651ms	# POLL·7 C1·221 C1E·15915 C3·5511 C6·2785
Benchmarkneo/go/sqlite-zhash.go 2127 225.4 µs/object	# crc32:14640593  nread=8540363  t=479.688306ms	# POLL·3 C1·115 C1E·14808 C3·8434 C6·1091
Benchmarkneo/go/sqlite-zhash.go 2127 210.1 µs/object	# crc32:14640593  nread=8540363  t=447.048312ms	# POLL·3 C1·219 C1E·15158 C3·7281 C6·1763
Benchmarkneo/go/sqlite-zhash.go 2127 188.2 µs/object	# crc32:14640593  nread=8540363  t=400.467271ms	# POLL·3 C1·231 C1E·17240 C3·4360 C6·2485
Benchmarkneo/go/sqlite-zhash.go+prefetch128 2127 40.4 µs/object	# crc32:14640593  nread=8540363  t=85.90779ms	# POLL·51 C1·4129 C1E·4845 C3·739 C6·802
Benchmarkneo/go/sqlite-zhash.go+prefetch128 2127 39.0 µs/object	# crc32:14640593  nread=8540363  t=83.011973ms	# POLL·45 C1·3757 C1E·4976 C3·644 C6·822
Benchmarkneo/go/sqlite-zhash.go+prefetch128 2127 39.4 µs/object	# crc32:14640593  nread=8540363  t=83.926963ms	# POLL·33 C1·4076 C1E·4570 C3·778 C6·672
Benchmarkneo/go/sqlite-zhash.go+prefetch128 2127 40.7 µs/object	# crc32:14640593  nread=8540363  t=86.617098ms	# POLL·47 C1·3947 C1E·4579 C3·781 C6·777
Benchmarkneo/go/sqlite-zhash.go+prefetch128 2127 40.0 µs/object	# crc32:14640593  nread=8540363  t=85.214631ms	# POLL·36 C1·3826 C1E·4722 C3·750 C6·753

# 1 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·1 100000	5010.7 req/s  199.572 latency-µs/object	# POLL·64 C1·5514 C1E·824982 C3·278349 C6·125736
Benchmarkneo/go/sqlite-zwrk.go·1 100000	5001.1 req/s  199.957 latency-µs/object	# POLL·75 C1·6500 C1E·831571 C3·267650 C6·126562
Benchmarkneo/go/sqlite-zwrk.go·1 100000	5006.6 req/s  199.736 latency-µs/object	# POLL·116 C1·6255 C1E·829929 C3·273942 C6·120199
Benchmarkneo/go/sqlite-zwrk.go·1 100000	4811.7 req/s  207.826 latency-µs/object	# POLL·84 C1·5339 C1E·816931 C3·284423 C6·133453
Benchmarkneo/go/sqlite-zwrk.go·1 100000	4778.6 req/s  209.267 latency-µs/object	# POLL·82 C1·5629 C1E·822023 C3·284908 C6·136027

# 2 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·2 200000	11962.1 req/s  167.194 latency-µs/object	# POLL·567 C1·71480 C1E·1031801 C3·142990 C6·136040
Benchmarkneo/go/sqlite-zwrk.go·2 200000	12002.3 req/s  166.635 latency-µs/object	# POLL·586 C1·72473 C1E·1037753 C3·141108 C6·132948
Benchmarkneo/go/sqlite-zwrk.go·2 200000	11948.5 req/s  167.384 latency-µs/object	# POLL·545 C1·71345 C1E·1033313 C3·144400 C6·134942
Benchmarkneo/go/sqlite-zwrk.go·2 200000	11984.4 req/s  166.884 latency-µs/object	# POLL·584 C1·73008 C1E·1024657 C3·145577 C6·130314
Benchmarkneo/go/sqlite-zwrk.go·2 200000	12036.2 req/s  166.165 latency-µs/object	# POLL·562 C1·72313 C1E·1027363 C3·136815 C6·134336

# 3 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·3 300000	18863.4 req/s  159.038 latency-µs/object	# POLL·1059 C1·189490 C1E·952981 C3·114363 C6·112865
Benchmarkneo/go/sqlite-zwrk.go·3 300000	18944.0 req/s  158.362 latency-µs/object	# POLL·922 C1·190023 C1E·941402 C3·116347 C6·109475
Benchmarkneo/go/sqlite-zwrk.go·3 300000	18948.8 req/s  158.321 latency-µs/object	# POLL·1044 C1·192657 C1E·952438 C3·114680 C6·111484
Benchmarkneo/go/sqlite-zwrk.go·3 300000	19003.2 req/s  157.868 latency-µs/object	# POLL·910 C1·193729 C1E·937065 C3·106982 C6·110051
Benchmarkneo/go/sqlite-zwrk.go·3 300000	18922.2 req/s  158.544 latency-µs/object	# POLL·978 C1·191906 C1E·953581 C3·107480 C6·109937

# 4 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·4 300000	24536.1 req/s  163.025 latency-µs/object	# POLL·843 C1·149760 C1E·779834 C3·99015 C6·79823
Benchmarkneo/go/sqlite-zwrk.go·4 300000	24610.0 req/s  162.536 latency-µs/object	# POLL·819 C1·150898 C1E·776685 C3·94182 C6·76683
Benchmarkneo/go/sqlite-zwrk.go·4 500000	24556.6 req/s  162.889 latency-µs/object	# POLL·1422 C1·248715 C1E·1278621 C3·149865 C6·129246
Benchmarkneo/go/sqlite-zwrk.go·4 300000	24691.2 req/s  162.001 latency-µs/object	# POLL·882 C1·151927 C1E·786670 C3·92785 C6·76749
Benchmarkneo/go/sqlite-zwrk.go·4 300000	24652.8 req/s  162.253 latency-µs/object	# POLL·848 C1·150918 C1E·779904 C3·94051 C6·79056

# 8 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	43969.6 req/s  181.944 latency-µs/object	# POLL·7301 C1·275841 C1E·2187821 C3·171937 C6·69036
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	44230.0 req/s  180.873 latency-µs/object	# POLL·7280 C1·277971 C1E·2182805 C3·168847 C6·65211
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	44302.6 req/s  180.576 latency-µs/object	# POLL·7158 C1·277993 C1E·2178422 C3·172427 C6·63455
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	44390.8 req/s  180.218 latency-µs/object	# POLL·7236 C1·277199 C1E·2183768 C3·167839 C6·65620
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	44484.3 req/s  179.839 latency-µs/object	# POLL·7273 C1·275469 C1E·2183127 C3·165935 C6·65189

# 12 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	55209.2 req/s  217.355 latency-µs/object	# POLL·39648 C1·691869 C1E·1623821 C3·73184 C6·21126
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	55475.7 req/s  216.311 latency-µs/object	# POLL·39221 C1·686115 C1E·1613096 C3·74129 C6·21277
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	55627.2 req/s  215.722 latency-µs/object	# POLL·39270 C1·687804 C1E·1615782 C3·70054 C6·20588
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	55716.8 req/s  215.375 latency-µs/object	# POLL·38879 C1·682889 C1E·1617605 C3·68749 C6·20104
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	55681.8 req/s  215.510 latency-µs/object	# POLL·38837 C1·682933 C1E·1617331 C3·70811 C6·19186

# 16 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	57878.3 req/s  276.442 latency-µs/object	# POLL·50036 C1·834896 C1E·950212 C3·56393 C6·9784
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	57899.0 req/s  276.343 latency-µs/object	# POLL·49643 C1·833361 C1E·956892 C3·53302 C6·12171
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	57797.9 req/s  276.826 latency-µs/object	# POLL·50339 C1·836247 C1E·957241 C3·51972 C6·12017
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	58118.8 req/s  275.298 latency-µs/object	# POLL·49780 C1·830831 C1E·951210 C3·51372 C6·12110
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	58084.1 req/s  275.463 latency-µs/object	# POLL·50378 C1·836422 C1E·953670 C3·49363 C6·10536
2018/03/08 15:49:23 accept tcp 192.168.0.16:5554: use of closed network connection
2018-03-08 15:49:23.1587 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/go sqlite (sha1 disabled on: client)
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 2127 169.4 µs/object	# crc32:14640593  nread=8540363  t=360.50408ms
# POLL·5 C1·547 C1E·17723 C3·3462 C6·2448
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 2127 209.2 µs/object	# crc32:14640593  nread=8540363  t=445.167273ms
# POLL·5 C1·219 C1E·15203 C3·6236 C6·2831
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 2127 164.0 µs/object	# crc32:14640593  nread=8540363  t=349.063682ms
# POLL·4 C1·239 C1E·17759 C3·2981 C6·2030
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 2127 172.8 µs/object	# crc32:14640593  nread=8540363  t=367.710893ms
# POLL·4 C1·246 C1E·15934 C3·5197 C6·1337
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 2127 210.2 µs/object	# crc32:14640593  nread=8540363  t=447.40005ms
# POLL·10 C1·167 C1E·12807 C3·8383 C6·1855
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 2127 35.0 µs/object	# crc32:14640593  nread=8540363  t=74.452411ms
# POLL·78 C1·4513 C1E·4952 C3·628 C6·691
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 2127 36.4 µs/object	# crc32:14640593  nread=8540363  t=77.515778ms
# POLL·66 C1·4638 C1E·4863 C3·723 C6·735
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 2127 39.0 µs/object	# crc32:14640593  nread=8540363  t=82.894135ms
# POLL·63 C1·4244 C1E·5086 C3·697 C6·774
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 2127 38.3 µs/object	# crc32:14640593  nread=8540363  t=81.577965ms
# POLL·53 C1·4356 C1E·5189 C3·861 C6·699
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 2127 37.5 µs/object	# crc32:14640593  nread=8540363  t=79.867049ms
# POLL·28 C1·4322 C1E·3918 C3·910 C6·755

# 1 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	5682.0 req/s  175.994 latency-µs/object
# POLL·64 C1·7298 C1E·854036 C3·217909 C6·101203
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	5575.8 req/s  179.345 latency-µs/object
# POLL·74 C1·7556 C1E·831594 C3·235421 C6·107604
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	5621.4 req/s  177.892 latency-µs/object
# POLL·84 C1·7939 C1E·826930 C3·230111 C6·109238
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	5575.8 req/s  179.347 latency-µs/object
# POLL·88 C1·7187 C1E·845808 C3·219451 C6·107444
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	5653.9 req/s  176.869 latency-µs/object
# POLL·72 C1·7751 C1E·846768 C3·219891 C6·105522

# 2 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	12981.5 req/s  154.065 latency-µs/object
# POLL·685 C1·92467 C1E·878727 C3·167334 C6·152151
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13117.9 req/s  152.463 latency-µs/object
# POLL·720 C1·95393 C1E·875580 C3·160054 C6·154054
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13125.6 req/s  152.374 latency-µs/object
# POLL·725 C1·94386 C1E·867257 C3·156107 C6·153932
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13092.9 req/s  152.755 latency-µs/object
# POLL·687 C1·91963 C1E·888523 C3·156561 C6·152458
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13062.1 req/s  153.115 latency-µs/object
# POLL·765 C1·91882 C1E·879194 C3·161116 C6·154420

# 3 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20173.7 req/s  148.708 latency-µs/object
# POLL·1394 C1·199668 C1E·892420 C3·155318 C6·138873
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20218.5 req/s  148.379 latency-µs/object
# POLL·1242 C1·200371 C1E·895454 C3·152623 C6·137050
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20196.2 req/s  148.543 latency-µs/object
# POLL·1282 C1·199388 C1E·895781 C3·153168 C6·141602
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20198.4 req/s  148.526 latency-µs/object
# POLL·1312 C1·201119 C1E·890043 C3·152630 C6·141224
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20209.2 req/s  148.448 latency-µs/object
# POLL·1281 C1·200026 C1E·889535 C3·161324 C6·136662

# 4 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	26810.5 req/s  149.196 latency-µs/object
# POLL·2353 C1·315981 C1E·1245376 C3·178447 C6·137935
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	26901.9 req/s  148.688 latency-µs/object
# POLL·2329 C1·317497 C1E·1243418 C3·178701 C6·133115
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	26843.2 req/s  149.014 latency-µs/object
# POLL·2252 C1·314683 C1E·1242410 C3·171854 C6·142710
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	26836.5 req/s  149.051 latency-µs/object
# POLL·2349 C1·315577 C1E·1238183 C3·177220 C6·141008
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	26870.5 req/s  148.862 latency-µs/object
# POLL·2277 C1·313307 C1E·1233237 C3·180648 C6·138766

# 8 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	47344.0 req/s  168.976 latency-µs/object
# POLL·7487 C1·409259 C1E·1856395 C3·221085 C6·87138
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	47736.3 req/s  167.587 latency-µs/object
# POLL·7387 C1·414037 C1E·1849144 C3·212321 C6·85504
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	47799.9 req/s  167.364 latency-µs/object
# POLL·7174 C1·413082 C1E·1847968 C3·210038 C6·87409
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	47854.3 req/s  167.174 latency-µs/object
# POLL·7206 C1·411889 C1E·1832795 C3·217801 C6·84851
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	47882.9 req/s  167.074 latency-µs/object
# POLL·7235 C1·412222 C1E·1834990 C3·215174 C6·84804

# 12 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	59267.9 req/s  202.471 latency-µs/object
# POLL·30039 C1·744399 C1E·1438572 C3·86184 C6·25017
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	59470.8 req/s  201.780 latency-µs/object
# POLL·29925 C1·743340 C1E·1434239 C3·89584 C6·27242
E0308 15:58:12.978885   22506 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:35000: 192.168.0.16:5554 - 192.168.0.16:35000: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	59653.2 req/s  201.163 latency-µs/object
# POLL·29566 C1·743742 C1E·1442017 C3·82810 C6·24310
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	60130.5 req/s  199.566 latency-µs/object
# POLL·29132 C1·738634 C1E·1432384 C3·85274 C6·25818
E0308 15:58:49.584111   22506 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:35124: 192.168.0.16:5554 - 192.168.0.16:35124: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	60102.3 req/s  199.660 latency-µs/object
# POLL·29432 C1·740486 C1E·1433006 C3·85043 C6·25087

# 16 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	62794.2 req/s  254.801 latency-µs/object
# POLL·48114 C1·893748 C1E·800605 C3·51179 C6·14383
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	62728.7 req/s  255.067 latency-µs/object
# POLL·47966 C1·890550 C1E·802627 C3·53245 C6·11333
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	62773.1 req/s  254.886 latency-µs/object
# POLL·48267 C1·895673 C1E·798457 C3·53154 C6·13480
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	62888.6 req/s  254.418 latency-µs/object
# POLL·48022 C1·895691 C1E·805761 C3·47325 C6·11949
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	62914.0 req/s  254.315 latency-µs/object
# POLL·48372 C1·894065 C1E·801053 C3·50784 C6·12697
2018/03/08 16:00:18 accept tcp 192.168.0.16:5554: use of closed network connection
2018-03-08 16:00:18.0257 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

dataset:	prod1-1024
node:
cluster:	z6001

*** FileStorage
/home/neotest/1/src/lab.nexedi.com/kirr/neo/go/neo/t/var/prod1-1024/fs1/data.fs Database records 79574464796 seconds in the future
Benchmarkfs1-zhash.py 3789 30.5 µs/object	# crc32:a50b90dc  nread=4905351  t=0.116s
# POLL·0 C1·79 C1E·3 C3·18 C6·441
/home/neotest/1/src/lab.nexedi.com/kirr/neo/go/neo/t/var/prod1-1024/fs1/data.fs Database records 79574464796 seconds in the future
Benchmarkfs1-zhash.py 3789 29.7 µs/object	# crc32:a50b90dc  nread=4905351  t=0.113s
# POLL·2 C1·88 C1E·0 C3·23 C6·508
/home/neotest/1/src/lab.nexedi.com/kirr/neo/go/neo/t/var/prod1-1024/fs1/data.fs Database records 79574464795 seconds in the future
Benchmarkfs1-zhash.py 3789 30.0 µs/object	# crc32:a50b90dc  nread=4905351  t=0.114s
# POLL·0 C1·85 C1E·2 C3·20 C6·533
/home/neotest/1/src/lab.nexedi.com/kirr/neo/go/neo/t/var/prod1-1024/fs1/data.fs Database records 79574464795 seconds in the future
Benchmarkfs1-zhash.py 3789 30.4 µs/object	# crc32:a50b90dc  nread=4905351  t=0.115s
# POLL·0 C1·104 C1E·0 C3·17 C6·471
/home/neotest/1/src/lab.nexedi.com/kirr/neo/go/neo/t/var/prod1-1024/fs1/data.fs Database records 79574464794 seconds in the future
Benchmarkfs1-zhash.py 3789 30.4 µs/object	# crc32:a50b90dc  nread=4905351  t=0.115s
# POLL·0 C1·58 C1E·4 C3·23 C6·570

Benchmarkfs1-zhash.go 3789 4.6 µs/object	# crc32:a50b90dc  nread=4905351  t=17.352828ms	# POLL·1 C1·115 C1E·58 C3·43 C6·271
Benchmarkfs1-zhash.go 3789 4.6 µs/object	# crc32:a50b90dc  nread=4905351  t=17.432401ms	# POLL·2 C1·93 C1E·59 C3·44 C6·249
Benchmarkfs1-zhash.go 3789 4.6 µs/object	# crc32:a50b90dc  nread=4905351  t=17.447253ms	# POLL·0 C1·104 C1E·66 C3·41 C6·273
Benchmarkfs1-zhash.go 3789 4.6 µs/object	# crc32:a50b90dc  nread=4905351  t=17.295234ms	# POLL·1 C1·108 C1E·66 C3·31 C6·244
Benchmarkfs1-zhash.go 3789 4.6 µs/object	# crc32:a50b90dc  nread=4905351  t=17.275492ms	# POLL·0 C1·86 C1E·60 C3·37 C6·255
Benchmarkfs1-zhash.go+prefetch128 3789 5.3 µs/object	# crc32:a50b90dc  nread=4905351  t=20.233352ms	# POLL·4 C1·390 C1E·849 C3·259 C6·449
Benchmarkfs1-zhash.go+prefetch128 3789 5.9 µs/object	# crc32:a50b90dc  nread=4905351  t=22.460999ms	# POLL·8 C1·327 C1E·858 C3·514 C6·404
Benchmarkfs1-zhash.go+prefetch128 3789 5.8 µs/object	# crc32:a50b90dc  nread=4905351  t=21.808972ms	# POLL·5 C1·258 C1E·595 C3·466 C6·385
Benchmarkfs1-zhash.go+prefetch128 3789 5.7 µs/object	# crc32:a50b90dc  nread=4905351  t=21.601981ms	# POLL·3 C1·237 C1E·606 C3·489 C6·384
Benchmarkfs1-zhash.go+prefetch128 3789 5.8 µs/object	# crc32:a50b90dc  nread=4905351  t=21.797315ms	# POLL·5 C1·178 C1E·644 C3·421 C6·503

# 1 clients in parallel
Benchmarkfs1-zwrk.go·1 5000000	349632.1 req/s  2.860 latency-µs/object	# POLL·12 C1·123 C1E·108 C3·84 C6·4833
Benchmarkfs1-zwrk.go·1 5000000	348896.2 req/s  2.866 latency-µs/object	# POLL·9 C1·185 C1E·170 C3·102 C6·4903
Benchmarkfs1-zwrk.go·1 5000000	347027.6 req/s  2.882 latency-µs/object	# POLL·5 C1·128 C1E·127 C3·71 C6·4999
Benchmarkfs1-zwrk.go·1 5000000	348958.7 req/s  2.866 latency-µs/object	# POLL·1 C1·186 C1E·162 C3·55 C6·4909
Benchmarkfs1-zwrk.go·1 5000000	349001.0 req/s  2.865 latency-µs/object	# POLL·6 C1·186 C1E·171 C3·104 C6·5091

# 2 clients in parallel
Benchmarkfs1-zwrk.go·2 10000000	668451.0 req/s  2.992 latency-µs/object	# POLL·19 C1·199 C1E·188 C3·95 C6·4768
Benchmarkfs1-zwrk.go·2 10000000	660715.6 req/s  3.027 latency-µs/object	# POLL·4 C1·138 C1E·137 C3·119 C6·5007
Benchmarkfs1-zwrk.go·2 10000000	645496.9 req/s  3.098 latency-µs/object	# POLL·8 C1·154 C1E·188 C3·104 C6·5256
Benchmarkfs1-zwrk.go·2 10000000	674389.9 req/s  2.966 latency-µs/object	# POLL·12 C1·184 C1E·231 C3·59 C6·4810
Benchmarkfs1-zwrk.go·2 10000000	646905.8 req/s  3.092 latency-µs/object	# POLL·7 C1·204 C1E·121 C3·77 C6·4820

# 3 clients in parallel
Benchmarkfs1-zwrk.go·3 20000000	1003175.0 req/s  2.991 latency-µs/object	# POLL·21 C1·233 C1E·139 C3·458 C6·16273
Benchmarkfs1-zwrk.go·3 20000000	1002399.9 req/s  2.993 latency-µs/object	# POLL·12 C1·237 C1E·121 C3·177 C6·16027
Benchmarkfs1-zwrk.go·3 20000000	979497.3 req/s  3.063 latency-µs/object	# POLL·14 C1·235 C1E·139 C3·118 C6·16291
Benchmarkfs1-zwrk.go·3 20000000	963176.0 req/s  3.115 latency-µs/object	# POLL·20 C1·201 C1E·114 C3·101 C6·17050
Benchmarkfs1-zwrk.go·3 20000000	999550.9 req/s  3.001 latency-µs/object	# POLL·9 C1·229 C1E·169 C3·113 C6·16416

# 4 clients in parallel
Benchmarkfs1-zwrk.go·4 20000000	1322282.7 req/s  3.025 latency-µs/object	# POLL·8 C1·230 C1E·222 C3·85 C6·12496
Benchmarkfs1-zwrk.go·4 20000000	1305696.2 req/s  3.063 latency-µs/object	# POLL·17 C1·212 C1E·115 C3·136 C6·12853
Benchmarkfs1-zwrk.go·4 20000000	1315441.0 req/s  3.041 latency-µs/object	# POLL·13 C1·223 C1E·176 C3·455 C6·11482
Benchmarkfs1-zwrk.go·4 20000000	1297864.3 req/s  3.082 latency-µs/object	# POLL·8 C1·181 C1E·151 C3·112 C6·10647
Benchmarkfs1-zwrk.go·4 20000000	1295343.7 req/s  3.088 latency-µs/object	# POLL·21 C1·225 C1E·207 C3·84 C6·7879

# 8 clients in parallel
Benchmarkfs1-zwrk.go·8 50000000	2552580.6 req/s  3.134 latency-µs/object	# POLL·12 C1·194 C1E·164 C3·229 C6·14278
Benchmarkfs1-zwrk.go·8 30000000	2493255.6 req/s  3.209 latency-µs/object	# POLL·20 C1·198 C1E·120 C3·217 C6·5407
Benchmarkfs1-zwrk.go·8 50000000	2508330.4 req/s  3.189 latency-µs/object	# POLL·25 C1·193 C1E·330 C3·179 C6·9115
Benchmarkfs1-zwrk.go·8 50000000	2511994.0 req/s  3.185 latency-µs/object	# POLL·24 C1·261 C1E·164 C3·158 C6·8012
Benchmarkfs1-zwrk.go·8 50000000	2524348.9 req/s  3.169 latency-µs/object	# POLL·28 C1·242 C1E·155 C3·216 C6·11820

# 12 clients in parallel
Benchmarkfs1-zwrk.go·12 50000000	2803048.4 req/s  4.281 latency-µs/object	# POLL·27 C1·25478 C1E·51204 C3·25615 C6·150682
Benchmarkfs1-zwrk.go·12 50000000	2794461.1 req/s  4.294 latency-µs/object	# POLL·44 C1·26718 C1E·53173 C3·27381 C6·147365
Benchmarkfs1-zwrk.go·12 50000000	2837918.1 req/s  4.228 latency-µs/object	# POLL·32 C1·26941 C1E·52433 C3·26152 C6·146762
Benchmarkfs1-zwrk.go·12 50000000	2818929.3 req/s  4.257 latency-µs/object	# POLL·37 C1·25845 C1E·51513 C3·27338 C6·146421
Benchmarkfs1-zwrk.go·12 50000000	2816651.7 req/s  4.260 latency-µs/object	# POLL·40 C1·25301 C1E·51492 C3·27557 C6·146961

# 16 clients in parallel
Benchmarkfs1-zwrk.go·16 50000000	2869768.0 req/s  5.575 latency-µs/object	# POLL·396 C1·83914 C1E·206815 C3·156308 C6·243256
Benchmarkfs1-zwrk.go·16 50000000	2856595.5 req/s  5.601 latency-µs/object	# POLL·489 C1·84012 C1E·226725 C3·160662 C6·240008
Benchmarkfs1-zwrk.go·16 50000000	2866569.4 req/s  5.582 latency-µs/object	# POLL·403 C1·83855 C1E·212561 C3·156164 C6·249376
Benchmarkfs1-zwrk.go·16 50000000	3031395.3 req/s  5.278 latency-µs/object	# POLL·394 C1·69577 C1E·190127 C3·117073 C6·200639
Benchmarkfs1-zwrk.go·16 50000000	2855036.4 req/s  5.604 latency-µs/object	# POLL·383 C1·84415 C1E·195447 C3·168888 C6·234785

*** ZEO
Benchmarkzeo/py/fs1-zhash.py 3789 627.7 µs/object	# crc32:a50b90dc  nread=4905351  t=2.379s	# POLL·2 C1·27255 C1E·9573 C3·5355 C6·1226
Benchmarkzeo/py/fs1-zhash.py 3789 659.9 µs/object	# crc32:a50b90dc  nread=4905351  t=2.501s	# POLL·3 C1·28567 C1E·10128 C3·4600 C6·1838
Benchmarkzeo/py/fs1-zhash.py 3789 647.9 µs/object	# crc32:a50b90dc  nread=4905351  t=2.456s	# POLL·1 C1·28833 C1E·9987 C3·4282 C6·1481
Benchmarkzeo/py/fs1-zhash.py 3789 653.8 µs/object	# crc32:a50b90dc  nread=4905351  t=2.478s	# POLL·2 C1·28621 C1E·9908 C3·4178 C6·2135
Benchmarkzeo/py/fs1-zhash.py 3789 642.1 µs/object	# crc32:a50b90dc  nread=4905351  t=2.434s	# POLL·2 C1·25833 C1E·10041 C3·4651 C6·2592

Benchmarkzeo/py/fs1-zhash.go 3789 230.8 µs/object	# crc32:a50b90dc  nread=4905351  t=874.801529ms	# POLL·4 C1·456 C1E·9900 C3·7703 C6·3324
Benchmarkzeo/py/fs1-zhash.go 3789 232.2 µs/object	# crc32:a50b90dc  nread=4905351  t=880.068566ms	# POLL·8 C1·586 C1E·9444 C3·9431 C6·1978
Benchmarkzeo/py/fs1-zhash.go 3789 233.4 µs/object	# crc32:a50b90dc  nread=4905351  t=884.744422ms	# POLL·6 C1·407 C1E·9553 C3·7774 C6·3672
Benchmarkzeo/py/fs1-zhash.go 3789 230.6 µs/object	# crc32:a50b90dc  nread=4905351  t=874.002632ms	# POLL·4 C1·522 C1E·9708 C3·7397 C6·3839
Benchmarkzeo/py/fs1-zhash.go 3789 240.4 µs/object	# crc32:a50b90dc  nread=4905351  t=911.270875ms	# POLL·6 C1·366 C1E·9643 C3·7604 C6·3820
Benchmarkzeo/py/fs1-zhash.go+prefetch128 3789 88.7 µs/object	# crc32:a50b90dc  nread=4905351  t=336.148457ms	# POLL·22 C1·3048 C1E·11967 C3·1383 C6·2632
Benchmarkzeo/py/fs1-zhash.go+prefetch128 3789 89.0 µs/object	# crc32:a50b90dc  nread=4905351  t=337.311922ms	# POLL·19 C1·2684 C1E·12005 C3·1910 C6·2165
Benchmarkzeo/py/fs1-zhash.go+prefetch128 3789 87.4 µs/object	# crc32:a50b90dc  nread=4905351  t=331.413022ms	# POLL·23 C1·2944 C1E·11912 C3·1906 C6·1985
Benchmarkzeo/py/fs1-zhash.go+prefetch128 3789 87.4 µs/object	# crc32:a50b90dc  nread=4905351  t=331.376188ms	# POLL·14 C1·2550 C1E·11703 C3·955 C6·3052
Benchmarkzeo/py/fs1-zhash.go+prefetch128 3789 85.0 µs/object	# crc32:a50b90dc  nread=4905351  t=322.272359ms	# POLL·21 C1·2848 C1E·11702 C3·963 C6·2929

# 1 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·1 100000	5215.3 req/s  191.743 latency-µs/object	# POLL·149 C1·47309 C1E·289563 C3·217231 C6·48975
Benchmarkzeo/py/fs1-zwrk.go·1 100000	5607.1 req/s  178.346 latency-µs/object	# POLL·154 C1·62073 C1E·288716 C3·212205 C6·39087
Benchmarkzeo/py/fs1-zwrk.go·1 100000	5441.4 req/s  183.777 latency-µs/object	# POLL·164 C1·53178 C1E·292848 C3·208081 C6·49276
Benchmarkzeo/py/fs1-zwrk.go·1 100000	5264.4 req/s  189.954 latency-µs/object	# POLL·122 C1·49056 C1E·290966 C3·213329 C6·50593
Benchmarkzeo/py/fs1-zwrk.go·1 100000	5414.4 req/s  184.692 latency-µs/object	# POLL·118 C1·54729 C1E·289753 C3·213578 C6·45139

# 2 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·2 100000	8194.4 req/s  244.070 latency-µs/object	# POLL·144 C1·14150 C1E·406550 C3·50002 C6·15921
Benchmarkzeo/py/fs1-zwrk.go·2 100000	8204.7 req/s  243.762 latency-µs/object	# POLL·154 C1·13808 C1E·406138 C3·51454 C6·14894
Benchmarkzeo/py/fs1-zwrk.go·2 100000	8151.6 req/s  245.349 latency-µs/object	# POLL·149 C1·14056 C1E·399252 C3·57703 C6·15625
Benchmarkzeo/py/fs1-zwrk.go·2 100000	8170.3 req/s  244.790 latency-µs/object	# POLL·140 C1·13104 C1E·401981 C3·56105 C6·15112
Benchmarkzeo/py/fs1-zwrk.go·2 200000	8258.8 req/s  242.167 latency-µs/object	# POLL·296 C1·25595 C1E·783897 C3·71567 C6·27241

# 3 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·3 200000	9133.2 req/s  328.470 latency-µs/object	# POLL·342 C1·117783 C1E·649098 C3·52718 C6·82817
Benchmarkzeo/py/fs1-zwrk.go·3 200000	8998.1 req/s  333.405 latency-µs/object	# POLL·321 C1·109090 C1E·655835 C3·64459 C6·71468
Benchmarkzeo/py/fs1-zwrk.go·3 200000	8961.1 req/s  334.780 latency-µs/object	# POLL·320 C1·103536 C1E·669173 C3·59647 C6·71022
Benchmarkzeo/py/fs1-zwrk.go·3 200000	8780.1 req/s  341.683 latency-µs/object	# POLL·308 C1·70586 C1E·726142 C3·54291 C6·54537
Benchmarkzeo/py/fs1-zwrk.go·3 200000	8792.4 req/s  341.204 latency-µs/object	# POLL·343 C1·73093 C1E·726037 C3·55356 C6·51652

# 4 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·4 200000	9553.6 req/s  418.689 latency-µs/object	# POLL·318 C1·134610 C1E·624931 C3·48361 C6·89956
Benchmarkzeo/py/fs1-zwrk.go·4 200000	9564.3 req/s  418.221 latency-µs/object	# POLL·320 C1·135985 C1E·621989 C3·55075 C6·85239
Benchmarkzeo/py/fs1-zwrk.go·4 200000	9298.1 req/s  430.195 latency-µs/object	# POLL·321 C1·120132 C1E·641425 C3·55937 C6·80719
Benchmarkzeo/py/fs1-zwrk.go·4 200000	9314.5 req/s  429.438 latency-µs/object	# POLL·349 C1·122365 C1E·640644 C3·48076 C6·87359
Benchmarkzeo/py/fs1-zwrk.go·4 200000	8977.7 req/s  445.548 latency-µs/object	# POLL·351 C1·109499 C1E·659585 C3·58861 C6·73820

# 8 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·8 200000	9779.0 req/s  818.083 latency-µs/object	# POLL·375 C1·124080 C1E·624592 C3·57228 C6·94462
Benchmarkzeo/py/fs1-zwrk.go·8 200000	10210.4 req/s  783.513 latency-µs/object	# POLL·356 C1·129203 C1E·610059 C3·59789 C6·94851
Benchmarkzeo/py/fs1-zwrk.go·8 200000	9630.9 req/s  830.662 latency-µs/object	# POLL·347 C1·117994 C1E·636273 C3·52768 C6·93820
Benchmarkzeo/py/fs1-zwrk.go·8 200000	9881.4 req/s  809.604 latency-µs/object	# POLL·346 C1·122704 C1E·621032 C3·57789 C6·98235
Benchmarkzeo/py/fs1-zwrk.go·8 200000	10155.6 req/s  787.746 latency-µs/object	# POLL·340 C1·128750 C1E·607980 C3·63285 C6·94775

# 12 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·12 100000	8119.5 req/s  1477.919 latency-µs/object	# POLL·163 C1·21729 C1E·403697 C3·43529 C6·18700
Benchmarkzeo/py/fs1-zwrk.go·12 200000	10397.8 req/s  1154.087 latency-µs/object	# POLL·370 C1·148692 C1E·597498 C3·52464 C6·94390
Benchmarkzeo/py/fs1-zwrk.go·12 200000	7950.8 req/s  1509.283 latency-µs/object	# POLL·362 C1·40855 C1E·751930 C3·86988 C6·33221
Benchmarkzeo/py/fs1-zwrk.go·12 200000	10329.1 req/s  1161.768 latency-µs/object	# POLL·383 C1·152152 C1E·595614 C3·60375 C6·87036
Benchmarkzeo/py/fs1-zwrk.go·12 200000	10362.3 req/s  1158.044 latency-µs/object	# POLL·393 C1·158016 C1E·593508 C3·54211 C6·88872

# 16 clients in parallel
Benchmarkzeo/py/fs1-zwrk.go·16 200000	10121.1 req/s  1580.856 latency-µs/object	# POLL·351 C1·151878 C1E·606188 C3·49410 C6·90970
Benchmarkzeo/py/fs1-zwrk.go·16 200000	9716.7 req/s  1646.649 latency-µs/object	# POLL·351 C1·133276 C1E·643874 C3·47501 C6·75592
Benchmarkzeo/py/fs1-zwrk.go·16 200000	10326.4 req/s  1549.420 latency-µs/object	# POLL·381 C1·158866 C1E·595046 C3·55923 C6·88371
Benchmarkzeo/py/fs1-zwrk.go·16 200000	9948.9 req/s  1608.222 latency-µs/object	# POLL·359 C1·144254 C1E·619739 C3·54189 C6·83638
Benchmarkzeo/py/fs1-zwrk.go·16 200000	10374.9 req/s  1542.185 latency-µs/object	# POLL·345 C1·158307 C1E·593473 C3·54741 C6·90031

*** NEO/py sqlite (logging disabled)
Benchmarkneo/py(!log)/sqlite-zhash.py 3789 680.2 µs/object	# crc32:a50b90dc  nread=4905351  t=2.578s	# POLL·3 C1·234 C1E·18 C3·15108 C6·928
Benchmarkneo/py(!log)/sqlite-zhash.py 3789 677.2 µs/object	# crc32:a50b90dc  nread=4905351  t=2.566s	# POLL·0 C1·145 C1E·3 C3·13364 C6·2502
Benchmarkneo/py(!log)/sqlite-zhash.py 3789 630.7 µs/object	# crc32:a50b90dc  nread=4905351  t=2.390s	# POLL·1 C1·4997 C1E·411 C3·13260 C6·1231
Benchmarkneo/py(!log)/sqlite-zhash.py 3789 605.0 µs/object	# crc32:a50b90dc  nread=4905351  t=2.293s	# POLL·3 C1·122 C1E·16 C3·13853 C6·2238
Benchmarkneo/py(!log)/sqlite-zhash.py 3789 673.1 µs/object	# crc32:a50b90dc  nread=4905351  t=2.551s	# POLL·1 C1·142 C1E·11 C3·15164 C6·604

Benchmarkneo/py(!log)/sqlite-zhash.go 3789 268.8 µs/object	# crc32:a50b90dc  nread=4905351  t=1.018708769s	# POLL·4 C1·162 C1E·8896 C3·8656 C6·3383
Benchmarkneo/py(!log)/sqlite-zhash.go 3789 244.8 µs/object	# crc32:a50b90dc  nread=4905351  t=927.691707ms	# POLL·3 C1·651 C1E·14594 C3·5188 C6·3891
Benchmarkneo/py(!log)/sqlite-zhash.go 3789 262.4 µs/object	# crc32:a50b90dc  nread=4905351  t=994.368841ms	# POLL·3 C1·273 C1E·11458 C3·6153 C6·3988
Benchmarkneo/py(!log)/sqlite-zhash.go 3789 260.8 µs/object	# crc32:a50b90dc  nread=4905351  t=988.595426ms	# POLL·9 C1·483 C1E·10039 C3·9832 C6·1501
Benchmarkneo/py(!log)/sqlite-zhash.go 3789 268.5 µs/object	# crc32:a50b90dc  nread=4905351  t=1.017792128s	# POLL·3 C1·135 C1E·10804 C3·6002 C6·4098
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 3789 159.1 µs/object	# crc32:a50b90dc  nread=4905351  t=603.047215ms	# POLL·7 C1·1536 C1E·14589 C3·2733 C6·2773
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 3789 163.7 µs/object	# crc32:a50b90dc  nread=4905351  t=620.568ms	# POLL·15 C1·1360 C1E·14189 C3·2925 C6·2969
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 3789 159.2 µs/object	# crc32:a50b90dc  nread=4905351  t=603.348444ms	# POLL·10 C1·1210 C1E·14607 C3·3018 C6·2516
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 3789 159.1 µs/object	# crc32:a50b90dc  nread=4905351  t=602.913518ms	# POLL·8 C1·1274 C1E·12989 C3·4854 C6·1494
Benchmarkneo/py(!log)/sqlite-zhash.go+prefetch128 3789 163.6 µs/object	# crc32:a50b90dc  nread=4905351  t=619.923978ms	# POLL·11 C1·1355 C1E·13960 C3·3475 C6·2523

# 1 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3705.8 req/s  269.844 latency-µs/object	# POLL·19 C1·6901 C1E·179371 C3·112417 C6·56181
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3770.6 req/s  265.208 latency-µs/object	# POLL·18 C1·9256 C1E·180684 C3·111903 C6·55783
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3806.4 req/s  262.715 latency-µs/object	# POLL·14 C1·11499 C1E·152818 C3·141591 C6·39575
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3545.2 req/s  282.068 latency-µs/object	# POLL·19 C1·2798 C1E·171354 C3·130225 C6·45028
Benchmarkneo/py(!log)/sqlite-zwrk.go·1 50000	3536.8 req/s  282.741 latency-µs/object	# POLL·9 C1·3847 C1E·152808 C3·145540 C6·40795

# 2 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5814.8 req/s  343.952 latency-µs/object	# POLL·24 C1·1195 C1E·367603 C3·137815 C6·35737
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5826.0 req/s  343.287 latency-µs/object	# POLL·21 C1·1882 C1E·371706 C3·138679 C6·34224
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5813.2 req/s  344.042 latency-µs/object	# POLL·23 C1·1440 C1E·363011 C3·142595 C6·35287
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5821.8 req/s  343.534 latency-µs/object	# POLL·41 C1·2366 C1E·377952 C3·132710 C6·35696
Benchmarkneo/py(!log)/sqlite-zwrk.go·2 100000	5811.7 req/s  344.136 latency-µs/object	# POLL·33 C1·3096 C1E·373515 C3·140524 C6·31876

# 3 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5776.9 req/s  519.307 latency-µs/object	# POLL·35 C1·1041 C1E·388054 C3·128276 C6·39209
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5774.7 req/s  519.504 latency-µs/object	# POLL·34 C1·2024 C1E·366574 C3·142146 C6·35750
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5765.9 req/s  520.299 latency-µs/object	# POLL·22 C1·1242 C1E·370936 C3·150228 C6·29512
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5763.1 req/s  520.555 latency-µs/object	# POLL·35 C1·1044 C1E·358971 C3·150233 C6·33651
Benchmarkneo/py(!log)/sqlite-zwrk.go·3 100000	5797.0 req/s  517.507 latency-µs/object	# POLL·38 C1·1171 C1E·359927 C3·152105 C6·29489

# 4 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5787.8 req/s  691.113 latency-µs/object	# POLL·32 C1·1422 C1E·369013 C3·146616 C6·31758
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5602.5 req/s  713.962 latency-µs/object	# POLL·37 C1·657 C1E·358467 C3·161959 C6·30359
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5500.9 req/s  727.155 latency-µs/object	# POLL·35 C1·1588 C1E·344924 C3·155720 C6·42928
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5739.2 req/s  696.961 latency-µs/object	# POLL·32 C1·981 C1E·381050 C3·135680 C6·34628
Benchmarkneo/py(!log)/sqlite-zwrk.go·4 100000	5736.3 req/s  697.317 latency-µs/object	# POLL·45 C1·652 C1E·356421 C3·149329 C6·34050

# 8 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5782.1 req/s  1383.573 latency-µs/object	# POLL·37 C1·1673 C1E·369473 C3·153971 C6·25800
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5748.7 req/s  1391.608 latency-µs/object	# POLL·53 C1·2612 C1E·381383 C3·146140 C6·30014
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5786.2 req/s  1382.601 latency-µs/object	# POLL·47 C1·2120 C1E·335616 C3·165901 C6·28100
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5912.3 req/s  1353.115 latency-µs/object	# POLL·45 C1·982 C1E·384503 C3·138922 C6·26230
Benchmarkneo/py(!log)/sqlite-zwrk.go·8 100000	5747.6 req/s  1391.896 latency-µs/object	# POLL·47 C1·1642 C1E·381501 C3·139617 C6·33090

# 12 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5739.5 req/s  2090.766 latency-µs/object	# POLL·35 C1·1877 C1E·358474 C3·157589 C6·28200
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5857.0 req/s  2048.847 latency-µs/object	# POLL·51 C1·1382 C1E·404307 C3·129764 C6·25326
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5892.5 req/s  2036.471 latency-µs/object	# POLL·43 C1·1299 C1E·399296 C3·134879 C6·26129
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5907.5 req/s  2031.332 latency-µs/object	# POLL·45 C1·1616 C1E·391562 C3·135177 C6·25492
Benchmarkneo/py(!log)/sqlite-zwrk.go·12 100000	5869.0 req/s  2044.625 latency-µs/object	# POLL·41 C1·1196 C1E·419026 C3·126862 C6·24395

# 16 clients in parallel
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5620.5 req/s  2846.731 latency-µs/object	# POLL·37 C1·795 C1E·365170 C3·159044 C6·25298
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5891.3 req/s  2715.878 latency-µs/object	# POLL·44 C1·1390 C1E·376355 C3·144943 C6·22632
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5779.7 req/s  2768.288 latency-µs/object	# POLL·37 C1·1255 C1E·384011 C3·144456 C6·25863
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5902.9 req/s  2710.516 latency-µs/object	# POLL·36 C1·1730 C1E·376651 C3·150149 C6·19855
Benchmarkneo/py(!log)/sqlite-zwrk.go·16 100000	5717.6 req/s  2798.395 latency-µs/object	# POLL·37 C1·2110 C1E·378476 C3·147990 C6·24555
2018-03-08 16:35:57.7039 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/py sql (logging disabled)
2018-03-08 16:35:57 140139801865600 [Note] mysqld (mysqld 10.1.25-MariaDB-1) starting as process 4773 ...
Benchmarkneo/py(!log)/sql-zhash.py 3789 1323.7 µs/object	# crc32:a50b90dc  nread=4905351  t=5.017s	# POLL·0 C1·151 C1E·39 C3·23194 C6·12246
Benchmarkneo/py(!log)/sql-zhash.py 3789 836.8 µs/object	# crc32:a50b90dc  nread=4905351  t=3.171s	# POLL·2 C1·2667 C1E·544 C3·19668 C6·10759
Benchmarkneo/py(!log)/sql-zhash.py 3789 811.9 µs/object	# crc32:a50b90dc  nread=4905351  t=3.077s	# POLL·1 C1·4712 C1E·525 C3·19090 C6·10735
Benchmarkneo/py(!log)/sql-zhash.py 3789 944.9 µs/object	# crc32:a50b90dc  nread=4905351  t=3.581s	# POLL·1 C1·170 C1E·2452 C3·24009 C6·5413
Benchmarkneo/py(!log)/sql-zhash.py 3789 890.1 µs/object	# crc32:a50b90dc  nread=4905351  t=3.374s	# POLL·2 C1·145 C1E·3938 C3·24594 C6·3295

Benchmarkneo/py(!log)/sql-zhash.go 3789 405.3 µs/object	# crc32:a50b90dc  nread=4905351  t=1.535950921s	# POLL·7 C1·931 C1E·15467 C3·14509 C6·5864
Benchmarkneo/py(!log)/sql-zhash.go 3789 345.8 µs/object	# crc32:a50b90dc  nread=4905351  t=1.310647656s	# POLL·3 C1·5981 C1E·12193 C3·6384 C6·11920
Benchmarkneo/py(!log)/sql-zhash.go 3789 327.8 µs/object	# crc32:a50b90dc  nread=4905351  t=1.242517244s	# POLL·3 C1·6885 C1E·10208 C3·9282 C6·10477
Benchmarkneo/py(!log)/sql-zhash.go 3789 374.6 µs/object	# crc32:a50b90dc  nread=4905351  t=1.419774419s	# POLL·4 C1·5911 C1E·10205 C3·16133 C6·4024
Benchmarkneo/py(!log)/sql-zhash.go 3789 363.5 µs/object	# crc32:a50b90dc  nread=4905351  t=1.377611739s	# POLL·0 C1·6238 C1E·10457 C3·14296 C6·7163
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 3789 259.9 µs/object	# crc32:a50b90dc  nread=4905351  t=985.050548ms	# POLL·6 C1·8028 C1E·13787 C3·6544 C6·7931
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 3789 291.0 µs/object	# crc32:a50b90dc  nread=4905351  t=1.102983647s	# POLL·9 C1·2605 C1E·14276 C3·15764 C6·3080
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 3789 238.4 µs/object	# crc32:a50b90dc  nread=4905351  t=903.403073ms	# POLL·9 C1·7975 C1E·14287 C3·6928 C6·7104
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 3789 253.1 µs/object	# crc32:a50b90dc  nread=4905351  t=959.207549ms	# POLL·10 C1·7035 C1E·14708 C3·7494 C6·6944
Benchmarkneo/py(!log)/sql-zhash.go+prefetch128 3789 267.5 µs/object	# crc32:a50b90dc  nread=4905351  t=1.013741221s	# POLL·4 C1·5011 C1E·14898 C3·11423 C6·4661

# 1 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·1 30000	2925.4 req/s  341.839 latency-µs/object	# POLL·19 C1·41027 C1E·167557 C3·131556 C6·79657
Benchmarkneo/py(!log)/sql-zwrk.go·1 50000	2475.1 req/s  404.022 latency-µs/object	# POLL·34 C1·33511 C1E·244989 C3·215331 C6·112538
Benchmarkneo/py(!log)/sql-zwrk.go·1 50000	2927.5 req/s  341.586 latency-µs/object	# POLL·23 C1·88434 C1E·189005 C3·201609 C6·123162
Benchmarkneo/py(!log)/sql-zwrk.go·1 50000	2726.1 req/s  366.831 latency-µs/object	# POLL·23 C1·69458 C1E·228141 C3·200174 C6·116559
Benchmarkneo/py(!log)/sql-zwrk.go·1 50000	2707.9 req/s  369.288 latency-µs/object	# POLL·25 C1·74278 C1E·201620 C3·199752 C6·127205

# 2 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	3909.2 req/s  511.619 latency-µs/object	# POLL·26 C1·91678 C1E·178248 C3·179974 C6·95762
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	4029.8 req/s  496.307 latency-µs/object	# POLL·28 C1·101912 C1E·165828 C3·179390 C6·91828
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	3929.6 req/s  508.959 latency-µs/object	# POLL·23 C1·90430 C1E·179579 C3·161634 C6·114953
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	3640.4 req/s  549.388 latency-µs/object	# POLL·41 C1·54668 C1E·205650 C3·182223 C6·99402
Benchmarkneo/py(!log)/sql-zwrk.go·2 50000	3622.9 req/s  552.041 latency-µs/object	# POLL·28 C1·52323 C1E·217141 C3·212615 C6·66891

# 3 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	3622.7 req/s  828.113 latency-µs/object	# POLL·29 C1·73967 C1E·178794 C3·189387 C6·98249
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	4115.7 req/s  728.922 latency-µs/object	# POLL·33 C1·104106 C1E·162572 C3·175406 C6·99915
Benchmarkneo/py(!log)/sql-zwrk.go·3 100000	4128.5 req/s  726.654 latency-µs/object	# POLL·42 C1·198642 C1E·286538 C3·298777 C6·181365
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	3999.1 req/s  750.177 latency-µs/object	# POLL·32 C1·93443 C1E·171992 C3·215040 C6·63430
Benchmarkneo/py(!log)/sql-zwrk.go·3 50000	4080.3 req/s  735.238 latency-µs/object	# POLL·17 C1·101903 C1E·176413 C3·166140 C6·105800

# 4 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·4 100000	4126.4 req/s  969.357 latency-µs/object	# POLL·40 C1·197053 C1E·308698 C3·303598 C6·165257
Benchmarkneo/py(!log)/sql-zwrk.go·4 50000	4191.7 req/s  954.264 latency-µs/object	# POLL·25 C1·110166 C1E·184936 C3·175054 C6·85854
Benchmarkneo/py(!log)/sql-zwrk.go·4 100000	4275.5 req/s  935.557 latency-µs/object	# POLL·31 C1·211070 C1E·296846 C3·349214 C6·126039
Benchmarkneo/py(!log)/sql-zwrk.go·4 50000	3689.2 req/s  1084.246 latency-µs/object	# POLL·18 C1·58215 C1E·203923 C3·215002 C6·71100
Benchmarkneo/py(!log)/sql-zwrk.go·4 100000	4283.4 req/s  933.828 latency-µs/object	# POLL·38 C1·222099 C1E·273671 C3·306351 C6·170034

# 8 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·8 100000	4225.7 req/s  1893.167 latency-µs/object	# POLL·55 C1·215972 C1E·279260 C3·305420 C6·167011
Benchmarkneo/py(!log)/sql-zwrk.go·8 100000	4103.5 req/s  1949.543 latency-µs/object	# POLL·61 C1·197287 C1E·312845 C3·320056 C6·143991
Benchmarkneo/py(!log)/sql-zwrk.go·8 100000	4085.5 req/s  1958.159 latency-µs/object	# POLL·60 C1·198912 C1E·293605 C3·338965 C6·138287
Benchmarkneo/py(!log)/sql-zwrk.go·8 100000	4204.0 req/s  1902.939 latency-µs/object	# POLL·42 C1·219431 C1E·326369 C3·266450 C6·178232
Benchmarkneo/py(!log)/sql-zwrk.go·8 50000	4259.0 req/s  1878.355 latency-µs/object	# POLL·26 C1·125088 C1E·172478 C3·162172 C6·93487

# 12 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·12 50000	3910.7 req/s  3068.511 latency-µs/object	# POLL·29 C1·78705 C1E·192105 C3·189689 C6·84575
Benchmarkneo/py(!log)/sql-zwrk.go·12 100000	4135.8 req/s  2901.474 latency-µs/object	# POLL·54 C1·194831 C1E·323715 C3·363265 C6·108482
Benchmarkneo/py(!log)/sql-zwrk.go·12 50000	4342.7 req/s  2763.289 latency-µs/object	# POLL·36 C1·112910 C1E·174823 C3·176091 C6·85188
Benchmarkneo/py(!log)/sql-zwrk.go·12 100000	4253.0 req/s  2821.519 latency-µs/object	# POLL·41 C1·204990 C1E·331144 C3·309290 C6·146158
Benchmarkneo/py(!log)/sql-zwrk.go·12 50000	3727.0 req/s  3219.742 latency-µs/object	# POLL·30 C1·65427 C1E·200077 C3·232398 C6·50891

# 16 clients in parallel
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	4221.0 req/s  3790.606 latency-µs/object	# POLL·35 C1·114245 C1E·189058 C3·163321 C6·90125
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	3714.9 req/s  4306.963 latency-µs/object	# POLL·31 C1·62661 C1E·213679 C3·185567 C6·88655
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	3762.1 req/s  4252.963 latency-µs/object	# POLL·41 C1·61593 C1E·213710 C3·220050 C6·53875
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	3874.7 req/s  4129.308 latency-µs/object	# POLL·18 C1·74551 C1E·223950 C3·187854 C6·76046
Benchmarkneo/py(!log)/sql-zwrk.go·16 50000	3905.9 req/s  4096.338 latency-µs/object	# POLL·37 C1·84727 C1E·185093 C3·173253 C6·97779
2018-03-08 16:48:48.1457 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/go fs1
unexpected packet: Retry Later in PrimaryBootstrapHandler
Connection to None lost
Benchmarkneo/go/fs1-zhash.py 3789 454.1 µs/object	# crc32:a50b90dc  nread=4905351  t=1.721s
# POLL·8 C1·2606 C1E·8194 C3·14483 C6·6852
Benchmarkneo/go/fs1-zhash.py 3789 484.1 µs/object	# crc32:a50b90dc  nread=4905351  t=1.835s	# POLL·2 C1·88 C1E·4397 C3·16123 C6·7752
Benchmarkneo/go/fs1-zhash.py 3789 521.7 µs/object	# crc32:a50b90dc  nread=4905351  t=1.977s	# POLL·5 C1·424 C1E·4692 C3·14997 C6·8756
Benchmarkneo/go/fs1-zhash.py 3789 527.3 µs/object	# crc32:a50b90dc  nread=4905351  t=1.998s	# POLL·7 C1·1263 C1E·4540 C3·18568 C6·4888
Benchmarkneo/go/fs1-zhash.py 3789 461.7 µs/object	# crc32:a50b90dc  nread=4905351  t=1.750s	# POLL·0 C1·24787 C1E·4631 C3·9748 C6·10928

Benchmarkneo/go/fs1-zhash.go 3789 81.9 µs/object	# crc32:a50b90dc  nread=4905351  t=310.544735ms	# POLL·11 C1·5892 C1E·24104 C3·747 C6·1793
Benchmarkneo/go/fs1-zhash.go 3789 79.3 µs/object	# crc32:a50b90dc  nread=4905351  t=300.493245ms	# POLL·13 C1·6554 C1E·23890 C3·623 C6·1349
Benchmarkneo/go/fs1-zhash.go 3789 81.5 µs/object	# crc32:a50b90dc  nread=4905351  t=308.852717ms	# POLL·8 C1·5690 C1E·24891 C3·1466 C6·591
Benchmarkneo/go/fs1-zhash.go 3789 85.6 µs/object	# crc32:a50b90dc  nread=4905351  t=324.31309ms	# POLL·12 C1·6116 C1E·24629 C3·1851 C6·819
Benchmarkneo/go/fs1-zhash.go 3789 78.9 µs/object	# crc32:a50b90dc  nread=4905351  t=299.109335ms	# POLL·10 C1·6534 C1E·23861 C3·1033 C6·987
Benchmarkneo/go/fs1-zhash.go+prefetch128 3789 23.5 µs/object	# crc32:a50b90dc  nread=4905351  t=89.00359ms	# POLL·74 C1·7017 C1E·5866 C3·564 C6·540
Benchmarkneo/go/fs1-zhash.go+prefetch128 3789 24.2 µs/object	# crc32:a50b90dc  nread=4905351  t=91.570104ms	# POLL·53 C1·7030 C1E·5541 C3·598 C6·710
Benchmarkneo/go/fs1-zhash.go+prefetch128 3789 24.1 µs/object	# crc32:a50b90dc  nread=4905351  t=91.166729ms	# POLL·56 C1·7125 C1E·5744 C3·556 C6·721
Benchmarkneo/go/fs1-zhash.go+prefetch128 3789 23.6 µs/object	# crc32:a50b90dc  nread=4905351  t=89.484734ms	# POLL·47 C1·7046 C1E·5565 C3·622 C6·666
Benchmarkneo/go/fs1-zhash.go+prefetch128 3789 23.9 µs/object	# crc32:a50b90dc  nread=4905351  t=90.639362ms	# POLL·64 C1·6889 C1E·5750 C3·728 C6·618

# 1 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·1 200000	13725.0 req/s  72.860 latency-µs/object	# POLL·246 C1·425409 C1E·1234486 C3·33336 C6·47038
Benchmarkneo/go/fs1-zwrk.go·1 200000	13748.4 req/s  72.736 latency-µs/object	# POLL·261 C1·427423 C1E·1232588 C3·32056 C6·49742
Benchmarkneo/go/fs1-zwrk.go·1 200000	13739.2 req/s  72.784 latency-µs/object	# POLL·311 C1·430912 C1E·1225632 C3·32000 C6·50354
E0308 16:50:07.855256    8284 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:38468: 192.168.0.16:5554 - 192.168.0.16:38468: accept: node link is not listening for incoming connections
Benchmarkneo/go/fs1-zwrk.go·1 200000	13795.5 req/s  72.487 latency-µs/object	# POLL·293 C1·429341 C1E·1226874 C3·32731 C6·46284
Benchmarkneo/go/fs1-zwrk.go·1 200000	13695.9 req/s  73.015 latency-µs/object	# POLL·289 C1·421643 C1E·1232909 C3·30986 C6·50754

# 2 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·2 500000	28043.2 req/s  71.318 latency-µs/object	# POLL·846 C1·661322 C1E·1044300 C3·48920 C6·67524
Benchmarkneo/go/fs1-zwrk.go·2 500000	27952.8 req/s  71.549 latency-µs/object	# POLL·921 C1·665574 C1E·1062104 C3·48909 C6·67028
E0308 16:51:19.424170    8284 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:38512: 192.168.0.16:5554 - 192.168.0.16:38512: accept: node link is not listening for incoming connections
Benchmarkneo/go/fs1-zwrk.go·2 500000	27897.5 req/s  71.691 latency-µs/object	# POLL·840 C1·662079 C1E·1062560 C3·48366 C6·68859
Benchmarkneo/go/fs1-zwrk.go·2 500000	27950.0 req/s  71.556 latency-µs/object	# POLL·926 C1·659787 C1E·1065070 C3·51385 C6·67446
Benchmarkneo/go/fs1-zwrk.go·2 500000	27999.8 req/s  71.429 latency-µs/object	# POLL·848 C1·663093 C1E·1044208 C3·48687 C6·67187

# 3 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·3 500000	40326.9 req/s  74.392 latency-µs/object	# POLL·995 C1·411261 C1E·875416 C3·35979 C6·44040
Benchmarkneo/go/fs1-zwrk.go·3 500000	40371.7 req/s  74.309 latency-µs/object	# POLL·1096 C1·412616 C1E·876211 C3·36503 C6·42663
Benchmarkneo/go/fs1-zwrk.go·3 500000	40257.2 req/s  74.521 latency-µs/object	# POLL·949 C1·410434 C1E·877995 C3·37258 C6·41645
Benchmarkneo/go/fs1-zwrk.go·3 500000	40272.6 req/s  74.492 latency-µs/object	# POLL·921 C1·409608 C1E·878978 C3·38559 C6·40839
Benchmarkneo/go/fs1-zwrk.go·3 500000	40263.6 req/s  74.509 latency-µs/object	# POLL·1043 C1·409417 C1E·878866 C3·37003 C6·44056

# 4 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·4 1000000	52762.7 req/s  75.811 latency-µs/object	# POLL·2979 C1·530615 C1E·1695108 C3·69683 C6·62491
E0308 16:53:40.911040    8284 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:38656: 192.168.0.16:5554 - 192.168.0.16:38656: accept: node link is not listening for incoming connections
Benchmarkneo/go/fs1-zwrk.go·4 1000000	52805.2 req/s  75.750 latency-µs/object	# POLL·3064 C1·532062 C1E·1689767 C3·70474 C6·62781
Benchmarkneo/go/fs1-zwrk.go·4 1000000	52878.9 req/s  75.645 latency-µs/object	# POLL·3007 C1·533980 C1E·1687919 C3·68056 C6·64151
Benchmarkneo/go/fs1-zwrk.go·4 1000000	52750.9 req/s  75.828 latency-µs/object	# POLL·2964 C1·534905 C1E·1691269 C3·68417 C6·63083
Benchmarkneo/go/fs1-zwrk.go·4 1000000	52799.8 req/s  75.758 latency-µs/object	# POLL·2935 C1·530236 C1E·1694251 C3·68498 C6·61797

# 8 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·8 1000000	91067.7 req/s  87.847 latency-µs/object	# POLL·41010 C1·779811 C1E·1480057 C3·20221 C6·10484
Benchmarkneo/go/fs1-zwrk.go·8 1000000	91098.3 req/s  87.817 latency-µs/object	# POLL·40782 C1·778359 C1E·1484473 C3·19537 C6·12761
Benchmarkneo/go/fs1-zwrk.go·8 1000000	90645.0 req/s  88.256 latency-µs/object	# POLL·41017 C1·785138 C1E·1488625 C3·20505 C6·11121
Benchmarkneo/go/fs1-zwrk.go·8 1000000	91017.6 req/s  87.895 latency-µs/object	# POLL·41337 C1·779858 C1E·1487051 C3·20059 C6·12676
Benchmarkneo/go/fs1-zwrk.go·8 1000000	91309.3 req/s  87.614 latency-µs/object	# POLL·40829 C1·779956 C1E·1476676 C3·20447 C6·10648

# 12 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·12 1000000	97794.4 req/s  122.706 latency-µs/object	# POLL·84016 C1·1121846 C1E·563089 C3·8295 C6·4655
Benchmarkneo/go/fs1-zwrk.go·12 1000000	98317.6 req/s  122.053 latency-µs/object	# POLL·83329 C1·1113827 C1E·557845 C3·7988 C6·4394
Benchmarkneo/go/fs1-zwrk.go·12 1000000	97692.9 req/s  122.834 latency-µs/object	# POLL·82999 C1·1125536 C1E·566737 C3·8329 C6·5501
Benchmarkneo/go/fs1-zwrk.go·12 1000000	98745.0 req/s  121.525 latency-µs/object	# POLL·82890 C1·1117246 C1E·560478 C3·7700 C6·4773
Benchmarkneo/go/fs1-zwrk.go·12 1000000	98702.7 req/s  121.577 latency-µs/object	# POLL·83012 C1·1116452 C1E·560793 C3·8406 C6·3632

# 16 clients in parallel
Benchmarkneo/go/fs1-zwrk.go·16 1000000	98408.6 req/s  162.587 latency-µs/object	# POLL·74880 C1·921560 C1E·380225 C3·11570 C6·4360
Benchmarkneo/go/fs1-zwrk.go·16 1000000	99798.8 req/s  160.323 latency-µs/object	# POLL·74149 C1·916012 C1E·378407 C3·10949 C6·4330
Benchmarkneo/go/fs1-zwrk.go·16 2000000	101963.8 req/s  156.918 latency-µs/object	# POLL·218761 C1·2686175 C1E·1045901 C3·25474 C6·8210
Benchmarkneo/go/fs1-zwrk.go·16 2000000	103486.3 req/s  154.610 latency-µs/object	# POLL·217627 C1·2675606 C1E·1038016 C3·23320 C6·7427
Benchmarkneo/go/fs1-zwrk.go·16 2000000	103461.8 req/s  154.647 latency-µs/object	# POLL·216823 C1·2669428 C1E·1033518 C3·22565 C6·7483
2018/03/08 16:58:37 accept tcp 192.168.0.16:5554: use of closed network connection
2018-03-08 16:58:37.1591 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/go fs1 (sha1 disabled on: storage, client)
# NEO/go (Sgo): skipping SHA1 computations
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 3789 68.3 µs/object	# crc32:a50b90dc  nread=4905351  t=258.930482ms
# POLL·5 C1·8636 C1E·20975 C3·258 C6·1598
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 3789 74.8 µs/object	# crc32:a50b90dc  nread=4905351  t=283.62734ms
# POLL·6 C1·6896 C1E·20593 C3·282 C6·1213
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 3789 69.4 µs/object	# crc32:a50b90dc  nread=4905351  t=263.116021ms
# POLL·11 C1·8932 C1E·19970 C3·397 C6·1220
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 3789 69.5 µs/object	# crc32:a50b90dc  nread=4905351  t=263.439409ms
# POLL·11 C1·9022 C1E·20743 C3·833 C6·811
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go(!sha1) 3789 70.3 µs/object	# crc32:a50b90dc  nread=4905351  t=266.449791ms
# POLL·9 C1·7744 C1E·21781 C3·669 C6·594
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 3789 21.1 µs/object	# crc32:a50b90dc  nread=4905351  t=79.895517ms
# POLL·35 C1·7895 C1E·3895 C3·774 C6·485
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 3789 20.6 µs/object	# crc32:a50b90dc  nread=4905351  t=78.164729ms
# POLL·64 C1·8293 C1E·4404 C3·926 C6·314
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 3789 21.2 µs/object	# crc32:a50b90dc  nread=4905351  t=80.414341ms
# POLL·62 C1·7812 C1E·4766 C3·974 C6·351
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 3789 21.2 µs/object	# crc32:a50b90dc  nread=4905351  t=80.213177ms
# POLL·72 C1·7909 C1E·4973 C3·861 C6·338
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zhash.go+prefetch128(!sha1) 3789 21.1 µs/object	# crc32:a50b90dc  nread=4905351  t=79.881211ms
# POLL·72 C1·7898 C1E·5165 C3·686 C6·584

# 1 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	16117.6 req/s  62.044 latency-µs/object
# POLL·191 C1·578296 C1E·1047117 C3·19340 C6·39926
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	16029.9 req/s  62.383 latency-µs/object
# POLL·169 C1·579085 C1E·1061643 C3·18100 C6·41168
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	16137.2 req/s  61.968 latency-µs/object
# POLL·153 C1·591130 C1E·1039911 C3·23715 C6·37850
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	16223.0 req/s  61.641 latency-µs/object
# POLL·167 C1·585816 C1E·1047695 C3·22746 C6·33202
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·1 200000	16088.8 req/s  62.155 latency-µs/object
# POLL·172 C1·598858 C1E·1037365 C3·24208 C6·39685

# 2 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	32885.4 req/s  60.817 latency-µs/object
# POLL·945 C1·862059 C1E·734353 C3·52024 C6·72514
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	32838.4 req/s  60.904 latency-µs/object
# POLL·945 C1·854215 C1E·720306 C3·52805 C6·72967
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	32961.6 req/s  60.677 latency-µs/object
# POLL·910 C1·858155 C1E·712528 C3·54193 C6·70433
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	32954.4 req/s  60.690 latency-µs/object
# POLL·965 C1·854982 C1E·724878 C3·53018 C6·70761
E0308 17:01:06.484264   12250 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:39658: 192.168.0.16:5554 - 192.168.0.16:39658: accept: node link is not listening for incoming connections
E0308 17:01:06.484370   12250 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:39656: 192.168.0.16:5554 - 192.168.0.16:39656: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·2 500000	32803.8 req/s  60.969 latency-µs/object
# POLL·927 C1·861827 C1E·717420 C3·53924 C6·70937

# 3 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	46140.5 req/s  65.019 latency-µs/object
# POLL·2352 C1·1158368 C1E·1285113 C3·87890 C6·88848
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	46234.7 req/s  64.886 latency-µs/object
# POLL·2406 C1·1151837 C1E·1283424 C3·88008 C6·88047
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	46202.5 req/s  64.931 latency-µs/object
# POLL·2369 C1·1155677 C1E·1285086 C3·87282 C6·90549
E0308 17:02:35.298391   12250 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:39724: 192.168.0.16:5554 - 192.168.0.16:39724: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	46172.5 req/s  64.974 latency-µs/object
# POLL·2288 C1·1158065 C1E·1284717 C3·83889 C6·94146
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·3 1000000	46203.3 req/s  64.930 latency-µs/object
# POLL·2270 C1·1157812 C1E·1279055 C3·89625 C6·88191

# 4 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	60133.0 req/s  66.519 latency-µs/object
# POLL·3489 C1·827371 C1E·1312468 C3·84685 C6·69291
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	60032.6 req/s  66.630 latency-µs/object
# POLL·3541 C1·828501 C1E·1315766 C3·84111 C6·71367
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	60080.1 req/s  66.578 latency-µs/object
# POLL·3509 C1·827364 C1E·1316202 C3·87637 C6·68685
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	60082.8 req/s  66.575 latency-µs/object
# POLL·3545 C1·831010 C1E·1314448 C3·82572 C6·72092
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·4 1000000	60084.0 req/s  66.573 latency-µs/object
# POLL·3504 C1·828086 C1E·1316406 C3·83972 C6·69714

# 8 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 1000000	99411.1 req/s  80.474 latency-µs/object
# POLL·39124 C1·996168 C1E·1136229 C3·25288 C6·15246
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 1000000	99658.1 req/s  80.274 latency-µs/object
# POLL·39078 C1·998828 C1E·1134773 C3·25176 C6·15222
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 1000000	99760.6 req/s  80.192 latency-µs/object
# POLL·39251 C1·1004299 C1E·1130354 C3·24516 C6·15492
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 1000000	99714.1 req/s  80.229 latency-µs/object
# POLL·38797 C1·993355 C1E·1137371 C3·25041 C6·15356
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·8 2000000	99358.5 req/s  80.517 latency-µs/object
# POLL·116739 C1·2956405 C1E·3343764 C3·72104 C6·42219

# 12 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	106167.1 req/s  113.029 latency-µs/object
# POLL·231812 C1·3494418 C1E·1371576 C3·24629 C6·14128
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	106259.8 req/s  112.931 latency-µs/object
# POLL·229251 C1·3492190 C1E·1392187 C3·24214 C6·14813
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	106420.6 req/s  112.760 latency-µs/object
# POLL·230974 C1·3498563 C1E·1388528 C3·24515 C6·13890
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	107005.9 req/s  112.143 latency-µs/object
# POLL·229936 C1·3490321 C1E·1368171 C3·23201 C6·14313
E0308 17:08:05.027590   12250 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40288: 192.168.0.16:5554 - 192.168.0.16:40288: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·12 2000000	106014.2 req/s  113.192 latency-µs/object
# POLL·229652 C1·3491475 C1E·1392756 C3·24531 C6·14518

# 16 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	108427.2 req/s  147.564 latency-µs/object
# POLL·210785 C1·2818509 C1E·932908 C3·27715 C6·10638
E0308 17:09:02.760266   12250 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40410: 192.168.0.16:5554 - 192.168.0.16:40410: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	109526.0 req/s  146.084 latency-µs/object
# POLL·209733 C1·2806685 C1E·931115 C3·25648 C6·9965
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	109486.9 req/s  146.136 latency-µs/object
# POLL·210222 C1·2818316 C1E·948535 C3·27436 C6·10511
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	110020.5 req/s  145.427 latency-µs/object
# POLL·209949 C1·2807469 C1E·921599 C3·25896 C6·9052
E0308 17:10:28.991540   12250 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40628: 192.168.0.16:5554 - 192.168.0.16:40628: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/fs1(!sha1)-zwrk.go(!sha1)·16 2000000	110544.6 req/s  144.738 latency-µs/object
# POLL·208917 C1·2795731 C1E·924784 C3·26624 C6·9617
2018/03/08 17:10:29 accept tcp 192.168.0.16:5554: use of closed network connection
2018-03-08 17:10:29.1485 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/go sqlite
Connection to None lost
Benchmarkneo/go/sqlite-zhash.py 3789 487.5 µs/object	# crc32:a50b90dc  nread=4905351  t=1.848s
# POLL·7 C1·3479 C1E·10779 C3·19711 C6·5086
Benchmarkneo/go/sqlite-zhash.py 3789 540.4 µs/object	# crc32:a50b90dc  nread=4905351  t=2.048s	# POLL·0 C1·216 C1E·12636 C3·15919 C6·8963
Benchmarkneo/go/sqlite-zhash.py 3789 530.9 µs/object	# crc32:a50b90dc  nread=4905351  t=2.012s	# POLL·1 C1·7112 C1E·13678 C3·16831 C6·5932
Benchmarkneo/go/sqlite-zhash.py 3789 527.2 µs/object	# crc32:a50b90dc  nread=4905351  t=1.998s	# POLL·2 C1·194 C1E·13114 C3·15872 C6·7581
Benchmarkneo/go/sqlite-zhash.py 3789 520.5 µs/object	# crc32:a50b90dc  nread=4905351  t=1.973s	# POLL·4 C1·2793 C1E·14140 C3·15530 C6·7429

Benchmarkneo/go/sqlite-zhash.go 3789 163.1 µs/object	# crc32:a50b90dc  nread=4905351  t=618.260072ms	# POLL·6 C1·505 C1E·30784 C3·4729 C6·4649
Benchmarkneo/go/sqlite-zhash.go 3789 154.1 µs/object	# crc32:a50b90dc  nread=4905351  t=583.982975ms	# POLL·5 C1·649 C1E·31356 C3·3704 C6·4256
Benchmarkneo/go/sqlite-zhash.go 3789 176.3 µs/object	# crc32:a50b90dc  nread=4905351  t=668.128001ms	# POLL·12 C1·427 C1E·28368 C3·10616 C6·1376
Benchmarkneo/go/sqlite-zhash.go 3789 184.5 µs/object	# crc32:a50b90dc  nread=4905351  t=699.355027ms	# POLL·4 C1·435 C1E·28583 C3·7595 C6·4178
Benchmarkneo/go/sqlite-zhash.go 3789 162.4 µs/object	# crc32:a50b90dc  nread=4905351  t=615.629191ms	# POLL·7 C1·602 C1E·30944 C3·5012 C6·4244
Benchmarkneo/go/sqlite-zhash.go+prefetch128 3789 36.2 µs/object	# crc32:a50b90dc  nread=4905351  t=137.330345ms	# POLL·101 C1·6028 C1E·9147 C3·942 C6·1216
Benchmarkneo/go/sqlite-zhash.go+prefetch128 3789 34.3 µs/object	# crc32:a50b90dc  nread=4905351  t=130.123932ms	# POLL·76 C1·6238 C1E·8149 C3·981 C6·1099
Benchmarkneo/go/sqlite-zhash.go+prefetch128 3789 35.7 µs/object	# crc32:a50b90dc  nread=4905351  t=135.477309ms	# POLL·81 C1·6118 C1E·8724 C3·1006 C6·1144
Benchmarkneo/go/sqlite-zhash.go+prefetch128 3789 34.7 µs/object	# crc32:a50b90dc  nread=4905351  t=131.36023ms	# POLL·64 C1·6145 C1E·7803 C3·1070 C6·988
Benchmarkneo/go/sqlite-zhash.go+prefetch128 3789 34.8 µs/object	# crc32:a50b90dc  nread=4905351  t=131.958122ms	# POLL·71 C1·6174 C1E·8095 C3·936 C6·1189

# 1 clients in parallel
E0308 17:11:06.272828   15990 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40722: 192.168.0.16:5554 - 192.168.0.16:40722: accept: node link is not listening for incoming connections
E0308 17:11:06.273454   15990 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40722: 192.168.0.16:5554 - 192.168.0.16:40722: accept: node link is not listening for incoming connections
Benchmarkneo/go/sqlite-zwrk.go·1 100000	5807.3 req/s  172.198 latency-µs/object	# POLL·78 C1·11340 C1E·859492 C3·215337 C6·107254
Benchmarkneo/go/sqlite-zwrk.go·1 100000	5731.5 req/s  174.475 latency-µs/object	# POLL·61 C1·8591 C1E·866418 C3·210081 C6·112900
Benchmarkneo/go/sqlite-zwrk.go·1 100000	5813.7 req/s  172.009 latency-µs/object	# POLL·73 C1·9705 C1E·877441 C3·198566 C6·110581
Benchmarkneo/go/sqlite-zwrk.go·1 100000	5770.9 req/s  173.282 latency-µs/object	# POLL·83 C1·9050 C1E·871848 C3·204902 C6·110763
E0308 17:12:25.971987   15990 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40750: 192.168.0.16:5554 - 192.168.0.16:40750: accept: node link is not listening for incoming connections
Benchmarkneo/go/sqlite-zwrk.go·1 100000	5596.2 req/s  178.693 latency-µs/object	# POLL·75 C1·10122 C1E·855018 C3·219164 C6·113523

# 2 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·2 200000	13351.1 req/s  149.800 latency-µs/object	# POLL·771 C1·101406 C1E·923729 C3·141819 C6·143269
Benchmarkneo/go/sqlite-zwrk.go·2 200000	13326.1 req/s  150.082 latency-µs/object	# POLL·726 C1·98232 C1E·923177 C3·139676 C6·146833
Benchmarkneo/go/sqlite-zwrk.go·2 200000	13381.1 req/s  149.465 latency-µs/object	# POLL·756 C1·99324 C1E·933427 C3·138769 C6·144797
E0308 17:13:31.896223   15990 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40802: 192.168.0.16:5554 - 192.168.0.16:40802: accept: node link is not listening for incoming connections
Benchmarkneo/go/sqlite-zwrk.go·2 200000	13423.1 req/s  148.996 latency-µs/object	# POLL·766 C1·101067 C1E·916342 C3·141283 C6·142946
Benchmarkneo/go/sqlite-zwrk.go·2 200000	13432.6 req/s  148.892 latency-µs/object	# POLL·674 C1·100904 C1E·924527 C3·143814 C6·137267

# 3 clients in parallel
E0308 17:14:04.403968   15990 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40826: 192.168.0.16:5554 - 192.168.0.16:40826: accept: node link is not listening for incoming connections
Benchmarkneo/go/sqlite-zwrk.go·3 300000	20336.0 req/s  147.522 latency-µs/object	# POLL·1314 C1·197535 C1E·925279 C3·138614 C6·132116
Benchmarkneo/go/sqlite-zwrk.go·3 300000	20394.8 req/s  147.097 latency-µs/object	# POLL·1295 C1·196259 C1E·926572 C3·139742 C6·129394
Benchmarkneo/go/sqlite-zwrk.go·3 300000	20346.6 req/s  147.445 latency-µs/object	# POLL·1385 C1·197707 C1E·926179 C3·138926 C6·130774
Benchmarkneo/go/sqlite-zwrk.go·3 300000	20377.2 req/s  147.224 latency-µs/object	# POLL·1276 C1·195779 C1E·919100 C3·143719 C6·133579
Benchmarkneo/go/sqlite-zwrk.go·3 300000	20409.1 req/s  146.993 latency-µs/object	# POLL·1196 C1·197057 C1E·918306 C3·141663 C6·133361

# 4 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·4 500000	26630.6 req/s  150.203 latency-µs/object	# POLL·2273 C1·293404 C1E·1281663 C3·175859 C6·138052
Benchmarkneo/go/sqlite-zwrk.go·4 500000	26806.5 req/s  149.218 latency-µs/object	# POLL·2245 C1·293235 C1E·1278170 C3·172630 C6·137581
E0308 17:16:07.954554   15990 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:40952: 192.168.0.16:5554 - 192.168.0.16:40952: accept: node link is not listening for incoming connections
Benchmarkneo/go/sqlite-zwrk.go·4 500000	26792.6 req/s  149.295 latency-µs/object	# POLL·2181 C1·294842 C1E·1282264 C3·171301 C6·137301
Benchmarkneo/go/sqlite-zwrk.go·4 500000	26857.7 req/s  148.933 latency-µs/object	# POLL·2268 C1·296367 C1E·1279789 C3·169381 C6·135631
Benchmarkneo/go/sqlite-zwrk.go·4 500000	26921.9 req/s  148.578 latency-µs/object	# POLL·2123 C1·297716 C1E·1271663 C3·169091 C6·138026

# 8 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	44962.8 req/s  177.925 latency-µs/object	# POLL·8692 C1·388019 C1E·1990424 C3·226260 C6·86757
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	45524.7 req/s  175.729 latency-µs/object	# POLL·8480 C1·384785 C1E·1970667 C3·218805 C6·82634
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	45727.8 req/s  174.948 latency-µs/object	# POLL·8651 C1·388369 C1E·1972390 C3·215099 C6·84160
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	45767.9 req/s  174.795 latency-µs/object	# POLL·8467 C1·383234 C1E·1968420 C3·214061 C6·83945
Benchmarkneo/go/sqlite-zwrk.go·8 1000000	45814.8 req/s  174.616 latency-µs/object	# POLL·8694 C1·382020 C1E·1971565 C3·210928 C6·86061

# 12 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	53448.4 req/s  224.515 latency-µs/object	# POLL·36391 C1·762865 C1E·1555321 C3·103556 C6·27788
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	53913.5 req/s  222.579 latency-µs/object	# POLL·36100 C1·760531 C1E·1546350 C3·99368 C6·25125
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	53895.5 req/s  222.653 latency-µs/object	# POLL·36152 C1·757211 C1E·1553014 C3·97180 C6·30210
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	53925.5 req/s  222.529 latency-µs/object	# POLL·36293 C1·763378 C1E·1551718 C3·94467 C6·27128
Benchmarkneo/go/sqlite-zwrk.go·12 1000000	54231.1 req/s  221.275 latency-µs/object	# POLL·36227 C1·762766 C1E·1545671 C3·98117 C6·26653

# 16 clients in parallel
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	50006.8 req/s  319.957 latency-µs/object	# POLL·57043 C1·951974 C1E·1005143 C3·93406 C6·16347
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	50119.9 req/s  319.235 latency-µs/object	# POLL·56938 C1·946515 C1E·995431 C3·93483 C6·16652
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	50392.6 req/s  317.507 latency-µs/object	# POLL·56574 C1·948924 C1E·1003912 C3·85065 C6·17218
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	51118.7 req/s  312.997 latency-µs/object	# POLL·56865 C1·948366 C1E·985859 C3·87243 C6·16749
Benchmarkneo/go/sqlite-zwrk.go·16 1000000	50878.4 req/s  314.476 latency-µs/object	# POLL·57298 C1·944803 C1E·993241 C3·85189 C6·16625
2018/03/08 17:22:15 accept tcp 192.168.0.16:5554: use of closed network connection
2018-03-08 17:22:15.6494 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed

*** NEO/go sqlite (sha1 disabled on: client)
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 3789 143.8 µs/object	# crc32:a50b90dc  nread=4905351  t=544.818596ms
# POLL·7 C1·879 C1E·33344 C3·2722 C6·3585
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 3789 170.9 µs/object	# crc32:a50b90dc  nread=4905351  t=647.837259ms
# POLL·3 C1·367 C1E·28784 C3·6827 C6·4278
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 3789 183.0 µs/object	# crc32:a50b90dc  nread=4905351  t=693.386365ms
# POLL·7 C1·516 C1E·28769 C3·7441 C6·4948
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 3789 169.4 µs/object	# crc32:a50b90dc  nread=4905351  t=641.969924ms
# POLL·6 C1·659 C1E·29834 C3·5798 C6·4733
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go(!sha1) 3789 170.2 µs/object	# crc32:a50b90dc  nread=4905351  t=645.205203ms
# POLL·8 C1·538 C1E·28497 C3·10028 C6·1600
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 3789 35.5 µs/object	# crc32:a50b90dc  nread=4905351  t=134.5307ms
# POLL·72 C1·6497 C1E·8236 C3·1892 C6·478
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 3789 34.6 µs/object	# crc32:a50b90dc  nread=4905351  t=131.049215ms
# POLL·66 C1·6598 C1E·8374 C3·876 C6·1185
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 3789 35.5 µs/object	# crc32:a50b90dc  nread=4905351  t=134.401863ms
# POLL·47 C1·6120 C1E·6491 C3·1203 C6·1351
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 3789 34.1 µs/object	# crc32:a50b90dc  nread=4905351  t=129.145395ms
# POLL·100 C1·6732 C1E·8395 C3·1139 C6·1026
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zhash.go+prefetch128(!sha1) 3789 35.1 µs/object	# crc32:a50b90dc  nread=4905351  t=133.182208ms
# POLL·77 C1·6589 C1E·8705 C3·1037 C6·1036

# 1 clients in parallel
E0308 17:22:40.698143   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:41872: 192.168.0.16:5554 - 192.168.0.16:41872: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	5905.5 req/s  169.335 latency-µs/object
# POLL·80 C1·11133 C1E·839920 C3·233035 C6·98155
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	5861.7 req/s  170.599 latency-µs/object
# POLL·74 C1·10610 C1E·857436 C3·211522 C6·105410
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	6066.4 req/s  164.842 latency-µs/object
# POLL·71 C1·11613 C1E·862032 C3·198080 C6·101982
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	6008.5 req/s  166.432 latency-µs/object
# POLL·64 C1·10636 C1E·861984 C3·212025 C6·98673
E0308 17:23:58.310970   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:41904: 192.168.0.16:5554 - 192.168.0.16:41904: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·1 100000	5741.5 req/s  174.169 latency-µs/object
# POLL·70 C1·9185 C1E·840168 C3·228414 C6·111830

# 2 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13612.5 req/s  146.923 latency-µs/object
# POLL·809 C1·111187 C1E·857488 C3·167693 C6·159395
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13561.5 req/s  147.476 latency-µs/object
# POLL·787 C1·109605 C1E·850544 C3·170977 C6·161733
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13616.1 req/s  146.885 latency-µs/object
# POLL·775 C1·108318 C1E·852551 C3·167543 C6·162966
E0308 17:25:02.922719   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:41950: 192.168.0.16:5554 - 192.168.0.16:41950: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13609.4 req/s  146.958 latency-µs/object
# POLL·782 C1·109252 C1E·855077 C3·172689 C6·159951
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·2 200000	13636.1 req/s  146.669 latency-µs/object
# POLL·811 C1·109177 C1E·869184 C3·167064 C6·161484

# 3 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20799.2 req/s  144.236 latency-µs/object
# POLL·1368 C1·211222 C1E·867292 C3·173448 C6·146357
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20768.3 req/s  144.451 latency-µs/object
# POLL·1333 C1·210345 C1E·873831 C3·169129 C6·147039
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20891.0 req/s  143.603 latency-µs/object
# POLL·1458 C1·213194 C1E·880462 C3·157031 C6·146021
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	20949.7 req/s  143.200 latency-µs/object
# POLL·1374 C1·212745 C1E·873428 C3·159292 C6·146141
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·3 300000	21027.5 req/s  142.671 latency-µs/object
# POLL·1410 C1·216168 C1E·871342 C3·166079 C6·135970

# 4 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	27500.9 req/s  145.450 latency-µs/object
# POLL·2469 C1·330474 C1E·1217124 C3·194786 C6·151254
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	27559.2 req/s  145.142 latency-µs/object
# POLL·2456 C1·331019 C1E·1211845 C3·190744 C6·157552
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	27671.3 req/s  144.554 latency-µs/object
# POLL·2385 C1·332501 C1E·1211552 C3·200648 C6·140023
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	27726.1 req/s  144.268 latency-µs/object
# POLL·2343 C1·332188 C1E·1205812 C3·198674 C6·144035
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·4 500000	27673.3 req/s  144.544 latency-µs/object
# POLL·2410 C1·329363 C1E·1210851 C3·194379 C6·150069

# 8 clients in parallel
E0308 17:28:35.919699   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:42170: 192.168.0.16:5554 - 192.168.0.16:42170: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	45763.8 req/s  174.811 latency-µs/object
# POLL·10002 C1·463579 C1E·1897474 C3·248878 C6·96978
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	46654.9 req/s  171.472 latency-µs/object
# POLL·9627 C1·458980 C1E·1862426 C3·241072 C6·94718
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	46795.0 req/s  170.959 latency-µs/object
# POLL·9452 C1·458248 C1E·1852147 C3·248117 C6·89633
E0308 17:29:46.095448   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:42286: 192.168.0.16:5554 - 192.168.0.16:42286: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	47108.6 req/s  169.820 latency-µs/object
# POLL·9336 C1·456929 C1E·1856471 C3·236525 C6·91532
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·8 1000000	47147.1 req/s  169.682 latency-µs/object
# POLL·9373 C1·456443 C1E·1847798 C3·233378 C6·90813

# 12 clients in parallel
E0308 17:30:29.417388   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:42388: 192.168.0.16:5554 - 192.168.0.16:42388: accept: node link is not listening for incoming connections
E0308 17:30:29.417607   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:42390: 192.168.0.16:5554 - 192.168.0.16:42390: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	54929.8 req/s  218.460 latency-µs/object
# POLL·34957 C1·804255 C1E·1461706 C3·99746 C6·29772
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	55122.9 req/s  217.695 latency-µs/object
# POLL·34828 C1·801202 C1E·1454261 C3·102842 C6·28498
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	55444.6 req/s  216.432 latency-µs/object
# POLL·34542 C1·797792 C1E·1457956 C3·96911 C6·27722
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	55228.9 req/s  217.278 latency-µs/object
# POLL·34725 C1·802540 C1E·1458763 C3·96424 C6·27903
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·12 1000000	55410.9 req/s  216.564 latency-µs/object
# POLL·34209 C1·797206 C1E·1450177 C3·101123 C6·28041

# 16 clients in parallel
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	51410.9 req/s  311.218 latency-µs/object
# POLL·53697 C1·949210 C1E·928025 C3·93396 C6·16644
E0308 17:32:32.206952   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:42740: 192.168.0.16:5554 - 192.168.0.16:42740: accept: node link is not listening for incoming connections
E0308 17:32:32.207145   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:42732: 192.168.0.16:5554 - 192.168.0.16:42732: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	51426.2 req/s  311.125 latency-µs/object
# POLL·53483 C1·944521 C1E·933391 C3·87434 C6·17735
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	50861.3 req/s  314.581 latency-µs/object
# POLL·53927 C1·954191 C1E·944910 C3·93718 C6·17364
E0308 17:33:15.424358   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:42868: 192.168.0.16:5554 - 192.168.0.16:42868: accept: node link is not listening for incoming connections
E0308 17:33:15.424359   19941 storage.go:522] storage(192.168.0.16:5554): accept: serve 192.168.0.16:5554 - 192.168.0.16:42868: 192.168.0.16:5554 - 192.168.0.16:42868: accept: node link is not listening for incoming connections
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	51316.3 req/s  311.792 latency-µs/object
# POLL·53810 C1·949574 C1E·933944 C3·90555 C6·19758
# NEO/go (tzodb_go): skipping SHA1 computations
Benchmarkneo/go/sqlite-zwrk.go(!sha1)·16 1000000	52414.1 req/s  305.262 latency-µs/object
# POLL·53621 C1·945134 C1E·916778 C3·91183 C6·15155
2018/03/08 17:33:36 accept tcp 192.168.0.16:5554: use of closed network connection
2018-03-08 17:33:36.8450 ERROR     NEO        [           app: 91] primary master is down
Cluster state changed