__step=000353 __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=data000353.txt __path_data=data/data000353.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x5596e32f4480 addrof(kcasDescriptors[1])=0x5596e32f4c00 addrof(rdcssDescriptors[0])=0x5596e33e4480 addrof(rdcssDescriptors[1])=0x5596e33e4540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6983021.486995526 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.005s prefilling_size=8894416 prefilling_elapsed_millis=1.001s prefilling_size=9105810 prefilling_elapsed_millis=1.101s prefilling_size=9276802 prefilling_elapsed_millis=1.201s prefilling_size=9414868 prefilling_elapsed_millis=1.301s prefilling_size=9519853 prefilling_elapsed_millis=1.402s prefilling_size=9608255 prefilling_elapsed_millis=1.502s prefilling_size=9679068 prefilling_elapsed_millis=1.602s prefilling_size=9740188 prefilling_elapsed_millis=1.702s prefilling_size=9786768 prefilling_elapsed_millis=1.802s prefilling_size=9825328 prefilling_elapsed_millis=1.903s finished prefilling to size 9825403 for expected size 10000000 keysum=98255391913204, performing 82171387 updates; total_prefilling_elapsed_ms=2004 ms) pref_size=9825403 pref_millis=2004 prefill_elapsed_ms=2031 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6983023.694347494 REALTIME_END_PERF_FORMAT=6983033.694497272 ############################################################################### ################################## 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 3775 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.058s tree_stats_numInternalsAtDepth=1 1 8 70 500 3775 28519 222087 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1747789 tree_stats_numNodesAtDepth=1 1 8 70 500 3775 28519 222087 1747789 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9983199 tree_stats_avgDegreeAtDepth=1 8 8.75 7.14286 7.55 7.5547 7.78733 7.86984 5.7119 tree_stats_height=9 tree_stats_numInternals=254961 tree_stats_numLeaves=1747789 tree_stats_numNodes=2002750 tree_stats_numKeys=9983199 tree_stats_avgDegreeInternal=7.85512 tree_stats_avgDegreeLeaves=5.7119 tree_stats_avgDegree=5.98475 tree_stats_avgKeyDepth=8 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:52479 2:58419 4:10440 8:391 16:1 [2^00, 2^01]: 52479 (2^01, 2^02]: 58419 (2^02, 2^03]: 10440 (2^03, 2^04]: 391 (2^04, 2^05]: 1 sum_limbo_reclamation_event_size_total=224686 count_limbo_reclamation_event_size_by_thread=2658 2544 2424 2554 2544 2558 2568 2564 2552 2482 2468 2556 2414 2644 2482 2622 2594 2532 2472 2428 2494 2450 2608 2460 2350 2458 2684 2682 2480 2496 2474 2668 2506 2476 2502 2560 2558 2620 2528 2538 2520 2586 2604 2590 2570 2554 2518 2536 count_limbo_reclamation_event_size_total=121730 sum_limbo_reclamation_event_count_total=2035392 first_thread_announced_epoch_by_thread=49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 49960 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=52 sum_abtree_erase_repeat_total=8 sum_abtree_search_repeat_total= sum_abtree_search_complete_total=47273347 sum_abtree_fix_weight_viol_attempt_total=188390 sum_abtree_fix_degree_viol_attempt_total=117076 sum_abtree_rebalancing_kcas_attempt_total=305464 sum_abtree_update_kcas_attempt_total=23481936 sum_abtree_internal_complex_search_while_iters_total=47273352 sum_abtree_internal_basic_search_while_iters_total=422622849 sum_kcas_desc_new_total= sum_num_inserts_by_thread=486152 488991 491808 489532 488869 485322 487615 488724 492943 493172 489143 486282 485785 491415 492528 492691 490801 486882 486387 487634 491498 493292 487757 484709 487471 488662 491522 490856 490612 484813 487675 487724 492768 493513 488190 486206 488274 491754 492479 493935 490268 487622 485901 487570 491173 492464 487892 485299 sum_num_inserts_total=23484575 sum_num_deletes_by_thread=486439 489559 491983 491729 488534 484444 486252 487806 492113 492698 488829 485933 488266 490273 495097 491904 489315 486578 485019 486590 491077 492719 486390 484552 486429 487665 493715 491196 491018 486941 487126 488840 491915 493055 488406 487486 487919 491033 494292 493162 491329 487751 484843 488106 491625 493207 487757 484291 sum_num_deletes_total=23483206 sum_num_searches_by_thread=8740906 8797657 8849083 8843351 8812014 8730788 8751890 8783768 8869615 8882338 8807933 8747926 8771314 8821884 8888247 8865240 8827038 8769472 8742067 8782800 8838805 8862818 8769038 8725448 8743756 8791441 8852905 8834731 8828905 8733132 8777497 8789707 8882001 8881995 8791898 8747887 8777491 8837880 8871442 8877092 8832766 8780104 8734507 8778928 8836330 8859215 8781783 8717280 sum_num_searches_total=422622113 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=9713497 9776207 9832874 9824612 9789417 9700554 9725757 9760298 9854671 9868208 9785905 9720141 9745365 9803572 9875872 9849835 9807154 9742932 9713473 9757024 9821380 9848829 9743185 9694709 9717656 9767768 9838142 9816783 9810535 9704886 9752298 9766271 9866684 9868563 9768494 9721579 9753684 9820667 9858213 9864189 9814363 9755477 9705251 9754604 9819128 9844886 9757432 9686870 average_num_operations_total=9783122 stdev_num_operations_total=8160 sum_num_operations_total=469589894 min_num_operations_total=9686870 max_num_operations_total=9875872 first_time_thread_terminate_by_thread=10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 10000149 min_time_thread_terminate_total=10000149 max_time_thread_terminate_total=10000149 first_time_thread_start_by_thread=3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=99828585671872 threads_final_size=9983199 final_keysum=99828585671872 final_size=9983199 validate_result=success Validation OK. Structural validation OK. total_find=422622113 total_rq=0 total_inserts=23484575 total_deletes=23483206 total_updates=46967781 total_queries=422622113 total_ops=469589894 find_throughput=42262211 rq_throughput=0 update_throughput=4696778 query_throughput=42262211 total_throughput=46958989 total find : 422622113 total rq : 0 total inserts : 23484575 total deletes : 23483206 total updates : 46967781 total queries : 422622113 total ops : 469589894 find throughput : 42262211 rq throughput : 0 update throughput : 4696778 query throughput : 42262211 total throughput : 46958989 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=18.447 PAPI_L3_TCM=6.36524 PAPI_TOT_CYC=2836.65 PAPI_TOT_INS=963.206 garbage=2099115872720926 total_execution_walltime=12.356s REALTIME_MAIN_END_PERF_FORMAT=6983033.843663461 [time_cmd_output] time_elapsed_sec=12.51, faults_major=0, faults_minor=185244, mem_maxresident_kb=741804, user_cputime=608.82, sys_cputime=3.41, percent_cpu=4891% 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=1