__step=000643 __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" ./sigouin_int_avl_kcas_validate_htm.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000643.txt __path_data=data/data000643.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x555d89c9d400 addrof(kcasDescriptors[1])=0x555d89c9dd00 addrof(rdcssDescriptors[0])=0x555d89dbd400 addrof(rdcssDescriptors[1])=0x555d89dbd4c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7002536.902900178 binary=./sigouin_int_avl_kcas_validate_htm.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=sigouin_int_avl_kcas_validate_htm 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=200000 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.011s prefilling_size=99880 prefilling_elapsed_millis=1.001s finished prefilling to size 99910 for expected size 100000 keysum=9982223465, performing 45365191 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99910 pref_millis=1102 prefill_elapsed_ms=1124 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7002538.208312554 REALTIME_END_PERF_FORMAT=7002548.208467702 ############################################################################### ################################## 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 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 2 4 8 16 32 64 128 256 512 1024 2048 4096 8155 15082 17652 7692 575 2 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 36 1117 10267 20498 9854 696 3 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8191 16199 27919 28190 10429 698 3 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8191 16199 27919 28190 10429 698 3 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99976 1.98205 1.79246 1.37745 1.09709 1.01179 1.00143 1 tree_stats_height=20 tree_stats_numInternals=57349 tree_stats_numLeaves=42471 tree_stats_numNodes=99820 tree_stats_numKeys=99820 tree_stats_avgDegreeInternal=1.74057 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.42548 tree_stats_avgKeyDepth=14.858 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:6 2:18 4:165 8:53293 16:879794 32:26252 64:95 128:4 256:95 [2^00, 2^01]: 6 (2^01, 2^02]: 18 (2^02, 2^03]: 165 (2^03, 2^04]: 53293 (2^04, 2^05]: 879794 (2^05, 2^06]: 26252 (2^06, 2^07]: 95 (2^07, 2^08]: 4 (2^08, 2^09]: 95 sum_limbo_reclamation_event_size_total=21603704 count_limbo_reclamation_event_size_by_thread=9998 9997 9998 9997 9996 9997 9998 9998 9998 9997 9997 9998 9997 9997 9998 9997 9996 9997 9998 9997 9997 9998 9997 9997 9997 9998 9998 9997 9998 9996 9997 9998 9997 9998 9997 9997 9996 9997 9998 9997 9998 9997 9996 9998 9998 9998 9997 9997 9997 9997 9997 9996 9996 9997 9997 9996 9997 9997 9997 9996 9997 9998 9997 9996 9997 9997 9997 9997 9997 9998 9997 9997 9997 9997 9997 9997 9996 9997 9997 9997 9997 9997 9997 9997 9997 9996 9997 9997 9997 9997 9997 9997 9997 9997 9998 9997 count_limbo_reclamation_event_size_total=959722 sum_limbo_reclamation_event_count_total=1589170 first_thread_announced_epoch_by_thread=34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 34286 sum_num_inserts_by_thread=741067 746289 748036 750481 743432 742296 737637 737962 747378 751989 740483 739369 741106 741612 743059 744381 747605 739015 740889 743127 745977 746707 739207 736264 738962 742102 746077 746515 744058 740030 733541 736951 748699 747117 738842 734266 732127 735351 740272 739281 739853 735690 737737 740560 742175 746066 740086 736969 743689 750296 750410 753463 742614 742501 745153 747374 757936 751641 746303 740787 741749 750352 752065 751116 747064 740592 739680 741518 748710 748532 748566 743939 744008 746610 756120 751807 745056 747627 747304 749433 757306 761074 753063 753194 744601 752719 753517 751637 754997 748854 748920 749021 760645 762323 754554 752405 sum_num_inserts_total=71571540 sum_num_deletes_by_thread=741452 744253 747554 749902 744554 742849 736938 739229 747965 751385 738304 738083 741620 742602 744348 744587 749083 739864 740920 744063 744797 747098 739166 736949 737663 741904 747416 747034 743340 739088 733604 737920 748389 746781 739070 733100 733186 734895 740924 737098 739636 735279 735794 741708 740827 746606 740479 735016 743539 750445 753549 754415 743283 741298 743612 746358 755590 749708 744503 742352 740038 751015 751254 750493 747568 739777 737983 740833 747411 745969 746716 744120 740716 748929 755260 751634 745302 747318 746029 746682 756284 760261 753528 751785 746293 754534 753365 752563 755271 747312 747480 749713 757938 761997 754213 751523 sum_num_deletes_total=71542081 sum_num_searches_by_thread=13347862 13411808 13448490 13497488 13383678 13356210 13287543 13295973 13448261 13515172 13316168 13275131 13336446 13370961 13393578 13405159 13462466 13305441 13338239 13392705 13425948 13448471 13322584 13273911 13295645 13363628 13453710 13450877 13388504 13281595 13222268 13277168 13485734 13443376 13279569 13203449 13178796 13257643 13328371 13290478 13300968 13248895 13258693 13336355 13333904 13421885 13336584 13255123 13365868 13499369 13538513 13555945 13386576 13362066 13406762 13447617 13627163 13519290 13415284 13368795 13343536 13524062 13517477 13505521 13450641 13331496 13288553 13350810 13462231 13463905 13479584 13406034 13381124 13452745 13581663 13547388 13410981 13462247 13441695 13475548 13614267 13699721 13558145 13551645 13410105 13551422 13540951 13516937 13580266 13474586 13473239 13495130 13662382 13701398 13578113 13535291 sum_num_searches_total=1288066998 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=14830381 14902350 14944080 14997871 14871664 14841355 14762118 14773164 14943604 15018546 14794955 14752583 14819172 14855175 14880985 14894127 14959154 14784320 14820048 14879895 14916722 14942276 14800957 14747124 14772270 14847634 14947203 14944426 14875902 14760713 14689413 14752039 14982822 14937274 14757481 14670815 14644109 14727889 14809567 14766857 14780457 14719864 14732224 14818623 14816906 14914557 14817149 14727108 14853096 15000110 15042472 15063823 14872473 14845865 14895527 14941349 15140689 15020639 14906090 14851934 14825323 15025429 15020796 15007130 14945273 14811865 14766216 14833161 14958352 14958406 14974866 14894093 14865848 14948284 15093043 15050829 14901339 14957192 14935028 14971663 15127857 15221056 15064736 15056624 14900999 15058675 15047833 15021137 15090534 14970752 14969639 14993864 15180965 15225718 15086880 15039219 average_num_operations_total=14908131 stdev_num_operations_total=12764 sum_num_operations_total=1431180619 min_num_operations_total=14644109 max_num_operations_total=15225718 first_time_thread_terminate_by_thread=10000145 10000144 10000145 10000145 10000145 10000144 10000144 10000147 10000144 10000145 10000145 10000144 10000145 10000146 10000146 10000145 10000146 10000144 10000145 10000145 10000144 10000144 10000144 10000146 10000145 10000144 10000145 10000145 10000145 10000144 10000144 10000145 10000144 10000145 10000145 10000144 10000145 10000146 10000146 10000145 10000146 10000144 10000145 10000145 10000144 10000144 10000144 10000145 10000147 10000144 10000146 10000146 10000145 10000144 10000146 10000145 10000147 10000147 10000144 10000144 10000145 10000146 10000145 10000144 10000147 10000145 10000146 10000146 10000143 10000145 10000143 10000146 10000147 10000144 10000146 10000146 10000144 10000144 10000146 10000145 10000147 10000147 10000144 10000144 10000145 10000147 10000146 10000144 10000147 10000145 10000146 10000146 10000143 10000145 10000143 10000146 min_time_thread_terminate_total=10000143 max_time_thread_terminate_total=10000147 first_time_thread_start_by_thread=3 2 2 2 3 3 3 3 2 3 3 3 3 2 3 3 3 3 2 3 2 3 3 2 3 2 2 2 3 3 3 3 2 3 3 3 3 2 3 3 3 3 2 3 2 3 3 2 3 3 3 3 3 2 3 3 3 2 3 3 3 3 2 3 2 3 3 3 3 2 3 3 3 3 3 3 3 2 3 3 3 2 3 3 3 3 2 3 2 3 3 3 3 2 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=9969783649 threads_final_size=99820 final_keysum=9969783649 final_size=99820 validate_result=success Validation OK. Structural validation OK. total_find=1288066998 total_rq=0 total_inserts=71571540 total_deletes=71542081 total_updates=143113621 total_queries=1288066998 total_ops=1431180619 find_throughput=128806699 rq_throughput=0 update_throughput=14311362 query_throughput=128806699 total_throughput=143118061 total find : 1288066998 total rq : 0 total inserts : 71571540 total deletes : 71542081 total updates : 143113621 total queries : 1288066998 total ops : 1431180619 find throughput : 128806699 rq throughput : 0 update throughput : 14311362 query throughput : 128806699 total throughput : 143118061 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=6.92428 PAPI_L3_TCM=0.502813 PAPI_TOT_CYC=1817.42 PAPI_TOT_INS=1028.5 garbage=64411285217734 total_execution_walltime=11.456s REALTIME_MAIN_END_PERF_FORMAT=7002548.360383391 [time_cmd_output] time_elapsed_sec=11.58, faults_major=0, faults_minor=80138, mem_maxresident_kb=317756, user_cputime=1092.51, sys_cputime=2.87, percent_cpu=9453% timeout=false algorithm=sigouin_int_avl_kcas_validate_htm.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1