__step=000043
__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=data000043.txt
__path_data=data/data000043.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979266.570577199
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.011s
prefilling_size=8587329 prefilling_elapsed_millis=1.001s
prefilling_size=8794205 prefilling_elapsed_millis=1.101s
prefilling_size=8967656 prefilling_elapsed_millis=1.201s
prefilling_size=9114405 prefilling_elapsed_millis=1.301s
prefilling_size=9239620 prefilling_elapsed_millis=1.401s
prefilling_size=9347803 prefilling_elapsed_millis=1.502s
prefilling_size=9437971 prefilling_elapsed_millis=1.602s
prefilling_size=9517584 prefilling_elapsed_millis=1.702s
prefilling_size=9583845 prefilling_elapsed_millis=1.802s
prefilling_size=9640524 prefilling_elapsed_millis=1.903s
prefilling_size=9690130 prefilling_elapsed_millis=2.003s
prefilling_size=9732616 prefilling_elapsed_millis=2.103s
prefilling_size=9768785 prefilling_elapsed_millis=2.203s
prefilling_size=9798755 prefilling_elapsed_millis=2.303s
prefilling_size=9824477 prefilling_elapsed_millis=2.404s
finished prefilling to size 9824484 for expected size 10000000 keysum=98237773139227, performing 81103478 updates; total_prefilling_elapsed_ms=2505 ms)
pref_size=9824484
pref_millis=2505
prefill_elapsed_ms=2529
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=980

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6979269.308168615
REALTIME_END_PERF_FORMAT=6979279.308252684

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
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.174s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1011 1951 3695 6844 12281 21221 35154 56144 86418 127681 181876 249546 329608 417811 509174 594682 667577 720732 751229 754532 729862 680043 611922 531809 444164 358800 279708 210465 153242 108550 75142 51167 33968 22014 14075 8968 5604 3366 1975 1185 691 365 181 85 24 11 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 13 71 207 546 1407 3341 7288 14164 25870 45155 73486 114206 169484 241405 326448 423666 521787 614422 690235 747926 779202 779681 748164 692035 619454 529528 437892 348951 267688 197934 141958 99117 68366 45922 29953 19182 12332 7842 4757 2765 1679 1017 549 277 146 37 18 8
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2022 3902 7390 13688 24562 42442 70308 112288 172836 255362 363752 499092 659216 835622 1018348 1189364 1335154 1441464 1502458 1509064 1459724 1360086 1223844 1063618 888328 717600 559416 420930 306484 217100 150284 102334 67936 44028 28150 17936 11208 6732 3950 2370 1382 730 362 170 48 22 8
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 13 71 207 546 1407 3341 7287 14164 25870 45155 73486 114206 169484 241405 326448 423666 521787 614422 690235 747926 779202 779681 748164 692035 619454 529528 437892 348951 267688 197934 141958 99117 68366 45922 29953 19182 12332 7842 4757 2765 1679 1017 549 277 146 37 18 8
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 1.9873 1.96489 1.94695 1.92612 1.89721 1.86398 1.82826 1.79854 1.76961 1.73874 1.71223 1.68603 1.66042 1.6338 1.60934 1.58397 1.56129 1.53981 1.52116 1.5022 1.48365 1.46587 1.44991 1.43454 1.4176 1.4039 1.38978 1.37622 1.36406 1.35418 1.34612 1.34047 1.33193 1.32404 1.31968 1.31858 1.31244 1.30032 1.29337 1.3 1.29156 1.26411 1.24795 1.23481 1.14118 1.22917 1.18182 1

tree_stats_height=58
tree_stats_numInternals=9857580
tree_stats_numLeaves=9857581
tree_stats_numNodes=19715161
tree_stats_numKeys=9857580

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20480 40960 80880 156080 295600 547520 982480 1697680 2812320 4491520 6913440 10214480 14550080 19963680 26368640 33424880 40733920 47574560 53406160 57658560 60098320 60362560 58388960 54403440 48953760 42544720 35533120 28704000 22376640 16837200 12259360 8684000 6011360 4093360 2717440 1761120 1126000 717440 448320 269280 158000 94800 55280 29200 14480 6800 1920 880 320
tree_stats_sizeInBytes=788606440

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:107150 4:216235 8:91172 16:1210 32:1
    (2^01, 2^02]: 107150
    (2^02, 2^03]: 216235
    (2^03, 2^04]: 91172
    (2^04, 2^05]: 1210
    (2^05, 2^06]: 1
sum_limbo_reclamation_event_size_total=2121010
count_limbo_reclamation_event_size_by_thread=4304 4341 4336 4313 4317 4286 4330 4315 4323 4378 4346 4311 4309 4322 4342 4353 4351 4311 4321 4321 4340 4328 4317 4304 4322 4323 4314 4326 4326 4373 4357 4316 4374 4338 4343 4337 4354 4332 4358 4347 4328 4301 4299 4316 4359 4361 4346 4314 4319 4367 4334 4352 4313 4345 4305 4267 4360 4313 4335 4323 4341 4345 4367 4331 4378 4349 4340 4311 4324 4348 4325 4312 4352 4279 4380 4328 4312 4342 4353 4347 4327 4345 4390 4301 4302 4322 4343 4300 4343 4288 4333 4328 4319 4315 4323 4309
count_limbo_reclamation_event_size_total=415768
sum_limbo_reclamation_event_count_total=462528
first_thread_announced_epoch_by_thread=11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596 11596
sum_num_inserts_by_thread=22384 22587 22674 22388 22520 22016 22287 22421 22917 22594 22305 22155 22509 22433 22638 22536 22501 22272 22326 22295 22722 22560 22446 22101 22431 22533 22589 22574 22438 22197 22055 22252 22490 22870 22675 22267 22314 22483 22608 22641 22399 22492 22133 22537 22285 22572 22269 21951 22393 22469 22676 22865 22508 22225 22120 22395 22828 22721 22370 22336 22632 22406 22683 22799 22660 22470 22043 22564 23085 22239 22611 22506 22416 22519 22688 22781 22220 22230 22380 22238 22617 22738 22377 22350 22460 22458 22764 22674 22601 22036 21993 21949 22631 22633 22492 22303
sum_num_inserts_total=2155794
sum_num_deletes_by_thread=22116 22612 22454 22185 22266 22294 22379 22447 22835 22614 22807 22411 22620 22658 22822 22857 22501 22351 22216 22326 22494 22609 22341 22104 22261 22610 22575 22354 22460 22380 22482 22348 23091 22855 22601 22174 22350 22545 22792 22569 22727 22323 22098 22392 22520 22679 22531 22367 22435 22404 22256 22419 22476 22280 22293 22104 22763 22621 22587 22500 22222 22643 22835 22569 22659 22457 22303 22274 22542 22442 22715 22268 22602 22417 22687 22635 22486 22190 22884 22301 22540 22742 22585 22262 22516 22600 22687 22498 22469 22230 22115 22395 22694 22539 22241 22135
sum_num_deletes_total=2157920
sum_num_searches_by_thread=4412321 4441465 4476396 4472018 4449959 4403574 4424208 4444731 4488644 4494079 4435712 4401119 4425795 4456909 4483499 4485463 4452090 4421234 4393596 4421977 4449703 4469206 4415003 4380585 4411302 4434861 4472026 4466957 4443610 4403202 4427152 4444464 4489239 4497974 4438658 4408109 4429805 4459485 4490011 4490696 4451922 4420869 4397254 4416730 4448286 4469786 4419729 4382051 4423078 4447807 4476200 4471851 4438008 4414383 4422632 4438657 4490656 4494217 4445050 4420645 4433725 4461767 4491549 4490259 4458038 4410234 4396021 4426690 4479392 4480419 4447610 4414764 4421016 4442593 4483534 4483003 4438926 4409802 4420453 4431484 4488952 4493518 4453466 4422989 4434980 4456676 4488833 4486558 4446257 4404153 4392908 4419450 4475282 4480587 4446944 4414569
sum_num_searches_total=426724049
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4456821 4486664 4521524 4516591 4494745 4447884 4468874 4489599 4534396 4539287 4480824 4445685 4470924 4502000 4528959 4530856 4497092 4465857 4438138 4466598 4494919 4514375 4459790 4424790 4455994 4480004 4517190 4511885 4488508 4447779 4471689 4489064 4534820 4543699 4483934 4452550 4474469 4504513 4535411 4535906 4497048 4465684 4441485 4461659 4493091 4515037 4464529 4426369 4467906 4492680 4521132 4517135 4482992 4458888 4467045 4483156 4536247 4539559 4490007 4465481 4478579 4506816 4537067 4535627 4503357 4455161 4440367 4471528 4525019 4525100 4492936 4459538 4466034 4487529 4528909 4528419 4483632 4454222 4465717 4476023 4534109 4538998 4498428 4467601 4479956 4501734 4534284 4531730 4491327 4448419 4437016 4463794 4520607 4525759 4491677 4459007
average_num_operations_total=4489976
stdev_num_operations_total=3223
sum_num_operations_total=431037763
min_num_operations_total=4424790
max_num_operations_total=4543699
first_time_thread_terminate_by_thread=10000084 10000084 10000085 10000085 10000084 10000084 10000084 10000085 10000084 10000084 10000084 10000085 10000085 10000085 10000084 10000085 10000085 10000086 10000084 10000085 10000085 10000084 10000084 10000084 10000085 10000084 10000085 10000085 10000084 10000084 10000085 10000085 10000084 10000084 10000084 10000085 10000084 10000085 10000084 10000084 10000085 10000086 10000084 10000084 10000085 10000084 10000084 10000084 10000087 10000086 10000084 10000084 10000084 10000085 10000086 10000085 10000086 10000085 10000085 10000086 10000084 10000086 10000086 10000086 10000086 10000084 10000086 10000086 10000084 10000086 10000083 10000084 10000087 10000086 10000084 10000084 10000139 10000085 10000086 10000085 10000086 10000085 10000085 10000084 10000084 10000084 10000086 10000086 10000086 10000084 10000084 10000086 10000084 10000086 10000085 10000086
min_time_thread_terminate_total=10000083
max_time_thread_terminate_total=10000139
first_time_thread_start_by_thread=6 6 6 5 6 6 6 5 6 5 6 5 6 5 5 6 6 5 5 5 5 5 6 5 6 6 6 5 6 6 6 5 6 5 6 5 6 6 5 6 6 5 5 5 5 5 6 5 5 6 5 5 4 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 6 5 5 10 6 5 5 5 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=

threads_final_keysum=98572237070466
threads_final_size=9857580
final_keysum=98572237070466
final_size=9857580
validate_result=success
Validation OK.
Structural validation OK.

total_find=426724049
total_rq=0
total_inserts=2155794
total_deletes=2157920
total_updates=4313714
total_queries=426724049
total_ops=431037763
find_throughput=42672404
rq_throughput=0
update_throughput=431371
query_throughput=42672404
total_throughput=43103776


total find                    : 426724049
total rq                      : 0
total inserts                 : 2155794
total deletes                 : 2157920
total updates                 : 4313714
total queries                 : 426724049
total ops                     : 431037763
find throughput               : 42672404
rq throughput                 : 0
update throughput             : 431371
query throughput              : 42672404
total throughput              : 43103776

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=37.8416
PAPI_L3_TCM=15.0472
PAPI_TOT_CYC=6200.09
PAPI_TOT_INS=342.107
garbage=2099655446891442
total_execution_walltime=13.083s
REALTIME_MAIN_END_PERF_FORMAT=6979279.654860565
[time_cmd_output] time_elapsed_sec=13.31, faults_major=0, faults_minor=311138, mem_maxresident_kb=1242836, user_cputime=1229.04, sys_cputime=4.56, percent_cpu=9268%
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