__step=000266 __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 48 -nprefill 48 -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=data000266.txt __path_data=data/data000266.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6981990.324140107 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=0.5 DEL_FRAC=0.5 RQ=0 RQSIZE=0 MAXKEY=200000 PREFILL_THREADS=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 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=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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.005s prefilling_size=100379 prefilling_elapsed_millis=1.001s finished prefilling to size 100319 for expected size 100000 keysum=10038101069, performing 66012141 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100319 pref_millis=1102 prefill_elapsed_ms=1125 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=3293 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6981991.613858364 REALTIME_END_PERF_FORMAT=6982001.614008351 ############################################################################### ################################## 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 904 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.047s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 124 238 452 821 1368 2070 3061 4326 5724 7231 8502 9430 9959 9677 8773 7472 6110 4806 3638 2501 1660 980 537 268 103 35 6 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 4 10 24 83 274 666 1079 1796 2928 4217 5960 7574 8901 10241 10581 10074 8834 7414 5974 4775 3342 2340 1423 806 433 171 64 11 2 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 248 476 904 1642 2736 4140 6122 8652 11448 14462 17004 18860 19918 19354 17546 14944 12220 9612 7276 5002 3320 1960 1074 536 206 70 12 2 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 4 10 24 82 274 666 1079 1796 2928 4217 5960 7574 8901 10241 10581 10074 8834 7414 5974 4775 3342 2340 1423 806 433 171 64 11 2 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.96875 1.95968 1.94958 1.90708 1.83313 1.75658 1.73937 1.70663 1.66158 1.63164 1.58789 1.55458 1.52805 1.48584 1.45329 1.42585 1.40886 1.39329 1.37849 1.34373 1.33187 1.29518 1.27398 1.24953 1.19216 1.1699 1.08571 1.08333 1 tree_stats_height=36 tree_stats_numInternals=100000 tree_stats_numLeaves=100001 tree_stats_numNodes=200001 tree_stats_numKeys=100000 tree_stats_avgDegreeInternal=2.00001 tree_stats_avgDegreeLeaves=0.99999 tree_stats_avgDegree=1.5 tree_stats_avgKeyDepth=21.154 tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 9920 19040 36160 65680 109440 165600 244880 346080 457920 578480 680160 754400 796720 774160 701840 597760 488800 384480 291040 200080 132800 78400 42960 21440 8240 2800 480 80 tree_stats_sizeInBytes=8000040 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=48695 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:175473 4:139886 8:14433 16:10 (2^01, 2^02]: 175473 (2^02, 2^03]: 139886 (2^03, 2^04]: 14433 (2^04, 2^05]: 10 sum_limbo_reclamation_event_size_total=1111158 count_limbo_reclamation_event_size_by_thread=6896 6754 6879 6949 6820 6833 6817 6874 6886 6915 6903 6896 6863 6908 6886 6973 6869 6867 6865 6878 6885 6964 6936 6802 6715 6939 6911 6838 6876 6783 6817 6901 6968 6916 6939 6825 6876 6895 6967 6958 6859 6796 6790 6835 6885 6842 6843 6710 count_limbo_reclamation_event_size_total=329802 sum_limbo_reclamation_event_count_total=2179295 first_thread_announced_epoch_by_thread=97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 97390 sum_num_inserts_by_thread=103722 105026 105440 105835 105485 103532 103388 104448 106215 106468 105750 104377 103795 104849 105964 106896 105099 104990 104340 105126 106210 105951 105511 103773 103440 104328 106085 106174 104856 103147 104365 105402 106363 107137 104967 104426 104685 104648 106363 106250 105038 104483 103703 103772 104794 106291 105050 104034 sum_num_inserts_total=5041991 sum_num_deletes_by_thread=103905 104073 105789 105853 105304 103850 103331 104558 106285 105848 105287 105136 104151 105322 105550 106643 105386 105368 103975 105251 106495 106707 105444 103848 103479 104586 105682 105769 105192 103429 103787 105436 106934 106373 105494 104442 104642 105019 105829 106243 104640 104320 103613 104776 105287 106259 104341 104373 sum_num_deletes_total=5043304 sum_num_searches_by_thread=20539640 20691115 20981238 20958981 20834136 20413435 20502948 20657004 21003414 21120761 20828046 20700549 20540848 20803838 20902217 20975786 20874531 20784019 20594487 20852076 21048009 21031170 20845881 20566702 20438083 20731409 20976107 20999314 20757627 20426536 20609404 20792240 21075694 21072734 20781137 20668382 20665827 20780823 21040243 21011604 20784157 20721273 20515208 20680938 20845346 21044736 20771958 20665756 sum_num_searches_total=997907367 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=20747267 20900214 21192467 21170669 21044925 20620817 20709667 20866010 21215914 21333077 21039083 20910062 20748794 21014009 21113731 21189325 21085016 20994377 20802802 21062453 21260714 21243828 21056836 20774323 20645002 20940323 21187874 21211257 20967675 20633112 20817556 21003078 21288991 21286244 20991598 20877250 20875154 20990490 21252435 21224097 20993835 20930076 20722524 20889486 21055427 21257286 20981349 20874163 average_num_operations_total=20999847 stdev_num_operations_total=28284 sum_num_operations_total=1007992662 min_num_operations_total=20620817 max_num_operations_total=21333077 first_time_thread_terminate_by_thread=10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 min_time_thread_terminate_total=10000148 max_time_thread_terminate_total=10000149 first_time_thread_start_by_thread=3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 2 2 2 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 2 2 2 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10008811384 threads_final_size=100000 final_keysum=10008811384 final_size=100000 validate_result=success Validation OK. Structural validation OK. total_find=997907367 total_rq=0 total_inserts=5041991 total_deletes=5043304 total_updates=10085295 total_queries=997907367 total_ops=1007992662 find_throughput=99790736 rq_throughput=0 update_throughput=1008529 query_throughput=99790736 total_throughput=100799266 total find : 997907367 total rq : 0 total inserts : 5041991 total deletes : 5043304 total updates : 10085295 total queries : 997907367 total ops : 1007992662 find throughput : 99790736 rq throughput : 0 update throughput : 1008529 query throughput : 99790736 total throughput : 100799266 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=8.76642 PAPI_L3_TCM=0.000317914 PAPI_TOT_CYC=1327.94 PAPI_TOT_INS=283.622 garbage=49885485105488 total_execution_walltime=11.422s REALTIME_MAIN_END_PERF_FORMAT=6982001.747234540 [time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=77412, mem_maxresident_kb=311656, user_cputime=562.41, sys_cputime=3.14, percent_cpu=4891% 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