__step=000385
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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_bst_kcas_validate.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000385.txt
__path_data=data/data000385.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55aadfe5e400
addrof(kcasDescriptors[1])=0x55aadfe5ed00
addrof(rdcssDescriptors[0])=0x55aadff7e400
addrof(rdcssDescriptors[1])=0x55aadff7e4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6999451.807867496
binary=./sigouin_int_bst_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=sigouin_int_bst_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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=5.0 5.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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.008s
prefilling_size=1001764 prefilling_elapsed_millis=1.001s
finished prefilling to size 1001743 for expected size 1000000 keysum=1001857882557, performing 38400617 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1001743
pref_millis=1102
prefill_elapsed_ms=1133
main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6999453.122073317
REALTIME_END_PERF_FORMAT=6999463.122218594

###############################################################################
################################## 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 (192 threads)...
partitioned into 971 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.05s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 494 952 1734 3053 5099 8106 12276 17641 24063 31335 39021 46368 52136 55610 56650 55173 51310 45380 38432 30750 23816 17727 12574 8846 5725 3724 2321 1452 836 464 228 102 47 21 8 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 11 19 97 237 590 1126 2218 3689 6109 9088 12758 17072 21751 25926 29106 30884 31166 30087 27583 24289 19821 15583 12060 8459 6138 3977 2676 1663 1072 612 357 185 71 37 19 6 3
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 505 971 1831 3290 5689 9232 14494 21330 30172 40423 51779 63440 73887 81536 85756 86057 82476 75467 66015 55039 43637 33310 24634 17305 11863 7701 4997 3115 1908 1076 585 287 118 58 27 8 3
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 505 971 1831 3290 5689 9232 14494 21330 30172 40423 51779 63440 73887 81536 85756 86057 82476 75467 66015 55039 43637 33310 24634 17305 11863 7701 4997 3115 1908 1076 585 287 118 58 27 8 3
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.97656 1.94455 1.90525 1.84981 1.80122 1.72649 1.69194 1.62467 1.58748 1.54222 1.50575 1.4716 1.43378 1.3979 1.36973 1.34291 1.31727 1.2929 1.27343 1.25156 1.23414 1.21757 1.20736 1.19205 1.17434 1.16657 1.1653 1.1589 1.14639 1.12579 1.11245 1.10085 1.05575 1.09322 1.10345 1 1.125 1

tree_stats_height=46
tree_stats_numInternals=653986
tree_stats_numLeaves=346546
tree_stats_numNodes=1000532
tree_stats_numKeys=1000532

tree_stats_avgDegreeInternal=1.5299
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34636
tree_stats_avgKeyDepth=23.7278


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:50 2:1602 4:54613 8:372501 16:51135
    [2^00, 2^01]: 50
    (2^01, 2^02]: 1602
    (2^02, 2^03]: 54613
    (2^03, 2^04]: 372501
    (2^04, 2^05]: 51135
sum_limbo_reclamation_event_size_total=5442028
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479901
sum_limbo_reclamation_event_count_total=1014336
first_thread_announced_epoch_by_thread=45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828 45828
sum_num_inserts_by_thread=470390 482245 477256 488864 475679 469599 481872 472787 492688 481361 485526 472553 483932 476437 480371 489356 487870 473720 480177 474360 488155 488780 474659 472108 470585 472941 487377 479535 477047 470516 483818 474467 481717 480692 475927 473024 474581 476346 491014 479550 477977 483570 480626 474710 489753 479550 471807 481968
sum_num_inserts_total=23009843
sum_num_deletes_by_thread=469855 483368 477667 488372 476546 468156 481444 472953 490311 481706 486133 474033 481713 476138 480899 488355 487411 474556 480583 473477 490092 490308 474612 471692 470515 473139 485980 479581 476485 471323 482563 475116 481720 481921 475657 473464 474602 474768 490070 479948 479365 484287 481338 473403 488565 478949 471891 481421
sum_num_deletes_total=23006451
sum_num_searches_by_thread=8462217 8699500 8594753 8775451 8567156 8436570 8678216 8519735 8842189 8662776 8730217 8516536 8687064 8563473 8649856 8820483 8780560 8532355 8656744 8537108 8787857 8814415 8544653 8470703 8469226 8522610 8769324 8623189 8576556 8471591 8698612 8562488 8671460 8649755 8565076 8515681 8538454 8568449 8821751 8650410 8608630 8710195 8653450 8525981 8799286 8623534 8500746 8665572
sum_num_searches_total=414092613
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9402462 9665113 9549676 9752687 9519381 9374325 9641532 9465475 9825188 9625843 9701876 9463122 9652709 9516048 9611126 9798194 9755841 9480631 9617504 9484945 9766104 9793503 9493924 9414503 9410326 9468690 9742681 9582305 9530088 9413430 9664993 9512071 9634897 9612368 9516660 9462169 9487637 9519563 9802835 9609908 9565972 9678052 9615414 9474094 9777604 9582033 9444444 9628961
average_num_operations_total=9585602
stdev_num_operations_total=18083
sum_num_operations_total=460108907
min_num_operations_total=9374325
max_num_operations_total=9825188
first_time_thread_terminate_by_thread=10000144 10000145 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000145 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144 10000144
min_time_thread_terminate_total=10000144
max_time_thread_terminate_total=10000145
first_time_thread_start_by_thread=4 5 5 5 5 5 4 5 4 4 5 4 5 5 4 4 4 4 4 4 5 5 5 4 4 5 5 5 5 5 4 5 4 4 5 4 5 5 4 4 4 4 4 4 5 5 5 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=999508417579
threads_final_size=1000532
final_keysum=999508417579
final_size=1000532
validate_result=success
Validation OK.
Structural validation OK.

total_find=414092613
total_rq=0
total_inserts=23009843
total_deletes=23006451
total_updates=46016294
total_queries=414092613
total_ops=460108907
find_throughput=41409261
rq_throughput=0
update_throughput=4601629
query_throughput=41409261
total_throughput=46010890


total find                    : 414092613
total rq                      : 0
total inserts                 : 23009843
total deletes                 : 23006451
total updates                 : 46016294
total queries                 : 414092613
total ops                     : 460108907
find throughput               : 41409261
rq throughput                 : 0
update throughput             : 4601629
query throughput              : 41409261
total throughput              : 46010890

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=16.2505
PAPI_L3_TCM=2.21002
PAPI_TOT_CYC=2893.45
PAPI_TOT_INS=1331.73
garbage=207029485273330
total_execution_walltime=11.47s
REALTIME_MAIN_END_PERF_FORMAT=6999463.278943743
[time_cmd_output] time_elapsed_sec=11.60, faults_major=0, faults_minor=91920, mem_maxresident_kb=369732, user_cputime=558.63, sys_cputime=1.89, percent_cpu=4829%
timeout=false
algorithm=sigouin_int_bst_kcas_validate.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1