__step=000243 __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" ./brown_int_bst_tm_auto.debra.tl2 -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000243.txt __path_data=data/data000243.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6997482.549780992 binary=./brown_int_bst_tm_auto.debra.tl2 parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_int_bst_tm_auto 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=2000000 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=32 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 TL2 system ready: GV=GV4 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.014s prefilling_size=996032 prefilling_elapsed_millis=1.001s finished prefilling to size 996108 for expected size 1000000 keysum=995685696594, performing 10903093 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=996108 pref_millis=1102 prefill_elapsed_ms=1136 4NodeIxPvL9tx_safety0EE_object_size=32 4NodeIxPvL9tx_safety0EE_allocated_count=0 4NodeIxPvL9tx_safety0EE_allocated_size=0MB 4NodeIxPvL9tx_safety0EE_get_from_pool=0 4NodeIxPvL9tx_safety0EE_deallocated=0 4NodeIxPvL9tx_safety0EE_limbo_count=0 4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 global_epoch_counter=128 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6997483.864009769 REALTIME_END_PERF_FORMAT=6997493.864150507 ############################################################################### ################################## 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 801 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.035s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 123 232 425 741 1280 2110 3451 5395 8117 11929 16671 22462 29242 36791 43765 49630 53697 55380 54444 51112 46007 39818 32858 26187 19973 14834 10524 7058 4516 2733 1568 864 464 256 131 65 28 9 3 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 3 8 19 60 118 254 429 852 1478 2304 3970 5915 8400 11607 15919 20253 24239 27804 29665 30494 29533 27349 24432 20704 16976 13159 9914 7301 4967 3241 2031 1165 633 342 192 91 55 25 7 3 tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 126 240 444 801 1398 2364 3880 6247 9595 14233 20641 28377 37642 48398 59684 69883 77936 83184 84109 81606 75540 67167 57290 46891 36949 27993 20438 14359 9483 5974 3599 2029 1097 598 323 156 83 34 10 3 tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 126 240 444 801 1398 2364 3880 6247 9595 14233 20641 28377 37642 48398 59684 69883 77936 83184 84109 81606 75540 67167 57290 46891 36949 27993 20438 14359 9483 5974 3599 2029 1097 598 323 156 83 34 10 3 tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 2 1.92857 1.88333 1.84685 1.82022 1.77539 1.74873 1.72062 1.67232 1.63742 1.6121 1.56712 1.53494 1.5089 1.47302 1.4376 1.40505 1.37835 1.34537 1.32294 1.29934 1.28012 1.26013 1.24495 1.22951 1.21706 1.20019 1.18764 1.16888 1.15375 1.14496 1.12809 1.11483 1.12215 1.11204 1.0774 1.11538 1.07229 1.02941 1 1 tree_stats_height=47 tree_stats_numInternals=655019 tree_stats_numLeaves=345911 tree_stats_numNodes=1000930 tree_stats_numKeys=1000930 tree_stats_avgDegreeInternal=1.52809 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34559 tree_stats_avgKeyDepth=24.9362 4NodeIxPvL9tx_safety0EE_object_size=32 4NodeIxPvL9tx_safety0EE_allocated_count=0 4NodeIxPvL9tx_safety0EE_allocated_size=0MB 4NodeIxPvL9tx_safety0EE_get_from_pool=0 4NodeIxPvL9tx_safety0EE_deallocated=0 4NodeIxPvL9tx_safety0EE_limbo_count=0 4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 global_epoch_counter=4426 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:47 8:22269 16:376042 32:14058 (2^02, 2^03]: 47 (2^03, 2^04]: 22269 (2^04, 2^05]: 376042 (2^05, 2^06]: 14058 sum_limbo_reclamation_event_size_total=9363500 count_limbo_reclamation_event_size_by_thread=4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 count_limbo_reclamation_event_size_total=412416 sum_limbo_reclamation_event_count_total=412608 first_thread_announced_epoch_by_thread=8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 sum_num_inserts_by_thread=188585 190351 191793 192304 192634 189959 190346 191069 193073 193132 191456 190949 190534 191131 191604 192422 192725 191519 189190 190956 192435 191605 191659 190157 189106 190648 192088 191993 192264 190258 189666 190578 193028 193578 191340 191708 190771 191059 192002 192699 192332 191229 188873 190498 191416 192875 192022 190310 196729 197886 199553 199363 199535 199964 197794 198691 200591 201405 199314 198370 197952 199230 199655 200012 199148 196973 197120 197340 200373 201051 199525 199165 196927 198076 200066 200708 199866 198660 196774 198207 199671 200683 199935 199269 198093 198528 200413 199986 200698 198314 197822 197702 200476 201705 200112 199828 sum_num_inserts_total=18743187 sum_num_deletes_by_thread=188410 190769 191116 192109 191694 190326 191068 191508 192359 193211 193137 190645 189934 191423 192287 192172 192306 191926 189358 191155 192092 192626 190790 189695 189188 190091 191308 192591 192073 189469 190179 190839 192128 192887 191281 190733 190024 191216 191565 192611 192752 190009 189456 191454 192185 192289 191889 190768 197748 197986 198756 199610 199477 199108 198077 198551 200959 200869 200496 198886 198405 198334 200251 201072 199778 197414 197670 198103 199504 201287 199380 199074 197469 199601 200500 201116 199976 199249 196694 198272 200205 200607 200531 198730 197095 198890 199350 199712 200265 197592 197156 198053 200828 201367 200652 198908 sum_num_deletes_total=18744714 sum_num_searches_by_thread=3394140 3435950 3452367 3461692 3454655 3429460 3430012 3444274 3474074 3482026 3464938 3435159 3421952 3436069 3455940 3465374 3467156 3443359 3409802 3432049 3455966 3459539 3447738 3424149 3405972 3424573 3442949 3455374 3457137 3416135 3420973 3438557 3464201 3478950 3445190 3442513 3425013 3441235 3454001 3472066 3465526 3435340 3411781 3424226 3450146 3465506 3456919 3428596 3550790 3556603 3590857 3595926 3583420 3581391 3552763 3575383 3610569 3625489 3601420 3574392 3570203 3586282 3594658 3617845 3596327 3559151 3544776 3557746 3599145 3613765 3596084 3582833 3551945 3573710 3604691 3615987 3601623 3592796 3548675 3571679 3612220 3620075 3606902 3583012 3554133 3580452 3599907 3608312 3601092 3566308 3556243 3574016 3607942 3625841 3603907 3590016 sum_num_searches_total=337470021 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3771135 3817070 3835276 3846105 3838983 3809745 3811426 3826851 3859506 3868369 3849531 3816753 3802420 3818623 3839831 3849968 3852187 3826804 3788350 3814160 3840493 3843770 3830187 3804001 3784266 3805312 3826345 3839958 3841474 3795862 3800818 3819974 3849357 3865415 3827811 3824954 3805808 3823510 3837568 3857376 3850610 3816578 3790110 3806178 3833747 3850670 3840830 3809674 3945267 3952475 3989166 3994899 3982432 3980463 3948634 3972625 4012119 4027763 4001230 3971648 3966560 3983846 3994564 4018929 3995253 3953538 3939566 3953189 3999022 4016103 3994989 3981072 3946341 3971387 4005257 4017811 4001465 3990705 3942143 3968158 4012096 4021365 4007368 3981011 3949321 3977870 3999670 4008010 4002055 3962214 3951221 3969771 4009246 4028913 4004671 3988752 average_num_operations_total=3905811 stdev_num_operations_total=8546 sum_num_operations_total=374957922 min_num_operations_total=3771135 max_num_operations_total=4028913 first_time_thread_terminate_by_thread=10000140 10000142 10000141 10000141 10000140 10000141 10000142 10000140 10000142 10000142 10000142 10000141 10000142 10000140 10000142 10000140 10000141 10000140 10000141 10000142 10000141 10000142 10000142 10000141 10000140 10000140 10000141 10000141 10000141 10000140 10000139 10000140 10000142 10000142 10000143 10000141 10000142 10000141 10000142 10000140 10000141 10000142 10000141 10000142 10000141 10000142 10000140 10000142 10000140 10000140 10000142 10000143 10000141 10000140 10000140 10000142 10000141 10000140 10000142 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000142 10000141 10000141 10000140 10000140 10000142 10000141 10000140 10000142 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000141 min_time_thread_terminate_total=10000139 max_time_thread_terminate_total=10000143 first_time_thread_start_by_thread=5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 4 4 4 5 4 4 5 4 4 5 4 5 4 5 4 5 4 4 4 4 5 4 5 4 4 4 4 5 4 4 5 4 4 5 4 5 4 5 4 5 4 4 4 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=1001122255420 threads_final_size=1000930 final_keysum=1001122255420 final_size=1000930 validate_result=success Validation OK. Structural validation OK. total_find=337470021 total_rq=0 total_inserts=18743187 total_deletes=18744714 total_updates=37487901 total_queries=337470021 total_ops=374957922 find_throughput=33747002 rq_throughput=0 update_throughput=3748790 query_throughput=33747002 total_throughput=37495792 total find : 337470021 total rq : 0 total inserts : 18743187 total deletes : 18744714 total updates : 37487901 total queries : 337470021 total ops : 374957922 find throughput : 33747002 rq throughput : 0 update throughput : 3748790 query throughput : 33747002 total throughput : 37495792 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=22.2473 PAPI_L3_TCM=0.914201 PAPI_TOT_CYC=5165.98 PAPI_TOT_INS=2468.77 garbage=166859782864935 total_execution_walltime=11.418s REALTIME_MAIN_END_PERF_FORMAT=6997493.969254467 TL2 system shutdown: GCLOCK=0x160840E Starts=387420754 Aborts=1559738 Overflows: R=0 W=0 L=0 [time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=99119, mem_maxresident_kb=356640, user_cputime=1013.98, sys_cputime=78.36, percent_cpu=9450% timeout=false algorithm=brown_int_bst_tm_auto.debra.tl2 thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1