__step=000539 __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 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=data000539.txt __path_data=data/data000539.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6985380.20466569 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=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=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,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.034s prefilling_size=999353 prefilling_elapsed_millis=1s finished prefilling to size 999350 for expected size 1000000 keysum=999026777585, performing 62959354 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999350 pref_millis=1102 prefill_elapsed_ms=1132 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=756 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6985381.384155847 REALTIME_END_PERF_FORMAT=6985391.384241127 ############################################################################### ################################## 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 1024 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.034s tree_stats_numInternalsAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65417 125288 189049 164339 65843 9757 269 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 117 5075 52660 169548 194829 85122 12602 326 tree_stats_numNodesAtDepth=1 1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65534 130363 241709 333887 260672 94879 12871 326 tree_stats_numKeysAtDepth=0 0 1 1 5 9 19 36 71 118 245 519 1039 2048 4107 8293 16703 35566 81557 188172 302164 252157 94092 12862 326 tree_stats_avgDegreeAtDepth=1 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99994 1.99103 1.89305 1.59922 1.28849 1.11135 1.03281 1.00443 1 tree_stats_height=25 tree_stats_numInternals=685498 tree_stats_numLeaves=520279 tree_stats_numNodes=1205777 tree_stats_numKeys=1000110 tree_stats_avgDegreeInternal=1.75898 tree_stats_avgDegreeLeaves=0.999958 tree_stats_avgDegree=1.43147 tree_stats_avgKeyDepth=19.8564 tree_stats_bytesAtDepth=56 56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3669904 7300328 13535704 18697672 14597632 5313224 720776 18256 tree_stats_sizeInBytes=67523512 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=11985 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:1 2:59 4:5329 8:286567 16:662831 32:4901 64:49 128:66 [2^00, 2^01]: 1 (2^01, 2^02]: 59 (2^02, 2^03]: 5329 (2^03, 2^04]: 286567 (2^04, 2^05]: 662831 (2^05, 2^06]: 4901 (2^06, 2^07]: 49 (2^07, 2^08]: 66 sum_limbo_reclamation_event_size_total=17384012 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 9997 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 9994 9998 count_limbo_reclamation_event_size_total=959803 sum_limbo_reclamation_event_count_total=1077984 first_thread_announced_epoch_by_thread=23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 23970 sum_num_inserts_by_thread=505953 516481 513919 514069 519126 504484 515771 506742 523055 523484 516756 514082 507231 517882 513201 511017 511592 507110 511268 515243 518395 519307 513095 509804 514170 506143 517467 518057 510190 512642 513460 518279 523507 523961 509754 506581 508006 518585 521405 513300 518658 515947 502167 513840 509514 513621 503669 506923 516536 517863 516018 523717 520220 509796 516943 521314 526351 528049 515721 511816 519969 516094 525942 517127 514911 510029 516338 511913 519997 526434 522705 517627 516006 520001 523489 516790 512112 508982 514995 509525 518387 519291 514743 511289 517780 523081 526096 528010 522881 507580 515461 511151 529017 528447 523436 519367 sum_num_inserts_total=49530260 sum_num_deletes_by_thread=504575 517060 514608 513937 518980 503916 516715 507100 524823 524650 515480 513084 507706 519524 513417 513499 510250 505414 510897 514484 517031 520620 512744 508550 510604 507094 518926 518011 509255 512757 513830 517993 524837 525397 510217 506051 507380 518092 522631 514133 520185 513280 501221 514355 509445 511500 503232 507745 515578 518360 516607 525354 519123 510657 518027 520289 525428 527231 513285 510147 519383 515603 526446 516192 515244 509798 517566 510458 518019 526490 523224 516404 516575 519417 523371 515245 510674 508407 515510 511977 517267 519216 514938 509213 518329 522895 525676 525143 522472 508777 515269 510304 527809 528907 521206 519935 sum_num_deletes_total=49510680 sum_num_searches_by_thread=9094757 9318332 9250215 9255194 9337422 9081655 9282364 9112215 9423411 9423111 9291371 9242045 9138299 9330103 9236011 9244608 9188344 9112723 9206613 9257959 9329456 9357738 9258781 9173463 9217927 9124663 9340987 9341082 9175271 9222975 9284203 9317579 9422318 9434778 9184428 9111530 9135875 9320888 9379543 9251591 9334959 9264824 9020838 9247437 9157283 9217363 9047500 9122626 9280351 9334809 9298446 9441654 9357734 9174502 9315082 9366777 9459595 9496920 9247581 9197607 9350549 9288370 9479750 9308445 9275180 9172333 9291471 9198736 9329551 9479275 9392135 9292970 9289174 9343573 9423269 9291480 9207654 9175387 9276495 9189915 9333198 9345680 9250903 9185992 9333834 9417469 9467792 9470412 9405312 9145131 9271027 9197821 9505202 9517906 9401267 9349244 sum_num_searches_total=891249618 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=10105285 10351873 10278742 10283200 10375528 10090055 10314850 10126057 10471289 10471245 10323607 10269211 10153236 10367509 10262629 10269124 10210186 10125247 10228778 10287686 10364882 10397665 10284620 10191817 10242701 10137900 10377380 10377150 10194716 10248374 10311493 10353851 10470662 10484136 10204399 10124162 10151261 10357565 10423579 10279024 10373802 10294051 10024226 10275632 10176242 10242484 10054401 10137294 10312465 10371032 10331071 10490725 10397077 10194955 10350052 10408380 10511374 10552200 10276587 10219570 10389901 10320067 10532138 10341764 10305335 10192160 10325375 10221107 10367567 10532199 10438064 10327001 10321755 10382991 10470129 10323515 10230440 10192776 10307000 10211417 10368852 10384187 10280584 10206494 10369943 10463445 10519564 10523565 10450665 10161488 10301757 10219276 10562028 10575260 10445909 10388546 average_num_operations_total=10315526 stdev_num_operations_total=12604 sum_num_operations_total=990290558 min_num_operations_total=10024226 max_num_operations_total=10575260 first_time_thread_terminate_by_thread=10000086 10000086 10000086 10000087 10000087 10000086 10000085 10000086 10000086 10000087 10000086 10000087 10000086 10000086 10000086 10000086 10000086 10000086 10000086 10000085 10000086 10000086 10000086 10000086 10000086 10000086 10000086 10000087 10000086 10000086 10000085 10000086 10000087 10000087 10000086 10000086 10000086 10000086 10000086 10000086 10000086 10000086 10000086 10000085 10000086 10000086 10000086 10000086 10000085 10000085 10000087 10000084 10000084 10000084 10000086 10000084 10000085 10000084 10000084 10000085 10000085 10000086 10000085 10000086 10000085 10000085 10000084 10000084 10000085 10000085 10000084 10000085 10000085 10000085 10000087 10000084 10000084 10000084 10000086 10000084 10000084 10000084 10000084 10000085 10000085 10000086 10000150 10000086 10000085 10000084 10000084 10000084 10000085 10000085 10000084 10000085 min_time_thread_terminate_total=10000084 max_time_thread_terminate_total=10000150 first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 6 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 5 6 5 5 5 5 5 5 5 5 5 5 4 4 5 4 4 4 5 5 4 5 4 5 5 5 5 4 5 4 4 5 5 5 5 5 4 4 5 4 4 4 5 5 4 5 9 5 5 5 5 4 5 4 4 5 min_time_thread_start_total=4 max_time_thread_start_total=9 sum_duration_all_ops_total= threads_final_keysum=1000033272625 threads_final_size=1000110 final_keysum=1000033272625 final_size=1000110 validate_result=success Validation OK. Structural validation OK. total_find=891249618 total_rq=0 total_inserts=49530260 total_deletes=49510680 total_updates=99040940 total_queries=891249618 total_ops=990290558 find_throughput=89124961 rq_throughput=0 update_throughput=9904094 query_throughput=89124961 total_throughput=99029055 total find : 891249618 total rq : 0 total inserts : 49530260 total deletes : 49510680 total updates : 99040940 total queries : 891249618 total ops : 990290558 find throughput : 89124961 rq throughput : 0 update throughput : 9904094 query throughput : 89124961 total throughput : 99029055 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=17.808 PAPI_L3_TCM=3.07782 PAPI_TOT_CYC=2621.82 PAPI_TOT_INS=1124.92 garbage=445724533598905 total_execution_walltime=11.614s REALTIME_MAIN_END_PERF_FORMAT=6985391.635706150 [time_cmd_output] time_elapsed_sec=11.75, faults_major=0, faults_minor=97665, mem_maxresident_kb=388596, user_cputime=1096.85, sys_cputime=2.85, percent_cpu=9358% 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=1