__step=000889
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 numactl -i all /usr/bin/time -f "[time_cmd_output] time_elapsed_sec=%e, faults_major=%F, faults_minor=%R, mem_maxresident_kb=%M, user_cputime=%U, sys_cputime=%S, percent_cpu=%P" ./sigouin_int_avl_kcas_validate.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000889.txt
__path_data=data/data000889.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x564a0fe0b3c0
addrof(kcasDescriptors[1])=0x564a0fe0bcc0
addrof(rdcssDescriptors[0])=0x564a0ff2b3c0
addrof(rdcssDescriptors[1])=0x564a0ff2b480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=217567.83938381
binary=./sigouin_int_avl_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=sigouin_int_avl_kcas_validate
FIND_FUNC=FIND_FUNC
INSERT_FUNC=insertIfAbsent
ERASE_FUNC=ERASE_FUNC
RQ_FUNC=RQ_FUNC
RECLAIM=reclaimer_debra
ALLOC=allocator_new
POOL=pool_none
MAX_THREADS_POW2=512
CPU_FREQ_GHZ=2.1
MILLIS_TO_RUN=10000
INS_FRAC=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=50.0 50.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=56
ACTUAL_THREAD_BINDINGS=0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.023s
prefilling_size=1000504 prefilling_elapsed_millis=1s
finished prefilling to size 1000511 for expected size 1000000 keysum=1000830804904, performing 30213714 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=1000511
pref_millis=1101
prefill_elapsed_ms=1117
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=217568.245728092
REALTIME_END_PERF_FORMAT=217578.245813502
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (256 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.053s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65192 120965 166903 121054 32531 2178 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 326 8259 61759 162811 148288 41584 2745
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65518 129224 228662 283865 180819 43762 2745
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65518 129224 228662 283865 180819 43762 2745
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99948 1.97732 1.83341 1.51151 1.21054 1.06211 1.01296 1
tree_stats_height=23
tree_stats_numInternals=574357
tree_stats_numLeaves=425773
tree_stats_numNodes=1000130
tree_stats_numKeys=1000130
tree_stats_avgDegreeInternal=1.7413
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42572
tree_stats_avgKeyDepth=18.2654
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:35 2:4 4:8 8:10 16:15 32:102 64:21044 128:488253 256:308 512:196
[2^00, 2^01]: 35
(2^01, 2^02]: 4
(2^02, 2^03]: 8
(2^03, 2^04]: 10
(2^04, 2^05]: 15
(2^05, 2^06]: 102
(2^06, 2^07]: 21044
(2^07, 2^08]: 488253
(2^08, 2^09]: 308
(2^09, 2^10]: 196
sum_limbo_reclamation_event_size_total=74862558
count_limbo_reclamation_event_size_by_thread=7969 7968 7969 7966 7967 7969 7968 7969 7970 7969 7968 7968 7968 7968 7969 7968 7968 7968 7969 7968 7969 7968 7969 7968 7968 7969 7969 7970 7969 7970 7969 7969 7968 7967 7968 7967 7968 7969 7968 7968 7968 7969 7970 7968 7968 7968 7968 7969 7969 7969 7967 7969 7967 7968 7968 7968 7969 7967 7968 7969 7968 7969 7969 7967
count_limbo_reclamation_event_size_total=509975
sum_limbo_reclamation_event_count_total=510205
first_thread_announced_epoch_by_thread=17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564 17564
sum_num_inserts_by_thread=2371231 2363730 2350938 2342756 2369708 2361634 2359503 2355819 2348217 2352193 2348298 2340703 2339310 2337238 2336741 2331267 2318014 2325340 2352660 2348947 2349340 2338894 2337840 2337199 2338691 2330463 2316838 2306579 2316374 2322326 2318027 2314586 2354339 2352748 2349006 2346860 2354630 2348600 2346919 2333757 2332140 2321958 2314498 2324893 2328124 2328185 2319165 2353259 2349580 2345608 2331658 2334855 2345220 2335763 2323921 2313315 2329298 2331134 2325577 2340145 2352302 2373413 2364147 2371952
sum_num_inserts_total=149758373
sum_num_deletes_by_thread=2372626 2368385 2350310 2340741 2369030 2361943 2356274 2357956 2353224 2349583 2348187 2340431 2341798 2338221 2335442 2332227 2320957 2325656 2356646 2347961 2351042 2338471 2339289 2336801 2340106 2330685 2317287 2308674 2318296 2322671 2317189 2314743 2358181 2356470 2346861 2351934 2357047 2350368 2345458 2333779 2328837 2320346 2311233 2324944 2327997 2329816 2318267 2355450 2348244 2346754 2333357 2333575 2342110 2336202 2322897 2314752 2330158 2326059 2324350 2338582 2349405 2371496 2361792 2370167
sum_num_deletes_total=149769740
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4743857 4732115 4701248 4683497 4738738 4723577 4715777 4713775 4701441 4701776 4696485 4681134 4681108 4675459 4672183 4663494 4638971 4650996 4709306 4696908 4700382 4677365 4677129 4674000 4678797 4661148 4634125 4615253 4634670 4644997 4635216 4629329 4712520 4709218 4695867 4698794 4711677 4698968 4692377 4667536 4660977 4642304 4625731 4649837 4656121 4658001 4637432 4708709 4697824 4692362 4665015 4668430 4687330 4671965 4646818 4628067 4659456 4657193 4649927 4678727 4701707 4744909 4725939 4742119
average_num_operations_total=4680126
stdev_num_operations_total=4077
sum_num_operations_total=299528113
min_num_operations_total=4615253
max_num_operations_total=4744909
first_time_thread_terminate_by_thread=10000088 10000088 10000088 10000088 10000085 10000085 10000085 10000085 10000086 10000086 10000086 10000086 10000086 10000086 10000086 10000088 10000088 10000088 10000088 10000088 10000087 10000089 10000089 10000087 10000088 10000090 10000088 10000088 10000085 10000085 10000085 10000085 10000088 10000088 10000088 10000088 10000087 10000087 10000091 10000087 10000097 10000087 10000087 10000087 10000086 10000086 10000088 10000086 10000086 10000087 10000087 10000086 10000085 10000085 10000087 10000087 10000087 10000087 10000087 10000089 10000088 10000088 10000088 10000088
min_time_thread_terminate_total=10000085
max_time_thread_terminate_total=10000097
first_time_thread_start_by_thread=8 8 8 8 9 9 9 9 7 7 7 7 14 14 14 14 10 10 10 10 9 9 9 9 11 11 11 11 7 8 8 8 12 12 12 12 12 12 12 12 11 11 11 11 10 10 10 10 11 11 11 11 10 10 10 10 15 15 15 15 13 13 13 13
min_time_thread_start_total=7
max_time_thread_start_total=15
sum_duration_all_ops_total=
threads_final_keysum=1000937981402
threads_final_size=1000130
final_keysum=1000937981402
final_size=1000130
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=149758373
total_deletes=149769740
total_updates=299528113
total_queries=0
total_ops=299528113
find_throughput=0
rq_throughput=0
update_throughput=29952811
query_throughput=0
total_throughput=29952811
total find : 0
total rq : 0
total inserts : 149758373
total deletes : 149769740
total updates : 299528113
total queries : 0
total ops : 299528113
find throughput : 0
rq throughput : 0
update throughput : 29952811
query throughput : 0
total throughput : 29952811
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=0
total_execution_walltime=11.308s
REALTIME_MAIN_END_PERF_FORMAT=217578.392717870
[time_cmd_output] time_elapsed_sec=11.41, faults_major=0, faults_minor=92467, mem_maxresident_kb=369532, user_cputime=728.49, sys_cputime=4.26, percent_cpu=6417%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1