__step=000377
__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 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=data000377.txt
__path_data=data/data000377.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6983360.447347955
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=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=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
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.006s
prefilling_size=6722204 prefilling_elapsed_millis=1.001s
prefilling_size=7010891 prefilling_elapsed_millis=1.101s
prefilling_size=7272332 prefilling_elapsed_millis=1.201s
prefilling_size=7509194 prefilling_elapsed_millis=1.301s
prefilling_size=7723713 prefilling_elapsed_millis=1.402s
prefilling_size=7920130 prefilling_elapsed_millis=1.502s
prefilling_size=8096401 prefilling_elapsed_millis=1.602s
prefilling_size=8257219 prefilling_elapsed_millis=1.702s
prefilling_size=8402063 prefilling_elapsed_millis=1.802s
prefilling_size=8534309 prefilling_elapsed_millis=1.903s
prefilling_size=8656167 prefilling_elapsed_millis=2.003s
prefilling_size=8767841 prefilling_elapsed_millis=2.103s
prefilling_size=8868622 prefilling_elapsed_millis=2.203s
prefilling_size=8962302 prefilling_elapsed_millis=2.303s
prefilling_size=9046001 prefilling_elapsed_millis=2.404s
prefilling_size=9123313 prefilling_elapsed_millis=2.504s
prefilling_size=9193963 prefilling_elapsed_millis=2.604s
prefilling_size=9258213 prefilling_elapsed_millis=2.704s
prefilling_size=9319666 prefilling_elapsed_millis=2.804s
prefilling_size=9374499 prefilling_elapsed_millis=2.905s
prefilling_size=9424271 prefilling_elapsed_millis=3.005s
prefilling_size=9471061 prefilling_elapsed_millis=3.105s
prefilling_size=9513022 prefilling_elapsed_millis=3.205s
prefilling_size=9551575 prefilling_elapsed_millis=3.305s
prefilling_size=9587151 prefilling_elapsed_millis=3.406s
prefilling_size=9620602 prefilling_elapsed_millis=3.506s
prefilling_size=9650561 prefilling_elapsed_millis=3.606s
prefilling_size=9678582 prefilling_elapsed_millis=3.706s
prefilling_size=9704065 prefilling_elapsed_millis=3.807s
prefilling_size=9727806 prefilling_elapsed_millis=3.907s
prefilling_size=9749030 prefilling_elapsed_millis=4.007s
prefilling_size=9768182 prefilling_elapsed_millis=4.107s
prefilling_size=9787458 prefilling_elapsed_millis=4.207s
prefilling_size=9802749 prefilling_elapsed_millis=4.308s
finished prefilling to size 9802712 for expected size 10000000 keysum=98022405720621, performing 79464014 updates; total_prefilling_elapsed_ms=4408 ms)
pref_size=9802712
pref_millis=4408
prefill_elapsed_ms=4433
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=3647
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6983365.50454179
REALTIME_END_PERF_FORMAT=6983375.50611447
###############################################################################
################################## 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 1012 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.146s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 506 991 1936 3726 6971 12695 22438 38381 62844 98673 148462 213671 294310 388487 489488 589194 677607 745907 786064 792371 766784 713442 639865 553671 462709 374043 293251 223507 165685 118875 82670 55967 36652 23226 14282 8647 5184 3155 1850 1049 547 305 150 70 30 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 4 21 46 146 481 1247 2952 6495 13918 27015 48884 83253 133032 200133 287486 389782 500781 609307 705750 779757 817958 820126 787019 726059 644633 551375 454835 362995 281329 212495 155080 109373 75282 50078 32170 19917 12110 7213 4460 2651 1551 789 460 230 110 56 7 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1012 1982 3872 7452 13942 25390 44876 76762 125688 197346 296924 427342 588620 776974 978976 1178388 1355214 1491814 1572128 1584742 1533568 1426884 1279730 1107342 925418 748086 586502 447014 331370 237750 165340 111934 73304 46452 28564 17294 10368 6310 3700 2098 1094 610 300 140 60 8 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 1 4 21 46 146 481 1247 2952 6495 13918 27014 48884 83253 133032 200133 287486 389782 500781 609307 705750 779757 817958 820126 787019 726059 644633 551375 454835 362995 281329 212495 155080 109373 75282 50078 32170 19917 12110 7213 4460 2651 1551 789 460 230 110 56 7 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.99216 1.97925 1.97679 1.96229 1.93545 1.91056 1.88373 1.85527 1.81869 1.78506 1.75229 1.71962 1.6887 1.66 1.62999 1.60185 1.57503 1.5504 1.52692 1.50401 1.48385 1.46522 1.44844 1.43265 1.41786 1.40419 1.392 1.38108 1.37065 1.35874 1.34772 1.3385 1.32744 1.31684 1.30746 1.30272 1.29976 1.3043 1.29319 1.28351 1.26072 1.27879 1.2459 1.23333 1.21429 1.06667 1.125 1
tree_stats_height=57
tree_stats_numInternals=9920853
tree_stats_numLeaves=9920854
tree_stats_numNodes=19841707
tree_stats_numKeys=9920853
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=30.098
tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20400 40480 79280 154880 298080 557680 1015600 1795040 3070480 5027520 7893840 11876960 17093680 23544800 31078960 39159040 47135520 54208560 59672560 62885120 63389680 61342720 57075360 51189200 44293680 37016720 29923440 23460080 17880560 13254800 9510000 6613600 4477360 2932160 1858080 1142560 691760 414720 252400 148000 83920 43760 24400 12000 5600 2400 320 80
tree_stats_sizeInBytes=793668280
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=12222
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:50 4:1332 8:47283 16:317427 32:45355 64:21 128:29
(2^01, 2^02]: 50
(2^02, 2^03]: 1332
(2^03, 2^04]: 47283
(2^04, 2^05]: 317427
(2^05, 2^06]: 45355
(2^06, 2^07]: 21
(2^07, 2^08]: 29
sum_limbo_reclamation_event_size_total=9353970
count_limbo_reclamation_event_size_by_thread=8573 8572 8573 8573 8573 8573 8572 8572 8573 8573 8573 8572 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8573 8572 8573 8573 8573 8573 8573 8573 8573 8572 8572 8573 8573 8573
count_limbo_reclamation_event_size_total=411497
sum_limbo_reclamation_event_count_total=411600
first_thread_announced_epoch_by_thread=24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444 24444
sum_num_inserts_by_thread=196012 197568 198787 197723 197936 196373 195776 197898 198798 199620 196690 195471 196888 198208 198340 199511 198114 197151 195486 196013 199030 198249 195931 194677 196811 196938 199099 198403 198577 195736 196662 197041 199985 198996 197405 196802 197010 197916 199837 199986 197515 197192 195019 197173 197391 198670 196890 194106
sum_num_inserts_total=9477410
sum_num_deletes_by_thread=195362 197080 197232 197334 198744 195300 196574 197606 199034 199109 197474 196984 198028 197975 199618 198715 198618 196828 196239 196630 198056 198867 196859 194579 196278 196473 197723 197574 197453 195342 196959 197843 199732 199304 196466 195830 196846 197794 198749 198564 198586 196568 196219 196958 197437 199781 196991 194458
sum_num_deletes_total=9474773
sum_num_searches_by_thread=3530209 3550690 3569711 3567768 3560567 3523719 3532761 3556974 3586591 3589369 3546066 3525443 3548657 3565161 3577041 3588664 3565591 3544719 3518806 3540375 3566229 3576051 3546335 3512121 3540434 3545783 3580597 3569284 3561562 3520939 3534092 3556085 3590224 3588652 3551111 3530795 3550892 3564446 3588821 3579216 3558919 3544530 3520251 3544148 3561175 3582424 3545495 3515070
sum_num_searches_total=170614563
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3921583 3945338 3965730 3962825 3957247 3915392 3925111 3952478 3984423 3988098 3940230 3917898 3943573 3961344 3974999 3986890 3962323 3938698 3910531 3933018 3963315 3973167 3939125 3901377 3933523 3939194 3977419 3965261 3957592 3912017 3927713 3950969 3989941 3986952 3944982 3923427 3944748 3960156 3987407 3977766 3955020 3938290 3911489 3938279 3956003 3980875 3939376 3903634
average_num_operations_total=3949307
stdev_num_operations_total=3606
sum_num_operations_total=189566746
min_num_operations_total=3901377
max_num_operations_total=3989941
first_time_thread_terminate_by_thread=10000157 10000157 10000157 10000157 10000157 10000157 10000158 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000158 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000157 10000158 10000157 10000157 10000157 10000157
min_time_thread_terminate_total=10000157
max_time_thread_terminate_total=10000158
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 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=99211410714077
threads_final_size=9920853
final_keysum=99211410714077
final_size=9920853
validate_result=success
Validation OK.
Structural validation OK.
total_find=170614563
total_rq=0
total_inserts=9477410
total_deletes=9474773
total_updates=18952183
total_queries=170614563
total_ops=189566746
find_throughput=17061456
rq_throughput=0
update_throughput=1895218
query_throughput=17061456
total_throughput=18956674
total find : 170614563
total rq : 0
total inserts : 9477410
total deletes : 9474773
total updates : 18952183
total queries : 170614563
total ops : 189566746
find throughput : 17061456
rq throughput : 0
update throughput : 1895218
query throughput : 17061456
total throughput : 18956674
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=38.5383
PAPI_L3_TCM=13.8806
PAPI_TOT_CYC=7058.93
PAPI_TOT_INS=369.22
garbage=807132180343613
total_execution_walltime=14.852s
REALTIME_MAIN_END_PERF_FORMAT=6983375.300565741
[time_cmd_output] time_elapsed_sec=15.05, faults_major=0, faults_minor=309734, mem_maxresident_kb=1240908, user_cputime=722.32, sys_cputime=2.75, percent_cpu=4816%
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=1