__step=000874 __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" ./bronson_pext_bst_occ.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000874.txt __path_data=data/data000874.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6989499.556301146 binary=./bronson_pext_bst_occ.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=bronson_pext_bst_occ 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=2000000 PREFILL_THREADS=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.005s prefilling_size=999316 prefilling_elapsed_millis=1.001s finished prefilling to size 999358 for expected size 1000000 keysum=998522356289, performing 42327040 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999358 pref_millis=1102 prefill_elapsed_ms=1125 6node_tIxPvE_object_size=56 6node_tIxPvE_allocated_count=0 6node_tIxPvE_allocated_size=0MB 6node_tIxPvE_get_from_pool=0 6node_tIxPvE_deallocated=0 6node_tIxPvE_limbo_count=0 6node_tIxPvE_limbo_details=0 0 0 global_epoch_counter=1946 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6989500.826549818 REALTIME_END_PERF_FORMAT=6989510.826711106 ############################################################################### ################################## 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.042s tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65381 124119 184710 164563 71611 9919 153 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 148 6035 53934 161985 192119 93219 12705 183 tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65529 130154 238644 326548 263730 103138 12858 183 tree_stats_numKeysAtDepth=0 1 0 1 3 10 13 42 60 138 234 529 1034 2038 4130 8162 16717 35459 82420 185724 293520 254488 102404 12851 183 tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99979 1.98846 1.87992 1.59434 1.30366 1.11952 1.02847 1.00233 1 tree_stats_height=25 tree_stats_numInternals=685992 tree_stats_numLeaves=520328 tree_stats_numNodes=1206320 tree_stats_numKeys=1000161 tree_stats_avgDegreeInternal=1.7585 tree_stats_avgDegreeLeaves=0.999965 tree_stats_avgDegree=1.43132 tree_stats_avgKeyDepth=19.8764 tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3669624 7288624 13364064 18286688 14768880 5775728 720048 10248 tree_stats_sizeInBytes=67553920 6node_tIxPvE_object_size=56 6node_tIxPvE_allocated_count=0 6node_tIxPvE_allocated_size=0MB 6node_tIxPvE_get_from_pool=0 6node_tIxPvE_deallocated=0 6node_tIxPvE_limbo_count=0 6node_tIxPvE_limbo_details=0 0 0 global_epoch_counter=20019 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:1 8:0 16:3 32:1413 64:478342 128:145 (2^02, 2^03]: 1 (2^03, 2^04]: 0 (2^04, 2^05]: 3 (2^05, 2^06]: 1413 (2^06, 2^07]: 478342 (2^07, 2^08]: 145 sum_limbo_reclamation_event_size_total=43097278 count_limbo_reclamation_event_size_by_thread=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 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=479904 sum_limbo_reclamation_event_count_total=867504 first_thread_announced_epoch_by_thread=40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 40038 sum_num_inserts_by_thread=4062582 4089083 4123878 4120627 4105363 4065727 4070175 4098179 4150362 4150236 4098337 4071656 4077754 4100761 4113124 4128548 4099312 4078261 4057287 4066950 4090705 4115596 4077475 4057093 4060431 4087659 4121727 4112612 4071373 4039095 4076475 4092259 4142508 4144211 4090390 4040849 4043879 4067162 4113075 4124018 4105526 4082860 4049847 4060263 4094649 4115765 4081524 4053360 sum_num_inserts_total=196340588 sum_num_deletes_by_thread=4061506 4088454 4124396 4122997 4103995 4063078 4069779 4096671 4146516 4151724 4092677 4072076 4075862 4101539 4113615 4130825 4101354 4077466 4054972 4063179 4090858 4113427 4080531 4056055 4063394 4089462 4121772 4108836 4069309 4037895 4074411 4088140 4142500 4147921 4086970 4043673 4040868 4068380 4111658 4122372 4105742 4084176 4050507 4057116 4097580 4120133 4083561 4057793 sum_num_deletes_total=196327721 sum_num_searches_by_thread= sum_num_searches_total= sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=8124088 8177537 8248274 8243624 8209358 8128805 8139954 8194850 8296878 8301960 8191014 8143732 8153616 8202300 8226739 8259373 8200666 8155727 8112259 8130129 8181563 8229023 8158006 8113148 8123825 8177121 8243499 8221448 8140682 8076990 8150886 8180399 8285008 8292132 8177360 8084522 8084747 8135542 8224733 8246390 8211268 8167036 8100354 8117379 8192229 8235898 8165085 8111153 average_num_operations_total=8180589 stdev_num_operations_total=8615 sum_num_operations_total=392668309 min_num_operations_total=8076990 max_num_operations_total=8301960 first_time_thread_terminate_by_thread=10000160 10000161 10000161 10000161 10000161 10000162 10000161 10000161 10000161 10000161 10000161 10000160 10000161 10000161 10000160 10000161 10000160 10000160 10000161 10000160 10000160 10000161 10000160 10000161 10000160 10000160 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000160 10000161 10000161 10000160 10000161 10000160 10000161 10000160 10000160 10000160 10000161 10000161 10000160 min_time_thread_terminate_total=10000160 max_time_thread_terminate_total=10000162 first_time_thread_start_by_thread=3 3 2 3 3 3 3 2 3 2 2 2 2 2 2 3 3 3 2 3 3 3 3 2 3 3 2 3 3 3 3 2 3 2 2 2 2 2 2 3 3 3 2 3 3 3 3 2 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=1000611830444 threads_final_size=1000161 final_keysum=1000611830444 final_size=1000161 validate_result=success Validation OK. Structural validation OK. total_find=0 total_rq=0 total_inserts=196340588 total_deletes=196327721 total_updates=392668309 total_queries=0 total_ops=392668309 find_throughput=0 rq_throughput=0 update_throughput=39266830 query_throughput=0 total_throughput=39266830 total find : 0 total rq : 0 total inserts : 196340588 total deletes : 196327721 total updates : 392668309 total queries : 0 total ops : 392668309 find throughput : 0 rq throughput : 0 update throughput : 39266830 query throughput : 0 total throughput : 39266830 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=20.8678 PAPI_L3_TCM=3.8276 PAPI_TOT_CYC=3318.31 PAPI_TOT_INS=1738.26 garbage=0 total_execution_walltime=11.423s REALTIME_MAIN_END_PERF_FORMAT=6989510.980450692 [time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=94885, mem_maxresident_kb=381368, user_cputime=562.65, sys_cputime=2.95, percent_cpu=4897% timeout=false algorithm=bronson_pext_bst_occ.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2