__step=000601 __cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000601.txt __path_data=data/data000601.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x563edf634400 addrof(kcasDescriptors[1])=0x563edf634d00 addrof(rdcssDescriptors[0])=0x563edf754400 addrof(rdcssDescriptors[1])=0x563edf7544c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7002044.592132992 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=200000 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.005s prefilling_size=100009 prefilling_elapsed_millis=1.001s finished prefilling to size 100010 for expected size 100000 keysum=9998488418, performing 56714082 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100010 pref_millis=1102 prefill_elapsed_ms=1122 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7002045.894369927 REALTIME_END_PERF_FORMAT=7002055.894531860 ############################################################################### ################################## 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 796 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.05s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 121 234 419 753 1271 2035 3003 4136 5380 6331 6884 6892 6522 5622 4695 3766 2714 1866 1238 705 400 225 130 73 45 28 9 5 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 3 3 33 43 127 274 598 1039 1573 2365 3084 3664 3801 3937 3431 2937 2499 1863 1277 902 511 279 169 105 59 37 27 5 5 1 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 124 237 452 796 1398 2309 3601 5175 6953 8696 9968 10556 10323 9559 8126 6703 5213 3729 2515 1607 911 504 299 178 104 65 36 10 6 1 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 124 237 452 796 1398 2309 3601 5175 6953 8696 9968 10556 10323 9559 8126 6703 5213 3729 2515 1607 911 504 299 178 104 65 36 10 6 1 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.95312 1.93548 1.91983 1.83407 1.8103 1.74249 1.67822 1.60317 1.54435 1.47692 1.41824 1.36838 1.32503 1.2942 1.26195 1.24711 1.21587 1.19471 1.17404 1.14672 1.12819 1.11416 1.14683 1.16054 1.17416 1.19231 1.12308 1.02778 1.1 1 1 tree_stats_height=37 tree_stats_numInternals=65629 tree_stats_numLeaves=34652 tree_stats_numNodes=100281 tree_stats_numKeys=100281 tree_stats_avgDegreeInternal=1.528 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34555 tree_stats_avgKeyDepth=18.5475 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:74 2:1482 4:51409 8:374624 16:52283 32:20 [2^00, 2^01]: 74 (2^01, 2^02]: 1482 (2^02, 2^03]: 51409 (2^03, 2^04]: 374624 (2^04, 2^05]: 52283 (2^05, 2^06]: 20 sum_limbo_reclamation_event_size_total=5483085 count_limbo_reclamation_event_size_by_thread=9996 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9997 9998 9998 9998 9997 9998 9998 9996 9998 9998 9998 9998 9997 9998 9997 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=479892 sum_limbo_reclamation_event_count_total=1758335 first_thread_announced_epoch_by_thread=78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 78582 sum_num_inserts_by_thread=830578 835439 843721 842484 832805 821685 827205 833636 854623 853269 840150 840129 832267 838394 849256 842952 840391 831613 834772 833539 846170 841117 830695 828172 825827 830212 843579 841803 837554 826045 835901 835332 850150 844769 837953 832407 831519 836005 844469 847363 843468 828651 823042 836710 840274 849007 836648 830306 sum_num_inserts_total=40194056 sum_num_deletes_by_thread=828064 835795 844337 842201 832617 824388 827138 831532 852692 853941 837735 838961 830531 836472 847640 843588 840084 829606 832550 832548 846564 841162 829641 825851 827130 832360 842869 838953 838094 825385 835291 834313 851562 845478 839534 833928 830856 834848 841198 848693 844372 827439 824047 836828 839656 847608 837532 828718 sum_num_deletes_total=40172330 sum_num_searches_by_thread=14938638 15062055 15194124 15178985 14992985 14831934 14901457 15010904 15364983 15349485 15094787 15127258 15008547 15051798 15264544 15189237 15146334 14939351 14997729 15001659 15236449 15157280 14935208 14898771 14867903 14949328 15169169 15111274 15081042 14874578 15029999 15037878 15332073 15217885 15071005 14983451 14960082 15045812 15163283 15253911 15196905 14892886 14823747 15065144 15117955 15271038 15069903 14928968 sum_num_searches_total=723389721 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=16597280 16733289 16882182 16863670 16658407 16478007 16555800 16676072 17072298 17056695 16772672 16806348 16671345 16726664 16961440 16875777 16826809 16600570 16665051 16667746 16929183 16839559 16595544 16552794 16520860 16611900 16855617 16792030 16756690 16526008 16701191 16707523 17033785 16908132 16748492 16649786 16622457 16716665 16848950 16949967 16884745 16548976 16470836 16738682 16797885 16967653 16744083 16587992 average_num_operations_total=16744918 stdev_num_operations_total=22582 sum_num_operations_total=803756107 min_num_operations_total=16470836 max_num_operations_total=17072298 first_time_thread_terminate_by_thread=10000162 10000162 10000161 10000162 10000161 10000162 10000161 10000161 10000161 10000162 10000161 10000162 10000161 10000162 10000162 10000161 10000161 10000162 10000162 10000162 10000161 10000162 10000162 10000162 10000162 10000162 10000161 10000162 10000161 10000162 10000161 10000161 10000161 10000162 10000161 10000162 10000161 10000162 10000162 10000162 10000161 10000162 10000162 10000162 10000161 10000162 10000162 10000162 min_time_thread_terminate_total=10000161 max_time_thread_terminate_total=10000162 first_time_thread_start_by_thread=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 3 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10019148772 threads_final_size=100281 final_keysum=10019148772 final_size=100281 validate_result=success Validation OK. Structural validation OK. total_find=723389721 total_rq=0 total_inserts=40194056 total_deletes=40172330 total_updates=80366386 total_queries=723389721 total_ops=803756107 find_throughput=72338972 rq_throughput=0 update_throughput=8036638 query_throughput=72338972 total_throughput=80375610 total find : 723389721 total rq : 0 total inserts : 40194056 total deletes : 40172330 total updates : 80366386 total queries : 723389721 total ops : 803756107 find throughput : 72338972 rq throughput : 0 update throughput : 8036638 query throughput : 72338972 total throughput : 80375610 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.43961 PAPI_L3_TCM=0.000160794 PAPI_TOT_CYC=1627.98 PAPI_TOT_INS=1116.11 garbage=36184738329700 total_execution_walltime=11.436s REALTIME_MAIN_END_PERF_FORMAT=7002056.28884544 [time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=77149, mem_maxresident_kb=310368, user_cputime=558.79, sys_cputime=1.14, percent_cpu=4850% 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=1