__step=000354 __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" ./brown_sigouin_abtree_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=data000354.txt __path_data=data/data000354.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x560f9ce90480 addrof(kcasDescriptors[1])=0x560f9ce90c00 addrof(rdcssDescriptors[0])=0x560f9cf80480 addrof(rdcssDescriptors[1])=0x560f9cf80540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6983034.66462714 binary=./brown_sigouin_abtree_kcas_validate.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_sigouin_abtree_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=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.007s prefilling_size=8833429 prefilling_elapsed_millis=1.001s prefilling_size=9043803 prefilling_elapsed_millis=1.101s prefilling_size=9210099 prefilling_elapsed_millis=1.201s prefilling_size=9348004 prefilling_elapsed_millis=1.301s prefilling_size=9459601 prefilling_elapsed_millis=1.402s prefilling_size=9553470 prefilling_elapsed_millis=1.502s prefilling_size=9629779 prefilling_elapsed_millis=1.602s prefilling_size=9694758 prefilling_elapsed_millis=1.702s prefilling_size=9749392 prefilling_elapsed_millis=1.802s prefilling_size=9791755 prefilling_elapsed_millis=1.903s prefilling_size=9825922 prefilling_elapsed_millis=2.003s finished prefilling to size 9826017 for expected size 10000000 keysum=98277672876436, performing 85933314 updates; total_prefilling_elapsed_ms=2104 ms) pref_size=9826017 pref_millis=2104 prefill_elapsed_ms=2125 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6983036.334450795 REALTIME_END_PERF_FORMAT=6983046.334592061 ############################################################################### ################################## 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 3814 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.054s tree_stats_numInternalsAtDepth=1 1 10 68 512 3814 28406 222747 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1752232 tree_stats_numNodesAtDepth=1 1 10 68 512 3814 28406 222747 1752232 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9975681 tree_stats_avgDegreeAtDepth=1 10 6.8 7.52941 7.44922 7.44782 7.84155 7.86647 5.69313 tree_stats_height=9 tree_stats_numInternals=255559 tree_stats_numLeaves=1752232 tree_stats_numNodes=2007791 tree_stats_numKeys=9975681 tree_stats_avgDegreeInternal=7.85647 tree_stats_avgDegreeLeaves=5.69313 tree_stats_avgDegree=5.96849 tree_stats_avgKeyDepth=8 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:51310 2:57124 4:9850 8:385 16:1 [2^00, 2^01]: 51310 (2^01, 2^02]: 57124 (2^02, 2^03]: 9850 (2^03, 2^04]: 385 (2^04, 2^05]: 1 sum_limbo_reclamation_event_size_total=218153 count_limbo_reclamation_event_size_by_thread=2468 2436 2482 2310 2378 2478 2602 2402 2578 2370 2306 2428 2396 2666 2400 2634 2614 2498 2564 2448 2632 2596 2368 2460 2530 2350 2392 2444 2330 2606 2528 2332 2632 2444 2348 2624 2542 2448 2520 2500 2412 2522 2314 2434 2444 2344 2554 2562 count_limbo_reclamation_event_size_total=118670 sum_limbo_reclamation_event_count_total=2038560 first_thread_announced_epoch_by_thread=50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 50404 sum_commit_tx_reader_total= sum_commit_tx_reader_by_thread= sum_commit_tx_writer_total= sum_commit_tx_writer_by_thread= sum_abort_tx_total= sum_abort_tx_by_thread= max_ht_capacity_by_thread= linear_histogram_of_none_tx_rdset_size_full_data= linear_histogram_of_none_tx_wrset_size_full_data= sum_fasthtm_commit_total= sum_fasthtm_abort_total= sum_htmpostfix_commit_total= sum_htmpostfix_abort_total= sum_htmprefix_commit_total= sum_htmprefix_abort_total= sum_htmprefix_abort_explicit_total= sum_htmprefix_abort_conflict_total= sum_htmprefix_abort_capacity_total= sum_htmprefix_abort_nesting_total= sum_htmprefix_abort_illegal_total= sum_htmprefix_abort_zero_total= sum_stmprefix_abort_total= sum_stmprefix_commit_total= sum_slow_commit_total= sum_abtree_insert_repeat_total=56 sum_abtree_erase_repeat_total=8 sum_abtree_search_repeat_total=2 sum_abtree_search_complete_total=47346109 sum_abtree_fix_weight_viol_attempt_total=181390 sum_abtree_fix_degree_viol_attempt_total=119820 sum_abtree_rebalancing_kcas_attempt_total=301209 sum_abtree_update_kcas_attempt_total=23519968 sum_abtree_internal_complex_search_while_iters_total=47346116 sum_abtree_internal_basic_search_while_iters_total=423309868 sum_kcas_desc_new_total= sum_num_inserts_by_thread=487223 489758 492523 493386 490505 485679 487314 490171 494212 495105 488094 486172 487781 490695 493466 492441 490305 487507 485507 488200 490667 492348 488021 486341 488092 489194 492769 492499 492599 486876 488040 489132 492854 494723 490733 488546 488262 491342 492682 494767 490703 488466 486807 489234 491379 493180 488055 484534 sum_num_inserts_total=23518889 sum_num_deletes_by_thread=487277 489105 493248 491663 491260 487483 488196 489126 492435 494709 488442 487695 488487 491150 492645 494848 490983 489610 486536 487745 490002 491184 487862 484710 486812 488900 494469 492083 491344 487234 488548 488939 495177 495701 489572 487591 489224 493378 493895 493864 490512 488910 487414 487893 490352 493599 489504 484585 sum_num_deletes_total=23525901 sum_num_searches_by_thread=8765504 8812895 8868206 8855420 8831934 8747343 8776223 8817298 8887840 8902197 8797351 8771472 8793525 8836611 8882916 8876269 8825482 8796172 8745291 8788206 8828435 8871815 8781707 8740924 8763344 8802850 8873654 8854190 8840113 8755943 8780853 8810607 8890435 8908933 8819616 8783220 8794738 8856454 8887553 8895936 8840661 8787950 8751223 8799063 8841703 8861757 8787235 8720045 sum_num_searches_total=423309112 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=9740004 9791758 9853977 9840469 9813699 9720505 9751733 9796595 9874487 9892011 9773887 9745339 9769793 9818456 9869027 9863558 9806770 9773289 9717334 9764151 9809104 9855347 9757590 9711975 9738248 9780944 9860892 9838772 9824056 9730053 9757441 9788678 9878466 9899357 9799921 9759357 9772224 9841174 9874130 9884567 9821876 9765326 9725444 9776190 9823434 9848536 9764794 9689164 average_num_operations_total=9799039 stdev_num_operations_total=7965 sum_num_operations_total=470353902 min_num_operations_total=9689164 max_num_operations_total=9899357 first_time_thread_terminate_by_thread=10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 min_time_thread_terminate_total=10000141 max_time_thread_terminate_total=10000141 first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 min_time_thread_start_total=4 max_time_thread_start_total=4 sum_duration_all_ops_total= threads_final_keysum=99757645928469 threads_final_size=9975681 final_keysum=99757645928469 final_size=9975681 validate_result=success Validation OK. Structural validation OK. total_find=423309112 total_rq=0 total_inserts=23518889 total_deletes=23525901 total_updates=47044790 total_queries=423309112 total_ops=470353902 find_throughput=42330911 rq_throughput=0 update_throughput=4704479 query_throughput=42330911 total_throughput=47035390 total find : 423309112 total rq : 0 total inserts : 23518889 total deletes : 23525901 total updates : 47044790 total queries : 423309112 total ops : 470353902 find throughput : 42330911 rq throughput : 0 update throughput : 4704479 query throughput : 42330911 total throughput : 47035390 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=18.4631 PAPI_L3_TCM=6.3699 PAPI_TOT_CYC=2831.45 PAPI_TOT_INS=962.089 garbage=2102404292951301 total_execution_walltime=12.416s REALTIME_MAIN_END_PERF_FORMAT=6983046.483921319 [time_cmd_output] time_elapsed_sec=12.58, faults_major=0, faults_minor=185642, mem_maxresident_kb=742976, user_cputime=613.50, sys_cputime=2.66, percent_cpu=4896% timeout=false algorithm=brown_sigouin_abtree_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