__step=000283 __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" ./drachsler_pext_bst_lock.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000283.txt __path_data=data/data000283.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6982189.639404013 binary=./drachsler_pext_bst_lock.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=drachsler_pext_bst_lock 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=0.5 DEL_FRAC=0.5 RQ=0 RQSIZE=0 MAXKEY=200000 PREFILL_THREADS=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 RQ_THREADS=0 distribution=0 INS_DEL_FRAC=0.5 0.5 PREFILL_TYPE=PREFILL_HYBRID PREFILL_HYBRID_MIN_MS=1000 PREFILL_HYBRID_MAX_MS=5000 sizes: node=192 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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.009s prefilling_size=100174 prefilling_elapsed_millis=1.001s finished prefilling to size 100193 for expected size 100000 keysum=10025271449, performing 69496289 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100193 pref_millis=1102 prefill_elapsed_ms=1122 6node_tIxPvE_object_size=192 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=870 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6982190.968531937 REALTIME_END_PERF_FORMAT=6982200.968646620 ############################################################################### ################################## 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 894 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.028s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 251 477 847 1359 2027 2823 3762 4731 5613 6219 6531 6413 5990 5168 4214 3156 2246 1478 920 523 274 132 46 10 5 2 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 2 11 47 187 382 679 1023 1515 2069 2679 3165 3560 3606 3626 3231 2754 2113 1562 1031 678 404 209 117 41 8 5 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 253 488 894 1546 2409 3502 4785 6246 7682 8898 9696 9973 9596 8794 7445 5910 4359 3040 1951 1201 678 341 163 51 13 7 2 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 253 488 894 1546 2409 3502 4785 6246 7682 8898 9696 9973 9596 8794 7445 5910 4359 3040 1951 1201 678 341 163 51 13 7 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.97656 1.93676 1.85451 1.78188 1.67917 1.61229 1.56025 1.51912 1.47246 1.42762 1.39076 1.35499 1.31916 1.29221 1.25893 1.2278 1.20355 1.18215 1.15559 1.14403 1.12906 1.09882 1.09091 1.03067 1.05882 1.15385 1 1 tree_stats_height=35 tree_stats_numInternals=65472 tree_stats_numLeaves=34706 tree_stats_numNodes=100178 tree_stats_numKeys=100178 tree_stats_avgDegreeInternal=1.53009 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34644 tree_stats_avgKeyDepth=18.8 tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 48576 93696 171648 296832 462528 672384 918720 1199232 1474944 1708416 1861632 1914816 1842432 1688448 1429440 1134720 836928 583680 374592 230592 130176 65472 31296 9792 2496 1344 384 tree_stats_sizeInBytes=19234176 6node_tIxPvE_object_size=192 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=21750 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:217921 2:452499 4:193511 8:2436 [2^00, 2^01]: 217921 (2^01, 2^02]: 452499 (2^02, 2^03]: 193511 (2^03, 2^04]: 2436 sum_limbo_reclamation_event_size_total=2227436 count_limbo_reclamation_event_size_by_thread=8994 8998 9045 9058 9047 8938 9049 9082 9098 9013 9049 8976 9011 9006 9076 9049 9053 9037 9029 9073 9102 9073 9052 8976 8949 9016 9000 8990 8997 8969 9012 8971 9034 9003 8969 8997 9023 9026 9029 9039 9043 9056 9036 8999 8994 8984 8978 9031 9000 9047 9004 8967 9057 9086 8971 8997 9024 9058 9010 8968 8988 8984 9028 9033 9015 8990 9008 9034 8997 9016 9039 9046 8994 9056 9056 9064 9074 9034 9050 9061 9021 9063 9077 9017 9026 9056 9003 9009 9001 9027 8967 9057 9111 9087 9057 9003 count_limbo_reclamation_event_size_total=866367 sum_limbo_reclamation_event_count_total=2004480 first_thread_announced_epoch_by_thread=43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 43500 sum_num_inserts_by_thread=95723 95845 97255 97740 97839 95367 97511 97300 96786 97404 97510 96635 96547 96922 99228 98255 97760 98218 96526 97656 98344 97767 96568 95902 94936 95356 96990 96296 96977 94961 96025 95368 97628 98044 95813 96685 96869 97650 97534 97768 97326 97891 96751 96431 96644 96397 96380 95246 95854 96996 97578 96963 97580 97223 96166 97041 97833 97081 97221 96146 95579 97068 97841 96676 95591 96405 97115 95686 97965 96704 96757 96305 94836 96696 98105 98502 97707 97830 98026 97237 97933 97689 98050 96542 97618 97093 97738 96930 95656 94825 95575 97936 98109 97749 96658 96616 sum_num_inserts_total=9305604 sum_num_deletes_by_thread=95595 96212 97786 97616 98128 95852 97378 96999 97039 97752 98171 96265 96541 97134 98400 98681 97643 97795 95770 97153 98919 97680 96644 95698 94348 95249 96724 96387 97271 95307 96689 95386 97296 97649 95588 96160 97349 97939 97222 97337 97033 97889 97342 96286 96742 96206 96141 95145 96657 96911 97021 96893 97372 97898 95899 97008 97601 97797 97645 95719 95483 97607 98072 96609 96207 96250 96824 96457 97651 97251 96760 95825 94854 96660 98329 98277 97766 97533 97079 96858 97901 97664 98153 96497 97312 96771 97995 97065 95724 95883 95290 97822 97975 97399 96938 95949 sum_num_deletes_total=9304647 sum_num_searches_by_thread=18931615 19051763 19403480 19413667 19355756 18928206 19314742 19136662 19224239 19378372 19375540 19079568 19118161 19196665 19441716 19467204 19402507 19337720 19038152 19341131 19468647 19314654 19174547 18950173 18712337 18955673 19281063 19086198 19202605 18826562 19062015 18946654 19364616 19376778 18946458 19071725 19130448 19329728 19297112 19297244 19195561 19360303 19191336 19037045 19152018 19194257 18971100 18892619 19101998 19200318 19309581 19184741 19263952 19313144 19110520 19195959 19337179 19328765 19341862 19031198 18939818 19152878 19404182 19228448 19050725 19137864 19224721 19048064 19436610 19192434 19301104 18947667 18836223 19128606 19479537 19428629 19363152 19397999 19314395 19172941 19301966 19321762 19414083 19080170 19292474 19144643 19406483 19171190 18952409 18903895 18954494 19276712 19506440 19346927 19216900 19130298 sum_num_searches_total=1843052402 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=19122933 19243820 19598521 19609023 19551723 19119425 19509631 19330961 19418064 19573528 19571221 19272468 19311249 19390721 19639344 19664140 19597910 19533733 19230448 19535940 19665910 19510101 19367759 19141773 18901621 19146278 19474777 19278881 19396853 19016830 19254729 19137408 19559540 19572471 19137859 19264570 19324666 19525317 19491868 19492349 19389920 19556083 19385429 19229762 19345404 19386860 19163621 19083010 19294509 19394225 19504180 19378597 19458904 19508265 19302585 19390008 19532613 19523643 19536728 19223063 19130880 19347553 19600095 19421733 19242523 19330519 19418660 19240207 19632226 19386389 19494621 19139797 19025913 19321962 19675971 19625408 19558625 19593362 19509500 19367036 19497800 19517115 19610286 19273209 19487404 19338507 19602216 19365185 19143789 19094603 19145359 19472470 19702524 19542075 19410496 19322863 average_num_operations_total=19392319 stdev_num_operations_total=18205 sum_num_operations_total=1861662653 min_num_operations_total=18901621 max_num_operations_total=19702524 first_time_thread_terminate_by_thread=10000115 10000117 10000115 10000115 10000115 10000115 10000115 10000115 10000116 10000116 10000115 10000115 10000116 10000115 10000115 10000117 10000116 10000115 10000115 10000115 10000116 10000115 10000115 10000115 10000115 10000117 10000115 10000115 10000115 10000115 10000115 10000115 10000116 10000116 10000115 10000115 10000116 10000115 10000115 10000117 10000116 10000115 10000115 10000115 10000116 10000115 10000115 10000115 10000115 10000115 10000114 10000115 10000117 10000116 10000115 10000115 10000115 10000115 10000114 10000114 10000115 10000116 10000116 10000116 10000116 10000116 10000116 10000116 10000116 10000114 10000115 10000114 10000115 10000115 10000114 10000115 10000117 10000116 10000115 10000115 10000115 10000115 10000114 10000114 10000115 10000116 10000116 10000116 10000116 10000116 10000116 10000116 10000116 10000114 10000115 10000114 min_time_thread_terminate_total=10000114 max_time_thread_terminate_total=10000117 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 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 3 2 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=9998049867 threads_final_size=100178 final_keysum=9998049867 final_size=100178 validate_result=success Validation OK. Structural validation OK. total_find=1843052402 total_rq=0 total_inserts=9305604 total_deletes=9304647 total_updates=18610251 total_queries=1843052402 total_ops=1861662653 find_throughput=184305240 rq_throughput=0 update_throughput=1861025 query_throughput=184305240 total_throughput=186166265 total find : 1843052402 total rq : 0 total inserts : 9305604 total deletes : 9304647 total updates : 18610251 total queries : 1843052402 total ops : 1861662653 find throughput : 184305240 rq throughput : 0 update throughput : 1861025 query throughput : 184305240 total throughput : 186166265 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=4.03544 PAPI_L3_TCM=0.0916011 PAPI_TOT_CYC=1435.35 PAPI_TOT_INS=319.685 garbage=92150463190565 total_execution_walltime=11.438s REALTIME_MAIN_END_PERF_FORMAT=6982201.91232028 [time_cmd_output] time_elapsed_sec=11.58, faults_major=0, faults_minor=97755, mem_maxresident_kb=388728, user_cputime=1089.09, sys_cputime=5.01, percent_cpu=9447% timeout=false algorithm=drachsler_pext_bst_lock.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1