__step=000713
__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 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000713.txt
__path_data=data/data000713.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6987488.220130846
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=50
DEL_FRAC=50
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=50.0 50.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=6673574 prefilling_elapsed_millis=1.001s
prefilling_size=6960801 prefilling_elapsed_millis=1.101s
prefilling_size=7220195 prefilling_elapsed_millis=1.201s
prefilling_size=7454562 prefilling_elapsed_millis=1.301s
prefilling_size=7666641 prefilling_elapsed_millis=1.402s
prefilling_size=7859281 prefilling_elapsed_millis=1.502s
prefilling_size=8036063 prefilling_elapsed_millis=1.602s
prefilling_size=8196275 prefilling_elapsed_millis=1.702s
prefilling_size=8342551 prefilling_elapsed_millis=1.802s
prefilling_size=8475951 prefilling_elapsed_millis=1.903s
prefilling_size=8596229 prefilling_elapsed_millis=2.003s
prefilling_size=8707332 prefilling_elapsed_millis=2.103s
prefilling_size=8809233 prefilling_elapsed_millis=2.203s
prefilling_size=8901777 prefilling_elapsed_millis=2.303s
prefilling_size=8985711 prefilling_elapsed_millis=2.404s
prefilling_size=9063289 prefilling_elapsed_millis=2.504s
prefilling_size=9135323 prefilling_elapsed_millis=2.604s
prefilling_size=9202299 prefilling_elapsed_millis=2.704s
prefilling_size=9263417 prefilling_elapsed_millis=2.804s
prefilling_size=9319201 prefilling_elapsed_millis=2.905s
prefilling_size=9371355 prefilling_elapsed_millis=3.005s
prefilling_size=9418623 prefilling_elapsed_millis=3.105s
prefilling_size=9462362 prefilling_elapsed_millis=3.205s
prefilling_size=9500889 prefilling_elapsed_millis=3.305s
prefilling_size=9538546 prefilling_elapsed_millis=3.406s
prefilling_size=9573399 prefilling_elapsed_millis=3.506s
prefilling_size=9604394 prefilling_elapsed_millis=3.606s
prefilling_size=9632770 prefilling_elapsed_millis=3.706s
prefilling_size=9658554 prefilling_elapsed_millis=3.806s
prefilling_size=9684150 prefilling_elapsed_millis=3.907s
prefilling_size=9706861 prefilling_elapsed_millis=4.007s
prefilling_size=9728115 prefilling_elapsed_millis=4.107s
prefilling_size=9747446 prefilling_elapsed_millis=4.207s
prefilling_size=9765798 prefilling_elapsed_millis=4.307s
prefilling_size=9781869 prefilling_elapsed_millis=4.408s
prefilling_size=9796803 prefilling_elapsed_millis=4.508s
prefilling_size=9812318 prefilling_elapsed_millis=4.608s
finished prefilling to size 9812251 for expected size 10000000 keysum=98113833394028, performing 84372715 updates; total_prefilling_elapsed_ms=4709 ms)
pref_size=9812251
pref_millis=4709
prefill_elapsed_ms=4726
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=3866

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6987493.114700011
REALTIME_END_PERF_FORMAT=6987503.114855907

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

tree_stats_computeWalltime=0.093s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 254 500 989 1933 3690 6906 12614 22475 38384 63095 99201 149835 216269 298864 394901 496705 597902 689715 760718 802022 810844 787892 734886 657409 566554 469873 375811 289832 214621 153108 105019 69400 44239 27182 16119 9259 5269 3018 1747 1009 582 316 173 112 70 37 12 5 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 8 11 45 176 474 1198 2753 6566 13673 26989 48567 83401 133674 202827 293097 395508 506089 618712 719414 793200 833796 840898 812363 748264 663235 563935 461790 365043 276134 201197 140638 94561 61296 38245 22979 13249 7520 4289 2485 1436 848 459 234 154 103 62 19 9 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 508 1000 1978 3866 7380 13812 25228 44950 76768 126190 198402 299670 432538 597728 789802 993410 1195804 1379430 1521436 1604044 1621688 1575784 1469772 1314818 1133108 939746 751622 579664 429242 306216 210038 138800 88478 54364 32238 18518 10538 6036 3494 2018 1164 632 346 224 140 74 24 10 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 2 8 11 45 176 474 1198 2753 6566 13672 26989 48567 83401 133674 202827 293097 395508 506089 618712 719414 793200 833796 840898 812363 748264 663235 563935 461790 365043 276134 201197 140638 94561 61296 38245 22979 13249 7520 4289 2485 1436 848 459 234 154 103 62 19 9 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.98425 1.989 1.97725 1.95447 1.93577 1.91326 1.89088 1.85393 1.82188 1.78612 1.75521 1.72169 1.69095 1.66067 1.6289 1.60187 1.57678 1.55147 1.52715 1.5055 1.48585 1.46636 1.44729 1.4309 1.41468 1.39991 1.38561 1.37025 1.35669 1.34296 1.33042 1.31872 1.30722 1.2965 1.28721 1.28453 1.28639 1.28943 1.28878 1.2884 1.27148 1.27373 1.3237 1.3125 1.26429 1.16216 1.20833 1.1 1

tree_stats_height=58
tree_stats_numInternals=10001626
tree_stats_numLeaves=10001627
tree_stats_numNodes=20003253
tree_stats_numKeys=10001626

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20320 40000 79120 154640 295200 552480 1009120 1798000 3070720 5047600 7936080 11986800 17301520 23909120 31592080 39736400 47832160 55177200 60857440 64161760 64867520 63031360 58790880 52592720 45324320 37589840 30064880 23186560 17169680 12248640 8401520 5552000 3539120 2174560 1289520 740720 421520 241440 139760 80720 46560 25280 13840 8960 5600 2960 960 400 80
tree_stats_sizeInBytes=800130120

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=11486


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:0 32:0 64:7 128:341514 256:24143
    (2^06, 2^07]: 7
    (2^07, 2^08]: 341514
    (2^08, 2^09]: 24143
sum_limbo_reclamation_event_size_total=82564850
count_limbo_reclamation_event_size_by_thread=7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618 7618
count_limbo_reclamation_event_size_total=365664
sum_limbo_reclamation_event_count_total=365760
first_thread_announced_epoch_by_thread=22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972 22972
sum_num_inserts_by_thread=1715628 1720983 1733907 1736346 1727249 1711676 1720730 1725870 1738566 1736325 1719546 1712805 1720867 1726710 1736582 1736913 1732104 1717613 1710608 1718912 1728099 1734046 1715117 1708493 1718714 1723737 1733417 1734767 1727211 1710924 1718549 1722884 1739982 1741780 1723993 1712850 1717816 1733491 1736122 1736688 1728025 1718172 1707694 1716971 1727865 1735677 1717249 1708569
sum_num_inserts_total=82778842
sum_num_deletes_by_thread=1713059 1723442 1733529 1736139 1726963 1714612 1720934 1723998 1739540 1736402 1719442 1711688 1721378 1731176 1737467 1737680 1731482 1716782 1710210 1719011 1726510 1733537 1715942 1708479 1714433 1723438 1731702 1735275 1726665 1710124 1720120 1725602 1740135 1742631 1722302 1712024 1716478 1730113 1740092 1737958 1724675 1720882 1706448 1718728 1727544 1732065 1717720 1706816
sum_num_deletes_total=82773372
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3428687 3444425 3467436 3472485 3454212 3426288 3441664 3449868 3478106 3472727 3438988 3424493 3442245 3457886 3474049 3474593 3463586 3434395 3420818 3437923 3454609 3467583 3431059 3416972 3433147 3447175 3465119 3470042 3453876 3421048 3438669 3448486 3480117 3484411 3446295 3424874 3434294 3463604 3476214 3474646 3452700 3439054 3414142 3435699 3455409 3467742 3434969 3415385
average_num_operations_total=3449004
stdev_num_operations_total=2873
sum_num_operations_total=165552214
min_num_operations_total=3414142
max_num_operations_total=3484411
first_time_thread_terminate_by_thread=10000154 10000154 10000156 10000158 10000155 10000155 10000155 10000155 10000156 10000155 10000187 10000154 10000154 10000155 10000155 10000154 10000155 10000155 10000154 10000157 10000155 10000154 10000155 10000162 10000157 10000155 10000155 10000154 10000156 10000156 10000155 10000156 10000155 10000155 10000156 10000155 10000155 10000155 10000154 10000154 10000155 10000155 10000154 10000155 10000155 10000156 10000156 10000155
min_time_thread_terminate_total=10000154
max_time_thread_terminate_total=10000187
first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 6 6 6 6 6 7 6 6 6 6 6 7 6 6 7 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 6 6 6 6 6 7 6 6 7 6
min_time_thread_start_total=6
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=100011178518542
threads_final_size=10001626
final_keysum=100011178518542
final_size=10001626
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=82778842
total_deletes=82773372
total_updates=165552214
total_queries=0
total_ops=165552214
find_throughput=0
rq_throughput=0
update_throughput=16555221
query_throughput=0
total_throughput=16555221


total find                    : 0
total rq                      : 0
total inserts                 : 82778842
total deletes                 : 82773372
total updates                 : 165552214
total queries                 : 0
total ops                     : 165552214
find throughput               : 0
rq throughput                 : 0
update throughput             : 16555221
query throughput              : 0
total throughput              : 16555221

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=49.0262
PAPI_L3_TCM=18.1655
PAPI_TOT_CYC=8081.87
PAPI_TOT_INS=846.621
garbage=0
total_execution_walltime=15.077s
REALTIME_MAIN_END_PERF_FORMAT=6987503.297995764
[time_cmd_output] time_elapsed_sec=15.28, faults_major=0, faults_minor=317563, mem_maxresident_kb=1272380, user_cputime=733.98, sys_cputime=3.26, percent_cpu=4824%
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