__step=000490
__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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000490.txt
__path_data=data/data000490.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984805.904701012
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=2000000
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=999599 prefilling_elapsed_millis=1.001s
finished prefilling to size 999600 for expected size 1000000 keysum=999652854751, performing 32194759 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999600
pref_millis=1102
prefill_elapsed_ms=1131
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=1511

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984807.210132031
REALTIME_END_PERF_FORMAT=6984817.210270811

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

tree_stats_computeWalltime=0.042s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 508 984 1863 3361 5811 9652 15252 23013 33031 45218 58690 71981 83415 91332 94157 91502 84864 74503 61323 47983 35121 24503 16419 10595 6465 3786 2076 1084 545 285 127 43 16 5 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 4 32 105 365 911 1970 4052 7491 12995 20844 31746 45399 60547 75498 88507 96812 98140 95225 87683 74663 60845 45739 32587 22243 14725 9144 5496 3068 1623 805 443 211 70 27 10
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1016 1968 3726 6722 11622 19304 30504 46026 66062 90436 117380 143962 166830 182664 188314 183004 169728 149006 122646 95966 70242 49006 32838 21190 12930 7572 4152 2168 1090 570 254 86 32 10
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 4 32 104 365 911 1970 4052 7491 12995 20844 31746 45399 60547 75498 88507 96812 98140 95225 87683 74663 60845 45739 32587 22243 14725 9144 5496 3068 1623 805 443 211 70 27 10
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.99219 1.9685 1.94614 1.90204 1.86447 1.83049 1.7901 1.75443 1.71766 1.68448 1.64897 1.61323 1.57942 1.54746 1.51547 1.4859 1.46373 1.43896 1.41155 1.39123 1.36597 1.34884 1.33504 1.32264 1.3051 1.29281 1.27417 1.26108 1.25138 1.26147 1.22281 1.16929 1.18605 1.15625 1

tree_stats_height=44
tree_stats_numInternals=1000024
tree_stats_numLeaves=1000025
tree_stats_numNodes=2000049
tree_stats_numKeys=1000024

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=25.0906

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20480 40640 78720 149040 268880 464880 772160 1220160 1841040 2642480 3617440 4695200 5758480 6673200 7306560 7532560 7320160 6789120 5960240 4905840 3838640 2809680 1960240 1313520 847600 517200 302880 166080 86720 43600 22800 10160 3440 1280 400
tree_stats_sizeInBytes=80001960

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:50 4:1479 8:52568 16:369730 32:56070
    (2^01, 2^02]: 50
    (2^02, 2^03]: 1479
    (2^03, 2^04]: 52568
    (2^04, 2^05]: 369730
    (2^05, 2^06]: 56070
sum_limbo_reclamation_event_size_total=11004400
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9996 9998 9997 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9997
count_limbo_reclamation_event_size_total=479897
sum_limbo_reclamation_event_count_total=841200
first_thread_announced_epoch_by_thread=38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072 38072
sum_num_inserts_by_thread=398768 400802 404684 404938 402501 397573 399378 399804 404837 406435 401384 399568 400339 402215 406444 405025 401910 400942 397378 401530 403002 405020 399397 397660 398366 399548 405039 402928 401952 398731 400600 401144 405614 407453 402618 399774 400907 402478 405601 404479 403388 400121 396676 400528 403186 405220 399760 397337
sum_num_inserts_total=19284982
sum_num_deletes_by_thread=398210 399918 404647 404046 399932 397748 398648 401158 405588 407757 401267 400088 399589 402531 404621 405896 403467 400735 398535 399596 404545 405538 400011 397111 397975 400713 404246 405231 402656 398394 399300 401322 405544 407279 402625 400067 400634 403245 406270 405574 402507 400426 397379 399210 403865 406138 400428 398313
sum_num_deletes_total=19290523
sum_num_searches_by_thread=7163506 7219206 7283110 7273804 7219522 7157056 7184646 7217354 7307274 7314633 7236983 7189001 7196525 7233941 7293833 7301831 7253204 7207452 7162905 7213377 7254633 7297808 7207049 7150095 7157867 7202622 7286081 7283602 7242208 7163605 7195189 7227222 7312415 7323216 7237037 7200549 7215432 7258753 7294578 7293751 7238148 7204952 7152526 7208163 7271860 7303021 7219801 7153214
sum_num_searches_total=347184560
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7960484 8019926 8092441 8082788 8021955 7952377 7982672 8018316 8117699 8128825 8039634 7988657 7996453 8038687 8104898 8112752 8058581 8009129 7958818 8014503 8062180 8108366 8006457 7944866 7954208 8002883 8095366 8091761 8046816 7960730 7995089 8029688 8123573 8137948 8042280 8000390 8016973 8064476 8106449 8103804 8044043 8005499 7946581 8007901 8078911 8114379 8019989 7948864
average_num_operations_total=8036668
stdev_num_operations_total=8289
sum_num_operations_total=385760065
min_num_operations_total=7944866
max_num_operations_total=8137948
first_time_thread_terminate_by_thread=10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137
min_time_thread_terminate_total=10000137
max_time_thread_terminate_total=10000138
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=999392190161
threads_final_size=1000024
final_keysum=999392190161
final_size=1000024
validate_result=success
Validation OK.
Structural validation OK.

total_find=347184560
total_rq=0
total_inserts=19284982
total_deletes=19290523
total_updates=38575505
total_queries=347184560
total_ops=385760065
find_throughput=34718456
rq_throughput=0
update_throughput=3857550
query_throughput=34718456
total_throughput=38576006


total find                    : 347184560
total rq                      : 0
total inserts                 : 19284982
total deletes                 : 19290523
total updates                 : 38575505
total queries                 : 347184560
total ops                     : 385760065
find throughput               : 34718456
rq throughput                 : 0
update throughput             : 3857550
query throughput              : 34718456
total throughput              : 38576006

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=21.4767
PAPI_L3_TCM=4.28996
PAPI_TOT_CYC=3467.75
PAPI_TOT_INS=336.019
garbage=169986637304375
total_execution_walltime=11.432s
REALTIME_MAIN_END_PERF_FORMAT=6984817.353417681
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=99232, mem_maxresident_kb=398968, user_cputime=560.60, sys_cputime=1.68, percent_cpu=4849%
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