__step=000556 __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" ./sigouin_int_avl_kcas_validate.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=data000556.txt __path_data=data/data000556.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55ed99561400 addrof(kcasDescriptors[1])=0x55ed99561d00 addrof(rdcssDescriptors[0])=0x55ed99681400 addrof(rdcssDescriptors[1])=0x55ed996814c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6985579.422775047 binary=./sigouin_int_avl_kcas_validate.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 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.009s prefilling_size=999601 prefilling_elapsed_millis=1.001s finished prefilling to size 999645 for expected size 1000000 keysum=1000311611561, performing 39932468 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999645 pref_millis=1102 prefill_elapsed_ms=1128 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6985580.788167509 REALTIME_END_PERF_FORMAT=6985590.788254625 ############################################################################### ################################## 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.04s tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32764 65100 120138 162417 120064 37204 3020 16 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 4 400 8870 63715 156269 144953 47606 3793 18 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65500 129008 226132 276333 182157 50626 3809 18 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65500 129008 226132 276333 182157 50626 3809 18 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99902 1.97569 1.82161 1.50376 1.2247 1.07368 1.01558 1.00053 1 tree_stats_height=24 tree_stats_numInternals=573490 tree_stats_numLeaves=425628 tree_stats_numNodes=999118 tree_stats_numKeys=999118 tree_stats_avgDegreeInternal=1.74217 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.426 tree_stats_avgKeyDepth=18.286 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:2 2:0 4:77 8:49952 16:882992 32:26304 64:192 128:285 [2^00, 2^01]: 2 (2^01, 2^02]: 0 (2^02, 2^03]: 77 (2^03, 2^04]: 49952 (2^04, 2^05]: 882992 (2^05, 2^06]: 26304 (2^06, 2^07]: 192 (2^07, 2^08]: 285 sum_limbo_reclamation_event_size_total=21704132 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 9996 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 9997 9998 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=959804 sum_limbo_reclamation_event_count_total=1048032 first_thread_announced_epoch_by_thread=22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 22814 sum_num_inserts_by_thread=488082 491931 494631 495544 493701 486303 489483 490785 496908 498410 492442 488579 489309 492800 496029 495585 492218 489053 486672 491291 495329 496194 490541 485294 488901 491107 493331 495486 491188 487033 489798 491611 497105 494570 491245 486483 486523 490316 494771 494437 493029 488426 485403 489539 492238 493237 489322 483702 491463 494783 497592 496654 493298 492339 490451 495708 502480 503410 498169 493846 494424 496228 497208 498184 496504 489951 490497 491391 497831 497873 495193 490414 490200 492391 498693 497961 493616 494287 492020 495054 502914 500521 496550 495450 493694 495843 499387 500868 498062 494313 490891 493386 501245 503329 498072 496198 sum_num_inserts_total=47386751 sum_num_deletes_by_thread=488451 492038 494356 496237 491523 486843 490284 491977 497778 496955 492434 486733 489155 492756 496026 493403 492754 488717 485841 491464 495313 497504 490263 485213 489122 493060 493920 494782 491602 486338 487660 493592 496367 496646 491259 487688 486457 489843 495570 494681 492727 488243 486108 488728 492059 493491 488748 481713 490896 494316 497748 497976 493913 492384 491744 496060 500572 501835 499116 494191 494591 496102 499494 498102 496406 489687 488772 491065 498478 497461 494063 490239 489252 493419 498411 497889 492587 493098 491767 495623 501206 500270 496659 494139 496361 496346 500089 500222 497299 494791 492002 494832 501312 502878 497462 494916 sum_num_deletes_total=47382463 sum_num_searches_by_thread=8798344 8862347 8914710 8910372 8870252 8751881 8810644 8847661 8980411 8952034 8870609 8779616 8791668 8864056 8931749 8911144 8880103 8821845 8759995 8853776 8912322 8939732 8838218 8736486 8813754 8844751 8890413 8910039 8837199 8755072 8788782 8864771 8942669 8905818 8846050 8769705 8754638 8849113 8899260 8881902 8854104 8789609 8750284 8793311 8851245 8875268 8798004 8677608 8844819 8909113 8945635 8977724 8898390 8863256 8848540 8937881 9031305 9047090 8966090 8870600 8894043 8915347 8985728 8969698 8931234 8812370 8806994 8851466 8970180 8950169 8902046 8824929 8826504 8875785 8973574 8959288 8890596 8878309 8843690 8912552 9029068 9025938 8953132 8911988 8904667 8929967 9013742 9019244 8967419 8882709 8828120 8904008 8999675 9046308 8945941 8915960 sum_num_searches_total=852926175 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=9774877 9846316 9903697 9902153 9855476 9725027 9790411 9830423 9975097 9947399 9855485 9754928 9770132 9849612 9923804 9900132 9865075 9799615 9732508 9836531 9902964 9933430 9819022 9706993 9791777 9828918 9877664 9900307 9819989 9728443 9766240 9849974 9936141 9897034 9828554 9743876 9727618 9829272 9889601 9871020 9839860 9766278 9721795 9771578 9835542 9861996 9776074 9643023 9827178 9898212 9940975 9972354 9885601 9847979 9830735 9929649 10034357 10052335 9963375 9858637 9883058 9907677 9982430 9965984 9924144 9792008 9786263 9833922 9966489 9945503 9891302 9805582 9805956 9861595 9970678 9955138 9876799 9865694 9827477 9903229 10033188 10026729 9946341 9901577 9894722 9922156 10013218 10020334 9962780 9871813 9811013 9892226 10002232 10052515 9941475 9907074 average_num_operations_total=9871826 stdev_num_operations_total=8739 sum_num_operations_total=947695389 min_num_operations_total=9643023 max_num_operations_total=10052515 first_time_thread_terminate_by_thread=10000088 10000089 10000092 10000090 10000092 10000089 10000088 10000088 10000090 10000088 10000089 10000090 10000091 10000091 10000088 10000088 10000089 10000088 10000088 10000091 10000093 10000089 10000089 10000090 10000088 10000089 10000088 10000090 10000090 10000089 10000089 10000088 10000088 10000088 10000089 10000088 10000091 10000091 10000088 10000088 10000090 10000088 10000088 10000091 10000090 10000089 10000089 10000091 10000087 10000087 10000087 10000145 10000088 10000087 10000088 10000090 10000087 10000087 10000087 10000088 10000087 10000091 10000087 10000087 10000089 10000087 10000089 10000088 10000087 10000089 10000087 10000090 10000087 10000087 10000087 10000088 10000087 10000087 10000088 10000090 10000087 10000087 10000087 10000089 10000087 10000091 10000088 10000087 10000087 10000087 10000089 10000088 10000087 10000088 10000089 10000090 min_time_thread_terminate_total=10000087 max_time_thread_terminate_total=10000145 first_time_thread_start_by_thread=6 6 6 6 6 6 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 5 6 6 6 6 6 6 6 6 6 5 5 5 10 5 5 6 5 6 5 5 5 6 6 6 5 5 6 6 5 5 6 6 6 5 5 5 5 5 5 6 5 6 5 5 5 6 6 6 5 5 6 6 5 5 6 6 6 min_time_thread_start_total=5 max_time_thread_start_total=10 sum_duration_all_ops_total= threads_final_keysum=998823728409 threads_final_size=999118 final_keysum=998823728409 final_size=999118 validate_result=success Validation OK. Structural validation OK. total_find=852926175 total_rq=0 total_inserts=47386751 total_deletes=47382463 total_updates=94769214 total_queries=852926175 total_ops=947695389 find_throughput=85292617 rq_throughput=0 update_throughput=9476921 query_throughput=85292617 total_throughput=94769538 total find : 852926175 total rq : 0 total inserts : 47386751 total deletes : 47382463 total updates : 94769214 total queries : 852926175 total ops : 947695389 find throughput : 85292617 rq throughput : 0 update throughput : 9476921 query throughput : 85292617 total throughput : 94769538 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=15.7467 PAPI_L3_TCM=2.55879 PAPI_TOT_CYC=2801.54 PAPI_TOT_INS=1236.71 garbage=426491402118341 total_execution_walltime=11.63s REALTIME_MAIN_END_PERF_FORMAT=6985591.53989233 [time_cmd_output] time_elapsed_sec=11.75, faults_major=0, faults_minor=94860, mem_maxresident_kb=377120, user_cputime=1092.91, sys_cputime=2.04, percent_cpu=9313% timeout=false algorithm=sigouin_int_avl_kcas_validate.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2