__step=000380 __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" ./guerraoui_ext_bst_ticket.debra -nwork 96 -nprefill 96 -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=data000380.txt __path_data=data/data000380.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6983404.211423210 binary=./guerraoui_ext_bst_ticket.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=guerraoui_ext_bst_ticket 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=96 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=96 WORK_THREADS=96 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,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.011s prefilling_size=8585097 prefilling_elapsed_millis=1.001s prefilling_size=8789328 prefilling_elapsed_millis=1.101s prefilling_size=8963367 prefilling_elapsed_millis=1.201s prefilling_size=9113081 prefilling_elapsed_millis=1.301s prefilling_size=9235619 prefilling_elapsed_millis=1.402s prefilling_size=9341740 prefilling_elapsed_millis=1.502s prefilling_size=9433158 prefilling_elapsed_millis=1.602s prefilling_size=9510939 prefilling_elapsed_millis=1.702s prefilling_size=9576620 prefilling_elapsed_millis=1.802s prefilling_size=9635298 prefilling_elapsed_millis=1.903s prefilling_size=9684462 prefilling_elapsed_millis=2.003s prefilling_size=9728858 prefilling_elapsed_millis=2.103s prefilling_size=9767071 prefilling_elapsed_millis=2.203s prefilling_size=9798253 prefilling_elapsed_millis=2.303s prefilling_size=9824610 prefilling_elapsed_millis=2.404s finished prefilling to size 9824640 for expected size 10000000 keysum=98216794790589, performing 81159474 updates; total_prefilling_elapsed_ms=2505 ms) pref_size=9824640 pref_millis=2505 prefill_elapsed_ms=2529 6node_tIxPvE_object_size=40 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=977 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6983406.940169344 REALTIME_END_PERF_FORMAT=6983416.940260704 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10.1s PRODUCING OUTPUT computing tree_stats in PARALLEL... bounded depth BFS to partition into subtrees for parallel computation (192 threads)... partitioned into 1012 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.605s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 506 992 1930 3646 6789 12325 21450 35815 57331 87746 128148 178701 239352 307118 380318 453696 521841 580909 626310 652760 659364 647890 619018 575995 523996 468113 410635 354131 300455 250881 206314 166060 132243 102421 77859 57138 40982 28986 19728 13247 8782 5763 3608 2263 1351 927 591 342 180 104 59 37 23 12 9 3 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 4 20 54 214 503 1253 3200 7085 14299 26916 47344 77595 118050 171586 233918 306940 385551 462773 535508 599860 646156 670838 676762 662041 627994 579879 525591 467139 407807 350029 295448 246568 199877 162065 126983 98580 73294 52978 38244 26209 17712 11801 7918 4953 3175 1775 1263 840 504 256 149 81 51 34 15 15 5 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1012 1984 3860 7292 13578 24650 42900 71630 114662 175492 256296 357402 478704 614236 760636 907392 1043682 1161818 1252620 1305520 1318728 1295780 1238036 1151990 1047992 936226 821270 708262 600910 501762 412628 332120 264486 204842 155718 114276 81964 57972 39456 26494 17564 11526 7216 4526 2702 1854 1182 684 360 208 118 74 46 24 18 6 2 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 1 4 20 54 214 503 1253 3199 7085 14299 26916 47344 77595 118050 171586 233918 306940 385551 462773 535508 599860 646156 670838 676762 662041 627994 579879 525591 467139 407807 350029 295448 246568 199877 162065 126983 98580 73294 52978 38244 26209 17712 11801 7918 4953 3175 1775 1263 840 504 256 149 81 51 34 15 15 5 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.99216 1.98024 1.97278 1.94456 1.93102 1.90772 1.87014 1.83485 1.80038 1.76526 1.73022 1.69724 1.6697 1.64156 1.61917 1.59647 1.5751 1.5566 1.53908 1.52112 1.50506 1.4913 1.47772 1.46525 1.45486 1.44668 1.43861 1.4312 1.42421 1.4175 1.41118 1.40244 1.39818 1.38725 1.38009 1.36693 1.35862 1.35364 1.3403 1.33574 1.33147 1.32811 1.31303 1.31361 1.2985 1.34308 1.31877 1.28934 1.26316 1.28889 1.28365 1.31356 1.31081 1.26087 1.375 1.16667 1.16667 1 tree_stats_height=67 tree_stats_numInternals=9977704 tree_stats_numLeaves=9977705 tree_stats_numNodes=19955409 tree_stats_numKeys=9977704 tree_stats_avgDegreeInternal=2 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=31.8616 tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20400 40480 79360 154400 291680 543120 986000 1716000 2865200 4586480 7019680 10251840 14296080 19148160 24569440 30425440 36295680 41747280 46472720 50104800 52220800 52749120 51831200 49521440 46079600 41919680 37449040 32850800 28330480 24036400 20070480 16505120 13284800 10579440 8193680 6228720 4571040 3278560 2318880 1578240 1059760 702560 461040 288640 181040 108080 74160 47280 27360 14400 8320 4720 2960 1840 960 720 240 80 tree_stats_sizeInBytes=798216360 6node_tIxPvE_object_size=40 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=5642 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:31 16:21252 32:406588 64:19777 (2^03, 2^04]: 31 (2^04, 2^05]: 21252 (2^05, 2^06]: 406588 (2^06, 2^07]: 19777 sum_limbo_reclamation_event_size_total=20692360 count_limbo_reclamation_event_size_by_thread=4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 4663 count_limbo_reclamation_event_size_total=447648 sum_limbo_reclamation_event_count_total=447840 first_thread_announced_epoch_by_thread=11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 11284 sum_num_inserts_by_thread=216429 216843 218385 218261 217246 215405 215885 217317 219217 218980 215982 215422 215446 218044 218369 219489 217785 215733 214421 217021 218277 217873 215567 214929 215616 216529 218336 218101 217683 215444 217269 217510 219345 219715 217591 215979 217009 217563 219710 219154 216959 215629 215044 215752 217026 217872 215811 213935 216275 217304 219524 218974 217108 215397 215619 217478 219887 219089 217959 216419 216839 217484 218977 219708 218329 215551 214495 216895 218150 218502 216856 216591 216108 216995 218996 218537 217375 215047 215768 217231 219091 220347 217508 216803 216951 217633 219246 219996 217761 215750 214860 215784 219004 218812 217771 215388 sum_num_inserts_total=20857080 sum_num_deletes_by_thread=215807 217130 218610 218188 218519 214506 216140 217894 219042 220465 217268 215498 216311 216923 219335 218953 217076 217196 214613 216796 217013 218403 216529 213617 215213 217029 218799 218079 218071 215505 216766 217757 218829 219612 216908 215124 216834 218004 219280 219341 217980 216391 215005 215467 216618 218832 216146 214081 216158 217047 218973 218440 216444 216137 216311 216888 219088 219102 218281 217007 216433 218204 219158 219527 217181 215449 214782 216706 219246 218872 216059 215825 215921 217327 218779 218742 217076 215754 217198 217217 219503 220365 217526 216481 216505 217923 219405 220000 217676 215587 215643 216174 218950 218830 217340 215933 sum_num_deletes_total=20862676 sum_num_searches_by_thread=3885633 3908550 3936576 3934489 3912351 3872437 3889883 3909047 3945892 3951983 3902187 3879582 3894651 3917707 3941001 3940983 3919065 3891328 3871281 3893855 3910950 3937158 3889883 3859401 3885858 3903451 3931848 3928975 3915845 3873431 3892559 3911839 3947742 3954570 3904403 3883597 3895196 3921630 3948328 3948144 3914814 3890033 3864919 3888664 3910915 3932357 3886943 3858399 3894080 3911106 3938973 3936157 3905365 3887368 3893477 3912801 3949527 3943399 3919221 3890454 3907199 3927287 3951246 3949060 3921638 3880796 3868279 3889038 3939231 3940761 3905662 3880637 3891076 3909269 3935715 3936218 3901074 3878170 3885950 3903363 3948478 3955304 3917000 3893693 3900187 3928323 3950372 3947895 3915189 3877929 3862570 3886408 3936456 3937146 3908462 3885087 sum_num_searches_total=375424429 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=4317869 4342523 4373571 4370938 4348116 4302348 4321908 4344258 4384151 4391428 4335437 4310502 4326408 4352674 4378705 4379425 4353926 4324257 4300315 4327672 4346240 4373434 4321979 4287947 4316687 4337009 4368983 4365155 4351599 4304380 4326594 4347106 4385916 4393897 4338902 4314700 4329039 4357197 4387318 4386639 4349753 4322053 4294968 4319883 4344559 4369061 4318900 4286415 4326513 4345457 4377470 4373571 4338917 4318902 4325407 4347167 4388502 4381590 4355461 4323880 4340471 4362975 4389381 4388295 4357148 4311796 4297556 4322639 4376627 4378135 4338577 4313053 4323105 4343591 4373490 4373497 4335525 4308971 4318916 4337811 4387072 4396016 4352034 4326977 4333643 4363879 4389023 4387891 4350626 4309266 4293073 4318366 4374410 4374788 4343573 4316408 average_num_operations_total=4345251 stdev_num_operations_total=2974 sum_num_operations_total=417144185 min_num_operations_total=4286415 max_num_operations_total=4396016 first_time_thread_terminate_by_thread=10000091 10000092 10000092 10000091 10000092 10000091 10000091 10000091 10000091 10000091 10000093 10000092 10000091 10000091 10000091 10000091 10000091 10000092 10000093 10000092 10000092 10000091 10000091 10000092 10000091 10000092 10000092 10000091 10000092 10000092 10000092 10000091 10000158 10000091 10000093 10000092 10000091 10000091 10000091 10000091 10000091 10000092 10000092 10000092 10000091 10000091 10000091 10000092 10000093 10000091 10000091 10000091 10000093 10000093 10000092 10000093 10000092 10000091 10000093 10000091 10000091 10000093 10000091 10000093 10000091 10000091 10000093 10000093 10000091 10000092 10000093 10000093 10000093 10000092 10000094 10000092 10000091 10000091 10000092 10000093 10000092 10000091 10000093 10000091 10000091 10000093 10000093 10000093 10000093 10000091 10000093 10000093 10000091 10000092 10000093 10000093 min_time_thread_terminate_total=10000091 max_time_thread_terminate_total=10000158 first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 10 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 7 6 7 6 7 7 7 7 6 7 7 6 6 6 6 6 7 6 7 7 6 6 6 6 7 6 7 6 7 7 7 7 6 7 7 6 6 6 6 6 7 6 7 7 6 6 min_time_thread_start_total=5 max_time_thread_start_total=10 sum_duration_all_ops_total= threads_final_keysum=99768545612171 threads_final_size=9977704 final_keysum=99768545612171 final_size=9977704 validate_result=success Validation OK. Structural validation OK. total_find=375424429 total_rq=0 total_inserts=20857080 total_deletes=20862676 total_updates=41719756 total_queries=375424429 total_ops=417144185 find_throughput=37542442 rq_throughput=0 update_throughput=4171975 query_throughput=37542442 total_throughput=41714418 total find : 375424429 total rq : 0 total inserts : 20857080 total deletes : 20862676 total updates : 41719756 total queries : 375424429 total ops : 417144185 find throughput : 37542442 rq throughput : 0 update throughput : 4171975 query throughput : 37542442 total throughput : 41714418 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=38.6241 PAPI_L3_TCM=15.1137 PAPI_TOT_CYC=6408.27 PAPI_TOT_INS=381.282 garbage=1863477601599174 total_execution_walltime=13.498s REALTIME_MAIN_END_PERF_FORMAT=6983417.710473910 [time_cmd_output] time_elapsed_sec=13.70, faults_major=0, faults_minor=313792, mem_maxresident_kb=1253180, user_cputime=1228.70, sys_cputime=4.06, percent_cpu=8994% timeout=false algorithm=guerraoui_ext_bst_ticket.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2