__step=000170
__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 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000170.txt
__path_data=data/data000170.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55ea14022400
addrof(kcasDescriptors[1])=0x55ea14022d00
addrof(rdcssDescriptors[0])=0x55ea14142400
addrof(rdcssDescriptors[1])=0x55ea141424c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996440.172346879
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=20000000
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.004s
prefilling_size=6840686 prefilling_elapsed_millis=1.001s
prefilling_size=7126016 prefilling_elapsed_millis=1.101s
prefilling_size=7383644 prefilling_elapsed_millis=1.201s
prefilling_size=7614582 prefilling_elapsed_millis=1.301s
prefilling_size=7823487 prefilling_elapsed_millis=1.402s
prefilling_size=8013091 prefilling_elapsed_millis=1.502s
prefilling_size=8183081 prefilling_elapsed_millis=1.602s
prefilling_size=8336144 prefilling_elapsed_millis=1.702s
prefilling_size=8476835 prefilling_elapsed_millis=1.802s
prefilling_size=8606605 prefilling_elapsed_millis=1.903s
prefilling_size=8723123 prefilling_elapsed_millis=2.003s
prefilling_size=8828690 prefilling_elapsed_millis=2.103s
prefilling_size=8926187 prefilling_elapsed_millis=2.203s
prefilling_size=9014069 prefilling_elapsed_millis=2.303s
prefilling_size=9092481 prefilling_elapsed_millis=2.404s
prefilling_size=9164395 prefilling_elapsed_millis=2.504s
prefilling_size=9231600 prefilling_elapsed_millis=2.604s
prefilling_size=9293435 prefilling_elapsed_millis=2.704s
prefilling_size=9350695 prefilling_elapsed_millis=2.804s
prefilling_size=9401933 prefilling_elapsed_millis=2.905s
prefilling_size=9450057 prefilling_elapsed_millis=3.005s
prefilling_size=9493824 prefilling_elapsed_millis=3.105s
prefilling_size=9534167 prefilling_elapsed_millis=3.205s
prefilling_size=9570920 prefilling_elapsed_millis=3.305s
prefilling_size=9604126 prefilling_elapsed_millis=3.406s
prefilling_size=9635620 prefilling_elapsed_millis=3.506s
prefilling_size=9666157 prefilling_elapsed_millis=3.606s
prefilling_size=9692419 prefilling_elapsed_millis=3.706s
prefilling_size=9715847 prefilling_elapsed_millis=3.806s
prefilling_size=9738358 prefilling_elapsed_millis=3.907s
prefilling_size=9757638 prefilling_elapsed_millis=4.007s
prefilling_size=9775987 prefilling_elapsed_millis=4.107s
prefilling_size=9792151 prefilling_elapsed_millis=4.207s
prefilling_size=9807177 prefilling_elapsed_millis=4.307s
finished prefilling to size 9807218 for expected size 10000000 keysum=98051213310258, performing 89440607 updates; total_prefilling_elapsed_ms=4408 ms)
pref_size=9807218
pref_millis=4408
prefill_elapsed_ms=4426
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6996444.774714267
REALTIME_END_PERF_FORMAT=6996454.774873983
###############################################################################
################################## 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 919 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.132s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 126 243 469 896 1691 3093 5469 9417 15605 24984 38695 58236 84727 118836 161041 210805 264994 321852 377346 426730 464130 486522 492635 481369 454460 413063 362352 306077 249821 196682 148547 107994 75196 50312 32530 20359 12147 6824 3710 1865 963 472 226 124 76 44 22 7 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 5 12 23 56 157 383 870 1779 3438 6239 10447 17325 27478 41358 59742 84035 111623 142413 174718 206913 235025 254710 266751 267986 261149 243672 219890 190118 158377 127819 98653 73077 52012 35555 23148 14651 9058 5081 2861 1417 749 369 178 87 52 37 22 3 3 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 248 481 919 1747 3250 5852 10287 17384 28422 44934 68683 102052 146314 202399 270547 349029 433475 519759 601448 671043 721547 747345 748120 722446 674212 606024 525967 439939 355059 276366 206647 148273 102324 68085 43507 26798 15882 8791 4726 2380 1221 595 302 163 96 59 29 7 4 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 248 481 919 1747 3250 5852 10287 17384 28422 44934 68683 102052 146314 202399 270547 349029 433475 519759 601448 671043 721547 747345 748120 722446 674212 606024 525967 439939 355059 276366 206647 148273 102324 68085 43507 26798 15882 8791 4726 2380 1221 595 302 163 96 59 29 7 4 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.96063 1.95968 1.93555 1.92601 1.89239 1.84892 1.82331 1.77447 1.73729 1.70192 1.66738 1.63795 1.60349 1.57112 1.54104 1.51091 1.48271 1.45656 1.43117 1.40621 1.38361 1.36148 1.34186 1.32224 1.30418 1.2862 1.26998 1.25451 1.23921 1.22442 1.21023 1.19492 1.18296 1.17369 1.16122 1.148 1.13938 1.12385 1.11557 1.10897 1.1084 1.10074 1.12773 1.12914 1.1227 1.15625 1.11864 1 1 1 1
tree_stats_height=58
tree_stats_numInternals=6493916
tree_stats_numLeaves=3431526
tree_stats_numNodes=9925442
tree_stats_numKeys=9925442
tree_stats_avgDegreeInternal=1.52842
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34573
tree_stats_avgKeyDepth=29.5082
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:68 2:1621 4:55813 8:371328 16:51068
[2^00, 2^01]: 68
(2^01, 2^02]: 1621
(2^02, 2^03]: 55813
(2^03, 2^04]: 371328
(2^04, 2^05]: 51068
sum_limbo_reclamation_event_size_total=5426462
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9996 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479898
sum_limbo_reclamation_event_count_total=503664
first_thread_announced_epoch_by_thread=29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142 29142
sum_num_inserts_by_thread=240980 237569 242438 239957 238719 237355 239954 238478 241608 244394 240949 239340 237338 239775 242847 238827 240544 236788 240100 237463 239713 243926 237549 234716 240125 237874 239602 239943 242321 239581 241302 237504 241224 241496 242132 237429 241420 238508 239698 243971 242522 237802 239548 239018 239629 240162 238347 235379
sum_num_inserts_total=11507864
sum_num_deletes_by_thread=240809 237902 242692 239796 239156 236982 240493 238183 241264 244654 242174 238987 238071 239807 243076 239874 239371 236913 240311 237467 238922 242751 237834 236305 240424 239213 239589 240078 241606 239224 242141 238042 240770 241053 241548 237154 241186 240006 240433 243537 242814 238375 239268 238242 238811 240058 237259 235784
sum_num_deletes_total=11510409
sum_num_searches_by_thread=4324942 4282974 4372733 4318401 4298829 4253937 4333846 4293803 4341736 4400636 4340315 4302954 4282849 4306013 4380931 4328319 4306197 4275717 4316867 4280515 4302724 4374931 4275295 4242213 4328322 4284471 4318223 4320367 4353955 4316995 4325377 4296191 4339394 4338636 4348015 4263601 4344674 4308026 4329148 4392502 4369401 4278708 4320848 4277569 4305611 4325925 4277240 4247111
sum_num_searches_total=207147987
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4806731 4758445 4857863 4798154 4776704 4728274 4814293 4770464 4824608 4889684 4823438 4781281 4758258 4785595 4866854 4807020 4786112 4749418 4797278 4755445 4781359 4861608 4750678 4713234 4808871 4761558 4797414 4800388 4837882 4795800 4808820 4771737 4821388 4821185 4831695 4738184 4827280 4786540 4809279 4880010 4854737 4754885 4799664 4754829 4784051 4806145 4752846 4718274
average_num_operations_total=4795130
stdev_num_operations_total=5977
sum_num_operations_total=230166260
min_num_operations_total=4713234
max_num_operations_total=4889684
first_time_thread_terminate_by_thread=10000159 10000158 10000159 10000158 10000158 10000158 10000160 10000158 10000159 10000159 10000158 10000159 10000159 10000158 10000159 10000158 10000158 10000159 10000158 10000158 10000159 10000158 10000159 10000159 10000159 10000158 10000159 10000158 10000160 10000158 10000160 10000158 10000159 10000159 10000158 10000158 10000159 10000158 10000159 10000158 10000158 10000159 10000158 10000158 10000158 10000158 10000159 10000159
min_time_thread_terminate_total=10000158
max_time_thread_terminate_total=10000160
first_time_thread_start_by_thread=5 4 5 4 4 5 4 4 4 5 5 5 5 5 5 5 5 5 4 4 5 4 5 5 5 4 5 4 4 5 4 4 4 5 5 5 5 5 5 5 5 5 4 4 5 4 5 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=99238693476766
threads_final_size=9925442
final_keysum=99238693476766
final_size=9925442
validate_result=success
Validation OK.
Structural validation OK.
total_find=207147987
total_rq=0
total_inserts=11507864
total_deletes=11510409
total_updates=23018273
total_queries=207147987
total_ops=230166260
find_throughput=20714798
rq_throughput=0
update_throughput=2301827
query_throughput=20714798
total_throughput=23016626
total find : 207147987
total rq : 0
total inserts : 11507864
total deletes : 11510409
total updates : 23018273
total queries : 207147987
total ops : 230166260
find throughput : 20714798
rq throughput : 0
update throughput : 2301827
query throughput : 20714798
total throughput : 23016626
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=30.9778
PAPI_L3_TCM=9.85866
PAPI_TOT_CYC=5814.06
PAPI_TOT_INS=1574.44
garbage=1025274992752460
total_execution_walltime=14.811s
REALTIME_MAIN_END_PERF_FORMAT=6996454.999564949
[time_cmd_output] time_elapsed_sec=15.00, faults_major=0, faults_minor=234992, mem_maxresident_kb=941948, user_cputime=721.56, sys_cputime=4.31, percent_cpu=4837%
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=2