__step=000410
__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_bst_kcas_validate.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=data000410.txt
__path_data=data/data000410.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x5603cc853400
addrof(kcasDescriptors[1])=0x5603cc853d00
addrof(rdcssDescriptors[0])=0x5603cc973400
addrof(rdcssDescriptors[1])=0x5603cc9734c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6983799.205441095
binary=./sigouin_int_bst_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_bst_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=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=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
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.006s
prefilling_size=6948764 prefilling_elapsed_millis=1.001s
prefilling_size=7243921 prefilling_elapsed_millis=1.101s
prefilling_size=7508806 prefilling_elapsed_millis=1.201s
prefilling_size=7746298 prefilling_elapsed_millis=1.302s
prefilling_size=7959686 prefilling_elapsed_millis=1.402s
prefilling_size=8152136 prefilling_elapsed_millis=1.502s
prefilling_size=8327154 prefilling_elapsed_millis=1.602s
prefilling_size=8484853 prefilling_elapsed_millis=1.702s
prefilling_size=8627048 prefilling_elapsed_millis=1.803s
prefilling_size=8752809 prefilling_elapsed_millis=1.903s
prefilling_size=8868054 prefilling_elapsed_millis=2.003s
prefilling_size=8973743 prefilling_elapsed_millis=2.103s
prefilling_size=9070887 prefilling_elapsed_millis=2.203s
prefilling_size=9156570 prefilling_elapsed_millis=2.303s
prefilling_size=9234096 prefilling_elapsed_millis=2.404s
prefilling_size=9303511 prefilling_elapsed_millis=2.504s
prefilling_size=9368712 prefilling_elapsed_millis=2.604s
prefilling_size=9427506 prefilling_elapsed_millis=2.704s
prefilling_size=9480995 prefilling_elapsed_millis=2.804s
prefilling_size=9527415 prefilling_elapsed_millis=2.905s
prefilling_size=9568418 prefilling_elapsed_millis=3.005s
prefilling_size=9608439 prefilling_elapsed_millis=3.105s
prefilling_size=9645198 prefilling_elapsed_millis=3.205s
prefilling_size=9678085 prefilling_elapsed_millis=3.305s
prefilling_size=9705807 prefilling_elapsed_millis=3.406s
prefilling_size=9732821 prefilling_elapsed_millis=3.506s
prefilling_size=9756542 prefilling_elapsed_millis=3.606s
prefilling_size=9778312 prefilling_elapsed_millis=3.706s
prefilling_size=9800890 prefilling_elapsed_millis=3.807s
finished prefilling to size 9800898 for expected size 10000000 keysum=98021238775751, performing 79376341 updates; total_prefilling_elapsed_ms=3907 ms)
pref_size=9800898
pref_millis=3907
prefill_elapsed_ms=3926
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6983803.312326242
REALTIME_END_PERF_FORMAT=6983813.312470783
###############################################################################
################################## 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 1002 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.326s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 506 990 1900 3572 6431 11110 18410 29233 44399 64886 90692 121751 156434 194733 235440 276555 315898 351670 382576 407545 423914 430625 427004 411056 385357 350152 307516 261366 214586 170160 129914 95748 67100 45162 29315 18411 11330 6822 4071 2444 1445 915 571 350 228 115 75 47 20 11 5 2 3 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 2 12 45 126 415 959 2099 4144 7668 12808 21081 32027 46847 63131 82016 103090 125861 148228 169963 188736 206815 220178 228434 233130 229152 220278 205583 184527 160962 135142 109572 85006 64533 46161 31503 20678 13332 8120 4900 2910 1767 1003 635 409 250 176 85 53 35 15 10 4 1 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 508 1002 1945 3698 6846 12069 20509 33377 52067 77694 111773 153778 203281 257864 317456 379645 441759 499898 552539 596281 630729 650803 655438 644186 614509 570430 513099 445893 375548 305302 239486 180754 131633 91323 60818 39089 24662 14942 8971 5354 3212 1918 1206 759 478 291 160 100 55 26 15 6 4 3 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 508 1002 1945 3698 6846 12069 20509 33377 52067 77694 111773 153778 203281 257864 317456 379645 441759 499898 552539 596281 630729 650803 655438 644186 614509 570430 513099 445893 375548 305302 239486 180754 131633 91323 60818 39089 24662 14942 8971 5354 3212 1918 1206 759 478 291 160 100 55 26 15 6 4 3 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.98438 1.97638 1.95309 1.92442 1.88534 1.82355 1.77877 1.72978 1.68412 1.63946 1.60348 1.56441 1.53018 1.49896 1.47592 1.45425 1.43515 1.41652 1.40182 1.38677 1.37429 1.35973 1.34544 1.33135 1.31583 1.30117 1.28566 1.26969 1.25607 1.24156 1.22707 1.21229 1.19853 1.18402 1.17144 1.16071 1.15992 1.14646 1.14382 1.14302 1.14344 1.14726 1.15172 1.15589 1.16864 1.1318 1.15464 1.15625 1.08 1.10909 1.15385 1.06667 1.33333 1 1 1
tree_stats_height=64
tree_stats_numInternals=6511084
tree_stats_numLeaves=3424620
tree_stats_numNodes=9935704
tree_stats_numKeys=9935704
tree_stats_avgDegreeInternal=1.52597
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34468
tree_stats_avgKeyDepth=30.3587
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:72 2:1682 4:55593 8:371169 16:51288 32:25 64:72
[2^00, 2^01]: 72
(2^01, 2^02]: 1682
(2^02, 2^03]: 55593
(2^03, 2^04]: 371169
(2^04, 2^05]: 51288
(2^05, 2^06]: 25
(2^06, 2^07]: 72
sum_limbo_reclamation_event_size_total=5439142
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479901
sum_limbo_reclamation_event_count_total=502848
first_thread_announced_epoch_by_thread=28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200 28200
sum_num_inserts_by_thread=238602 239750 240781 241986 241456 237320 239206 239424 242546 242803 239428 238460 239719 240757 243169 240794 241351 240169 238978 239248 241519 241146 238236 237430 239942 240677 240663 241146 241381 238419 239923 239574 242359 241803 239913 238823 239618 241485 242016 243234 242365 239408 238517 239219 242001 241082 239616 237922
sum_num_inserts_total=11535384
sum_num_deletes_by_thread=237080 238935 240931 241305 240969 237999 238871 240530 242704 243516 241303 237942 240713 240618 243203 241763 241514 239680 238640 237870 241142 240439 238647 237462 239513 240911 241080 240901 240518 239413 239712 240892 242431 241791 240480 238327 239872 241377 242437 241831 242110 238697 237638 240476 242091 242335 240038 237773
sum_num_deletes_total=11536420
sum_num_searches_by_thread=4287215 4311260 4341131 4354487 4337939 4275063 4292745 4311090 4359137 4381423 4331281 4292611 4327465 4325674 4369216 4349997 4349202 4317086 4301049 4301592 4347748 4337069 4292715 4268165 4312172 4329217 4342375 4337526 4345463 4300307 4315682 4329088 4360589 4361834 4331473 4289651 4310418 4341533 4355201 4372739 4346662 4300832 4276732 4297601 4344316 4350080 4321852 4272542
sum_num_searches_total=207608245
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4762897 4789945 4822843 4837778 4820364 4750382 4770822 4791044 4844387 4867742 4812012 4769013 4807897 4807049 4855588 4832554 4832067 4796935 4778667 4778710 4830409 4818654 4769598 4743057 4791627 4810805 4824118 4819573 4827362 4778139 4795317 4809554 4845379 4845428 4811866 4766801 4789908 4824395 4839654 4857804 4831137 4778937 4752887 4777296 4828408 4833497 4801506 4748237
average_num_operations_total=4805834
stdev_num_operations_total=4619
sum_num_operations_total=230680049
min_num_operations_total=4743057
max_num_operations_total=4867742
first_time_thread_terminate_by_thread=10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000144 10000143 10000143 10000143 10000144 10000144 10000143 10000143 10000143 10000144 10000143 10000143 10000143 10000143 10000143 10000144 10000143 10000143 10000158 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000143 10000144 10000144 10000143 10000143 10000144 10000144 10000143 10000143 10000143
min_time_thread_terminate_total=10000143
max_time_thread_terminate_total=10000158
first_time_thread_start_by_thread=6 6 7 7 6 6 7 6 6 6 7 7 6 6 7 7 7 7 6 7 6 6 7 7 6 6 7 7 6 6 7 6 6 6 7 7 6 6 7 7 7 7 6 7 6 6 7 7
min_time_thread_start_total=6
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=99365228393469
threads_final_size=9935704
final_keysum=99365228393469
final_size=9935704
validate_result=success
Validation OK.
Structural validation OK.
total_find=207608245
total_rq=0
total_inserts=11535384
total_deletes=11536420
total_updates=23071804
total_queries=207608245
total_ops=230680049
find_throughput=20760824
rq_throughput=0
update_throughput=2307180
query_throughput=20760824
total_throughput=23068004
total find : 207608245
total rq : 0
total inserts : 11535384
total deletes : 11536420
total updates : 23071804
total queries : 207608245
total ops : 230680049
find throughput : 20760824
rq throughput : 0
update throughput : 2307180
query throughput : 20760824
total throughput : 23068004
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=30.9694
PAPI_L3_TCM=9.85167
PAPI_TOT_CYC=5800.71
PAPI_TOT_INS=1611.26
garbage=1026195396253243
total_execution_walltime=14.544s
REALTIME_MAIN_END_PERF_FORMAT=6983813.750303644
[time_cmd_output] time_elapsed_sec=14.73, faults_major=0, faults_minor=235121, mem_maxresident_kb=942784, user_cputime=698.61, sys_cputime=3.48, percent_cpu=4766%
timeout=false
algorithm=sigouin_int_bst_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