__step=000044
__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" ./guerraoui_ext_bst_ticket.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000044.txt
__path_data=data/data000044.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979279.940132947
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=guerraoui_ext_bst_ticket
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=40
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.013s
prefilling_size=8539791 prefilling_elapsed_millis=1.001s
prefilling_size=8743525 prefilling_elapsed_millis=1.101s
prefilling_size=8913400 prefilling_elapsed_millis=1.201s
prefilling_size=9060826 prefilling_elapsed_millis=1.302s
prefilling_size=9186045 prefilling_elapsed_millis=1.402s
prefilling_size=9293240 prefilling_elapsed_millis=1.502s
prefilling_size=9383785 prefilling_elapsed_millis=1.602s
prefilling_size=9465833 prefilling_elapsed_millis=1.702s
prefilling_size=9534439 prefilling_elapsed_millis=1.803s
prefilling_size=9592396 prefilling_elapsed_millis=1.903s
prefilling_size=9643489 prefilling_elapsed_millis=2.003s
prefilling_size=9688631 prefilling_elapsed_millis=2.103s
prefilling_size=9728134 prefilling_elapsed_millis=2.203s
prefilling_size=9761553 prefilling_elapsed_millis=2.304s
prefilling_size=9791607 prefilling_elapsed_millis=2.404s
prefilling_size=9817876 prefilling_elapsed_millis=2.504s
finished prefilling to size 9817949 for expected size 10000000 keysum=98188936334903, performing 84237851 updates; total_prefilling_elapsed_ms=2606 ms)
pref_size=9817949
pref_millis=2606
prefill_elapsed_ms=2627
6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=1020

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6979282.735867179
REALTIME_END_PERF_FORMAT=6979292.736011227

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

tree_stats_computeWalltime=0.109s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1017 1990 3845 7145 12789 21994 36391 58467 90665 135944 195796 270756 358501 454521 551303 640427 712536 761595 781948 772204 732081 668086 586679 496085 404493 317516 240832 176309 124224 85252 56363 35932 21965 13320 7819 4752 2799 1637 931 579 344 227 138 75 50 22 13 8 6 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 7 44 135 545 1501 3584 7597 14315 26269 45386 76092 120836 183011 262481 357739 462179 568318 663477 741242 791692 812327 796076 749493 677273 587677 491470 394200 305355 228394 163196 114141 76794 49899 30610 18821 10886 6705 3961 2343 1283 814 461 316 201 100 78 31 18 10 10 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2034 3980 7690 14290 25578 43988 72782 116934 181330 271888 391592 541512 717002 909042 1102606 1280854 1425072 1523190 1563896 1544408 1464162 1336172 1173358 992170 808986 635032 481664 352618 248448 170504 112726 71864 43930 26640 15638 9504 5598 3274 1862 1158 688 454 276 150 100 44 26 16 12 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 7 44 134 545 1501 3584 7597 14315 26269 45386 76092 120836 183011 262481 357739 462179 568318 663477 741242 791692 812327 796076 749493 677273 587677 491470 394200 305355 228394 163196 114141 76794 49899 30610 18821 10886 6705 3961 2343 1283 814 461 316 201 100 78 31 18 10 10 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 1.99316 1.97837 1.96583 1.92913 1.89496 1.85988 1.82729 1.80332 1.77535 1.7497 1.72013 1.69142 1.66204 1.63392 1.60647 1.58083 1.5563 1.53443 1.51336 1.49377 1.47402 1.45629 1.43907 1.42279 1.40769 1.39249 1.37924 1.36604 1.35229 1.34314 1.33057 1.31876 1.30565 1.30321 1.29351 1.30388 1.29451 1.29243 1.28436 1.31096 1.29706 1.32994 1.30396 1.27174 1.33333 1.22 1.29545 1.30769 1.375 1.16667 1

tree_stats_height=61
tree_stats_numInternals=9849396
tree_stats_numLeaves=9849397
tree_stats_numNodes=19698793
tree_stats_numKeys=9849396

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=30.3336

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20480 40960 81360 159200 307600 571600 1023120 1759520 2911280 4677360 7253200 10875520 15663680 21660480 28680080 36361680 44104240 51234160 57002880 60927600 62555840 61776320 58566480 53446880 46934320 39686800 32359440 25401280 19266560 14104720 9937920 6820160 4509040 2874560 1757200 1065600 625520 380160 223920 130960 74480 46320 27520 18160 11040 6000 4000 1760 1040 640 480 160
tree_stats_sizeInBytes=787951720

6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=5853


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:107486 4:217617 8:90803 16:1191
    (2^01, 2^02]: 107486
    (2^02, 2^03]: 217617
    (2^03, 2^04]: 90803
    (2^04, 2^05]: 1191
sum_limbo_reclamation_event_size_total=2124904
count_limbo_reclamation_event_size_by_thread=4323 4281 4353 4325 4355 4328 4317 4328 4313 4369 4401 4335 4384 4364 4344 4331 4339 4353 4331 4362 4342 4318 4359 4355 4391 4326 4343 4341 4327 4315 4317 4365 4343 4363 4385 4303 4303 4350 4357 4302 4347 4352 4370 4333 4362 4354 4318 4310 4339 4379 4343 4348 4322 4300 4334 4337 4329 4345 4373 4389 4306 4361 4328 4407 4274 4353 4332 4325 4347 4356 4372 4321 4330 4352 4352 4342 4338 4347 4369 4358 4384 4374 4364 4339 4378 4358 4377 4312 4335 4339 4346 4352 4363 4365 4364 4352
count_limbo_reclamation_event_size_total=417097
sum_limbo_reclamation_event_count_total=463968
first_thread_announced_epoch_by_thread=11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706 11706
sum_num_inserts_by_thread=22305 22440 22612 22269 22619 22350 22340 22673 22621 22770 22479 22869 22462 22677 22666 22640 22504 22247 22201 22305 22075 22707 22352 22094 22271 22656 22294 22774 22434 22515 22168 22123 22872 22758 22446 22339 22417 22760 22723 22543 22525 22438 22208 22575 22526 22639 22374 22002 22325 22588 23177 22565 22274 22093 22426 22352 22841 22658 22416 22253 22561 22694 22633 22524 22693 22284 22198 22585 22355 22725 22654 22283 22509 22491 22788 22396 22509 22488 22412 22528 22546 22736 22552 22348 22411 22767 22917 22459 22304 22139 22100 22447 22585 22931 22413 22163
sum_num_inserts_total=2158753
sum_num_deletes_by_thread=22520 22599 22875 22482 22337 22067 22216 22730 22529 22843 22422 22319 22586 22769 22826 22485 22536 22423 22281 22793 22548 22775 22682 22113 22626 22398 22635 22594 22437 22326 22281 22619 22784 22511 22506 22598 22411 22842 22703 22586 22720 22288 22254 22443 22715 22463 22315 22345 22348 22624 22606 22424 22461 22649 22425 22426 22578 22627 22495 22343 22495 22590 22568 22770 22481 22257 22255 22386 22721 22526 22602 22328 22230 22530 22509 22572 22764 22411 22608 22627 22730 22715 22490 22393 22380 22503 22741 22648 22411 22073 22450 22670 22570 22355 22404 22326
sum_num_deletes_total=2161251
sum_num_searches_by_thread=4434348 4460219 4492829 4474157 4451457 4418036 4427950 4460578 4495119 4499283 4440575 4433321 4440346 4479216 4496852 4504686 4475399 4433126 4405955 4443550 4462394 4490492 4439075 4388549 4426162 4453358 4482892 4489209 4452141 4419999 4430048 4450193 4506129 4495122 4443262 4429720 4452623 4477842 4504480 4496394 4472113 4430704 4406338 4432654 4466189 4498083 4437591 4400241 4434543 4455742 4502945 4500594 4452298 4430807 4428105 4447206 4507067 4506413 4458669 4428748 4453040 4478480 4505792 4491373 4472094 4410352 4397531 4431955 4491564 4480685 4446886 4429291 4442190 4452602 4489049 4491897 4450749 4422258 4432969 4453939 4505027 4510222 4461087 4441313 4442847 4464443 4492030 4490844 4457256 4407576 4405304 4432592 4480828 4483162 4450157 4420248
sum_num_searches_total=427923768
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4479173 4505258 4538316 4518908 4496413 4462453 4472506 4505981 4540269 4544896 4485476 4478509 4485394 4524662 4542344 4549811 4520439 4477796 4450437 4488648 4507017 4535974 4484109 4432756 4471059 4498412 4527821 4534577 4497012 4464840 4474497 4494935 4551785 4540391 4488214 4474657 4497451 4523444 4549906 4541523 4517358 4475430 4450800 4477672 4511430 4543185 4482280 4444588 4479216 4500954 4548728 4545583 4497033 4475549 4472956 4491984 4552486 4551698 4503580 4473344 4498096 4523764 4550993 4536667 4517268 4454893 4441984 4476926 4536640 4525936 4492142 4473902 4486929 4497623 4534346 4536865 4496022 4467157 4477989 4499094 4550303 4555673 4506129 4486054 4487638 4509713 4537688 4535951 4501971 4451788 4449854 4477709 4525983 4528448 4494974 4464737
average_num_operations_total=4502539
stdev_num_operations_total=3224
sum_num_operations_total=432243772
min_num_operations_total=4432756
max_num_operations_total=4555673
first_time_thread_terminate_by_thread=10000144 10000143 10000143 10000144 10000143 10000145 10000145 10000143 10000145 10000145 10000145 10000145 10000143 10000144 10000143 10000143 10000143 10000145 10000143 10000146 10000143 10000145 10000143 10000145 10000143 10000143 10000143 10000143 10000143 10000145 10000145 10000143 10000145 10000145 10000143 10000143 10000143 10000144 10000143 10000143 10000143 10000143 10000143 10000145 10000143 10000145 10000143 10000145 10000143 10000143 10000143 10000143 10000146 10000143 10000144 10000144 10000143 10000144 10000144 10000146 10000144 10000144 10000145 10000143 10000143 10000145 10000144 10000143 10000143 10000143 10000144 10000143 10000144 10000144 10000144 10000144 10000146 10000143 10000144 10000144 10000144 10000144 10000144 10000146 10000144 10000143 10000145 10000143 10000143 10000145 10000143 10000143 10000143 10000143 10000143 10000143
min_time_thread_terminate_total=10000143
max_time_thread_terminate_total=10000146
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 2 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=98504609805813
threads_final_size=9849396
final_keysum=98504609805813
final_size=9849396
validate_result=success
Validation OK.
Structural validation OK.

total_find=427923768
total_rq=0
total_inserts=2158753
total_deletes=2161251
total_updates=4320004
total_queries=427923768
total_ops=432243772
find_throughput=42792376
rq_throughput=0
update_throughput=432000
query_throughput=42792376
total_throughput=43224377


total find                    : 427923768
total rq                      : 0
total inserts                 : 2158753
total deletes                 : 2161251
total updates                 : 4320004
total queries                 : 427923768
total ops                     : 432243772
find throughput               : 42792376
rq throughput                 : 0
update throughput             : 432000
query throughput              : 42792376
total throughput              : 43224377

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=37.7086
PAPI_L3_TCM=14.999
PAPI_TOT_CYC=6182.33
PAPI_TOT_INS=339.498
garbage=2108045343893098
total_execution_walltime=12.995s
REALTIME_MAIN_END_PERF_FORMAT=6979292.940841425
[time_cmd_output] time_elapsed_sec=13.20, faults_major=0, faults_minor=311121, mem_maxresident_kb=1242508, user_cputime=1235.97, sys_cputime=4.37, percent_cpu=9393%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2