__step=000780
__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" ./sigouin_int_avl_kcas_validate.debra -nwork 96 -nprefill 96 -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=data000780.txt
__path_data=data/data000780.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55f46f37c400
addrof(kcasDescriptors[1])=0x55f46f37cd00
addrof(rdcssDescriptors[0])=0x55f46f49c400
addrof(rdcssDescriptors[1])=0x55f46f49c4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6988391.476130984
binary=./sigouin_int_avl_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=sigouin_int_avl_kcas_validate
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=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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=56
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.008s
prefilling_size=8321574 prefilling_elapsed_millis=1.001s
prefilling_size=8575006 prefilling_elapsed_millis=1.101s
prefilling_size=8788032 prefilling_elapsed_millis=1.201s
prefilling_size=8969093 prefilling_elapsed_millis=1.301s
prefilling_size=9120916 prefilling_elapsed_millis=1.402s
prefilling_size=9248747 prefilling_elapsed_millis=1.502s
prefilling_size=9359526 prefilling_elapsed_millis=1.602s
prefilling_size=9453625 prefilling_elapsed_millis=1.702s
prefilling_size=9533215 prefilling_elapsed_millis=1.803s
prefilling_size=9601229 prefilling_elapsed_millis=1.903s
prefilling_size=9656033 prefilling_elapsed_millis=2.003s
prefilling_size=9705982 prefilling_elapsed_millis=2.103s
prefilling_size=9746550 prefilling_elapsed_millis=2.203s
prefilling_size=9783006 prefilling_elapsed_millis=2.304s
prefilling_size=9815310 prefilling_elapsed_millis=2.404s
finished prefilling to size 9815327 for expected size 10000000 keysum=98156086297211, performing 80497687 updates; total_prefilling_elapsed_ms=2506 ms)
pref_size=9815327
pref_millis=2506
prefill_elapsed_ms=2528
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6988394.200684802
REALTIME_END_PERF_FORMAT=6988404.200822810
###############################################################################
################################## 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.047s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262125 522044 990382 1512873 1431536 647454 110135 4667 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 18 2051 47226 387987 1243215 1619161 813421 139975 5819 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262143 524095 1037608 1900860 2674751 2266615 923556 144642 5823 4
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262143 524095 1037608 1900860 2674751 2266615 923556 144642 5823 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99999 1.99934 1.98372 1.87748 1.61124 1.31221 1.12181 1.03736 1.00799 1 1
tree_stats_height=28
tree_stats_numInternals=5743363
tree_stats_numLeaves=4258877
tree_stats_numNodes=10002240
tree_stats_numKeys=10002240
tree_stats_avgDegreeInternal=1.74153
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42579
tree_stats_avgKeyDepth=21.6402
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:0 32:0 64:10 128:351275 256:2571
(2^06, 2^07]: 10
(2^07, 2^08]: 351275
(2^08, 2^09]: 2571
sum_limbo_reclamation_event_size_total=77135961
count_limbo_reclamation_event_size_by_thread=3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686 3686
count_limbo_reclamation_event_size_total=353856
sum_limbo_reclamation_event_count_total=354048
first_thread_announced_epoch_by_thread=9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262 9262
sum_num_inserts_by_thread=1599831 1604078 1613923 1616593 1604331 1594490 1596674 1607295 1622064 1620148 1607842 1605837 1606739 1611033 1616003 1612620 1609187 1605681 1599111 1602538 1613047 1612438 1599067 1593958 1599848 1605691 1613875 1613562 1604519 1590002 1599983 1606856 1616848 1619034 1603479 1600383 1604933 1596538 1614012 1616627 1613130 1603549 1599373 1606512 1606658 1614159 1605794 1593556 1606004 1613477 1618833 1620408 1609394 1605142 1605086 1610793 1620966 1622408 1615285 1605028 1607505 1615270 1620641 1619399 1614839 1600698 1599689 1608052 1618647 1620283 1608970 1602734 1606073 1611831 1625241 1622985 1612528 1610576 1605745 1612053 1626602 1622345 1616178 1608317 1612055 1617600 1623591 1624313 1611947 1605218 1600264 1612090 1623463 1623697 1612370 1604362
sum_num_inserts_total=154564444
sum_num_deletes_by_thread=1602874 1606515 1614024 1615658 1607171 1594709 1596340 1604021 1622489 1621103 1608922 1605566 1608240 1613421 1616070 1614478 1608430 1600784 1599204 1602392 1610459 1614802 1602363 1595684 1599136 1604355 1615772 1609825 1606073 1589480 1598935 1604906 1616801 1621272 1601638 1599656 1606956 1593091 1616333 1618108 1613033 1607050 1598118 1605838 1609474 1616717 1602179 1596761 1604289 1616031 1617840 1618125 1609041 1608206 1604532 1612394 1620945 1622491 1615590 1603350 1609543 1614137 1624611 1619169 1615174 1599748 1602551 1606883 1617823 1618859 1607025 1604091 1607218 1612214 1626002 1622715 1616123 1610198 1605043 1610890 1623801 1621898 1615145 1611217 1612090 1615992 1624314 1622854 1611073 1604092 1601973 1610521 1621938 1622649 1614438 1605605
sum_num_deletes_total=154579677
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3202705 3210593 3227947 3232251 3211502 3189199 3193014 3211316 3244553 3241251 3216764 3211403 3214979 3224454 3232073 3227098 3217617 3206465 3198315 3204930 3223506 3227240 3201430 3189642 3198984 3210046 3229647 3223387 3210592 3179482 3198918 3211762 3233649 3240306 3205117 3200039 3211889 3189629 3230345 3234735 3226163 3210599 3197491 3212350 3216132 3230876 3207973 3190317 3210293 3229508 3236673 3238533 3218435 3213348 3209618 3223187 3241911 3244899 3230875 3208378 3217048 3229407 3245252 3238568 3230013 3200446 3202240 3214935 3236470 3239142 3215995 3206825 3213291 3224045 3251243 3245700 3228651 3220774 3210788 3222943 3250403 3244243 3231323 3219534 3224145 3233592 3247905 3247167 3223020 3209310 3202237 3222611 3245401 3246346 3226808 3209967
average_num_operations_total=3220251
stdev_num_operations_total=1680
sum_num_operations_total=309144121
min_num_operations_total=3179482
max_num_operations_total=3251243
first_time_thread_terminate_by_thread=10000139 10000136 10000136 10000139 10000136 10000136 10000136 10000136 10000136 10000137 10000152 10000137 10000137 10000136 10000139 10000139 10000136 10000136 10000139 10000136 10000139 10000136 10000143 10000137 10000138 10000136 10000136 10000139 10000140 10000136 10000138 10000136 10000138 10000137 10000138 10000137 10000140 10000137 10000137 10000146 10000136 10000140 10000137 10000136 10000136 10000136 10000139 10000138 10000139 10000141 10000140 10000138 10000137 10000137 10000142 10000137 10000140 10000140 10000140 10000136 10000140 10000141 10000137 10000138 10000137 10000138 10000136 10000139 10000138 10000136 10000137 10000137 10000140 10000137 10000139 10000138 10000137 10000137 10000140 10000138 10000138 10000137 10000139 10000136 10000140 10000140 10000137 10000138 10000140 10000140 10000138 10000138 10000142 10000136 10000137 10000137
min_time_thread_terminate_total=10000136
max_time_thread_terminate_total=10000152
first_time_thread_start_by_thread=5 5 4 4 5 4 5 5 5 4 5 4 4 4 5 5 5 4 4 5 5 4 5 4 5 5 4 4 5 4 5 5 5 4 5 4 4 4 5 5 5 4 4 5 5 4 5 4 4 5 4 5 5 5 4 5 4 5 5 5 4 5 5 5 5 5 5 5 4 5 5 5 4 5 4 5 5 5 4 5 4 5 5 5 4 5 5 5 5 5 5 5 4 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=100022093279584
threads_final_size=10002240
final_keysum=100022093279584
final_size=10002240
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=154564444
total_deletes=154579677
total_updates=309144121
total_queries=0
total_ops=309144121
find_throughput=0
rq_throughput=0
update_throughput=30914412
query_throughput=0
total_throughput=30914412
total find : 0
total rq : 0
total inserts : 154564444
total deletes : 154579677
total updates : 309144121
total queries : 0
total ops : 309144121
find throughput : 0
rq throughput : 0
update throughput : 30914412
query throughput : 0
total throughput : 30914412
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=31.2504
PAPI_L3_TCM=12.4113
PAPI_TOT_CYC=8638.01
PAPI_TOT_INS=3259.77
garbage=0
total_execution_walltime=12.853s
REALTIME_MAIN_END_PERF_FORMAT=6988404.329678566
[time_cmd_output] time_elapsed_sec=13.02, faults_major=0, faults_minor=241105, mem_maxresident_kb=961760, user_cputime=1223.96, sys_cputime=3.76, percent_cpu=9423%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2