You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@trafodion.apache.org by "ASF GitHub Bot (JIRA)" <ji...@apache.org> on 2017/09/26 00:43:00 UTC

[jira] [Commented] (TRAFODION-2754) Get statistics cores sqlci or mxosrvr at str_sprintf()

    [ https://issues.apache.org/jira/browse/TRAFODION-2754?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16180013#comment-16180013 ] 

ASF GitHub Bot commented on TRAFODION-2754:
-------------------------------------------

GitHub user selvaganesang opened a pull request:

    https://github.com/apache/incubator-trafodion/pull/1245

    [TRAFODION-2754] Get statistics cores sqlci or mxosrvr at str_sprintf()

    str_sprintf is Trafodion specific formatting function. Replaced
    str_sprintf with sprint that provides better checking with parameters.
    str_sprintf is replaced with sprintf in the statistics output related functions
    only. It is advised that the new code should start using the standard formatting
    functions.

You can merge this pull request into a Git repository by running:

    $ git pull https://github.com/selvaganesang/incubator-trafodion master_stats_core_issue

Alternatively you can review and apply these changes as the patch at:

    https://github.com/apache/incubator-trafodion/pull/1245.patch

To close this pull request, make a commit to your master/trunk branch
with (at least) the following in the commit message:

    This closes #1245
    
----
commit 43c312df5ea45c810a1b7f5e2bcd8e5a0bde8bdb
Author: selvaganesang <se...@esgyn.com>
Date:   2017-09-26T00:36:26Z

    [TRAFODION-2754] Get statistics cores sqlci or mxosrvr at str_sprintf()
    
    str_sprintf is Trafodion specific formatting function. Replaced
    str_sprintf with sprint that provides better checking with parameters.
    str_sprintf is replaced with sprintf in the statistics output related functions
    only. It is advised that the new code should start using the standard formatting
    functions.

----


>  Get statistics cores sqlci or mxosrvr at str_sprintf()
> -------------------------------------------------------
>
>                 Key: TRAFODION-2754
>                 URL: https://issues.apache.org/jira/browse/TRAFODION-2754
>             Project: Apache Trafodion
>          Issue Type: Bug
>          Components: sql-exe
>            Reporter: Selvaganesan Govindarajan
>            Assignee: Selvaganesan Govindarajan
>
> As shown below, select * from table(statistics()) cores sqlci (when using sqlci) or mxosrvr (when using trafci) with a core. The core indicates that ExMasterStats::getVariableStatsInfo() has crashed at str_sprintf(). 
> $ sqlci
> >>obey mytest.sql;
> >>set schema trafodion.g_tpch2x;
> --- SQL operation complete.
> >>
> >>prepare xx from select
> +>cast( (100.00 * sum(case
> +>when p_type like 'PROMO%'
> +>then l_extendedprice * (1 - l_discount)
> +>else 0
> +>end) / sum(l_extendedprice * (1 - l_discount))
> +>) as numeric(18,3)) as promo_revenue
> +>from
> +>lineitem,
> +>part
> +>where
> +>l_partkey = p_partkey
> +>and l_shipdate >= date '1996-01-01'
> +>and l_shipdate < date '1996-01-01' + interval '1' month;
> --- SQL command prepared.
> >>
> >>explain options 'f' xx;
> LC RC OP OPERATOR OPT DESCRIPTION CARD
> ---- ---- ---- -------------------- -------- -------------------- ---------
> 8 . 9 root 1.00E+000
> 7 . 8 sort_partial_aggr_ro 1.00E+000
> 6 . 7 esp_exchange 1:7(hash2) 1.00E+000
> 5 . 6 sort_partial_aggr_le 1.00E+000
> 4 2 5 hybrid_hash_join 1.53E+005
> 3 . 4 esp_exchange 7(hash2):8(hash2) 4.00E+005
> . . 3 trafodion_scan PART 4.00E+005
> 1 . 2 esp_exchange 7(hash2):4(hash2) 1.53E+005
> . . 1 trafodion_scan LINEITEM 1.53E+005
> --- SQL operation complete.
> >>execute xx;
> PROMO_REVENUE
> ---------------------
>                16.448
> --- 1 row(s) selected.
> >>get statistics for qid current;
> Qid MXID11000050557212371659699857497000000000206U3333308T150000000_19_XX
> Compile Start Time 2017/09/08 12:41:45.751039
> Compile End Time 2017/09/08 12:41:54.318958
> Compile Elapsed Time 0:00:08.567919
> Execute Start Time 2017/09/08 12:41:54.371318
> Execute End Time 2017/09/08 12:41:57.024031
> Execute Elapsed Time 0:00:02.652713
> State CLOSE
> Rows Affected 0
> SQL Error Code 100
> Stats Error Code 0
> Query Type SQL_SELECT_NON_UNIQUE
> Sub Query Type SQL_STMT_NA
> Estimated Accessed Rows 0
> Estimated Used Rows 0
> Parent Qid NONE
> Parent Query System NONE
> Child Qid NONE
> Number of SQL Processes 9
> Number of Cpus 1
> Transaction Id -1
> Source String select cast( (100.00 * sum(case when p_type like 'PROMO%' then l_extendedprice * (1 - l_discount) else 0 end) / sum(l_extendedprice * (1 - l_discount)) ) as numeric(18,3)) as promo_revenue from lineitem, part where l_partkey = p_partkey and l_shipdate >=
> SQL Source Length 329
> Rows Returned 1
> First Row Returned Time 2017/09/08 12:41:57.022748
> Last Error before AQR 0
> Number of AQR retries 0
> Delay before AQR 0
> No. of times reclaimed 0
> Cancel Time -1
> Last Suspend Time -1
> Query hash 7788260225241981733
> SLA Name defaultSLA
> Profile Name defaultProfile
> No. of times executed 1
> Min. Execute Time 2.652713 secs
> Max. Execute Time 2.652713 secs
> Avg. Execute Time 2.652713 secs
> Stats Collection Type OPERATOR_STATS
> SQL Process Busy Time 14,018,562
> UDR Process Busy Time 0
> SQL Space Allocated 48,416 KB
> SQL Space Used 47,741 KB
> SQL Heap Allocated 809 KB
> SQL Heap Used 322 KB
> SQL Heap WM 22,621 KB
> Processes Created 8
> Process Create Time 230,970
> Request Message Count 2,803
> Request Message Bytes 767,576
> Reply Message Count 2,694
> Reply Message Bytes 31,439,144
> BMO Space Buffer Size 256
> BMO Space Buffer Count 21
> BMO Interim Row Count 154,291
> Scr. Overflow Mode DISK
> Scr. File Count 0
> Scr. IO Size 0
> Scr. Read Count 0
> Scr. Write Count 0
> Scr. IO Max Time 0
> Sort TopN -1
>    Id DOP Table Name
>   EstRowsAccess ActRowsAccess EstRowsUsed ActRowsUsed SE_IOs SE_IO_KBytes SE_IO_SumTime SE_IO_MaxTime
>     1 4 TRAF_QATEST:TRAFODION.G_TPCH2X.LINEITEM
>               0 154,291 153,879 154,291 161 24,250 1,151,209 326,747
>     6 8 TRAF_QATEST:TRAFODION.G_TPCH2X.PART
>               0 400,000 400,000 400,000 402 70,986 1,490,487 320,272
> --- SQL operation complete.
> >>
> >>-- Execute the following statement with <qid> from the output above.
> >>-- select * from table(statistics(null, 'QID=<qid>'));
> >>
> >>select * from table(statistics(null, 'QID=MXID11000050557212371659699857497000000000206U3333308T150000000_19_XX'));
> #
> # A fatal error has been detected by the Java Runtime Environment:
> #
> # SIGSEGV (0xb) at pc=0x00007f9af8d67352, pid=50557, tid=140303659776480
> #
> # JRE version: Java(TM) SE Runtime Environment (8.0_60-b27) (build 1.8.0_60-b27)
> # Java VM: Java HotSpot(TM) 64-Bit Server VM (25.60-b23 mixed mode linux-amd64 compressed oops)
> # Problematic frame:
> # C [libcommon.so+0x10a352] str_len(char const*)+0x2
> #
> # Core dump written. Default location: /home/trafodion/bugs/core or core.50557
> #
> # An error report file with more information is saved as:
> # /home/trafodion/bugs/hs_err_pid50557.log
> #
> # If you would like to submit a bug report, please visit:
> # http://bugreport.java.com/bugreport/crash.jsp [^]
> # The crash happened outside the Java Virtual Machine in native code.
> # See problematic frame for where to report the bug.
> #
> Aborted (core dumped)
> Here is the stack trace of the core:
> #0 0x00007f9afad005e5 in raise () from /lib64/libc.so.6
> #1 0x00007f9afad01d4d in abort () from /lib64/libc.so.6
> #2 0x00007f9afcb8e6b5 in os::abort(bool) ()
>    from /usr/jdk64/jdk1.8.0_60/jre/lib/amd64/server/libjvm.so
> #3 0x00007f9afcd2cbf3 in VMError::report_and_die() ()
>    from /usr/jdk64/jdk1.8.0_60/jre/lib/amd64/server/libjvm.so
> 0000004 0x00007f9afcb93edf in JVM_handle_linux_signal ()
>    from /usr/jdk64/jdk1.8.0_60/jre/lib/amd64/server/libjvm.so
> 0000005 0x00007f9afcb8a673 in signalHandler(int, siginfo*, void*) ()
>    from /usr/jdk64/jdk1.8.0_60/jre/lib/amd64/server/libjvm.so
> 0000006 <signal handler called>
> 0000007 0x00007f9af8d67352 in str_len (
>     s=0x500000000 <Address 0x500000000 out of bounds>) at ../common/str.cpp:458
> 0000008 0x00007f9af8d68f43 in str_sprintf (
>     buffer=0x7f9abb366190 "statsRowType: 15 Qid: MXID11000050557212371659699857497000000000206U3333308T150000000_19_XX CompStartTime: 212371659705751039 CompEndTime: 212371659714318958 ExeStartTime: 212371659714371318 ExeEndTim"...,
>     format=0x7f9af94dd888 "statsRowType: %d Qid: %s CompStartTime: %Ld CompEndTime: %Ld ExeStartTime: %Ld ExeEndTime: %Ld CanceledTime: %Ld RowsAffected: %Ld SqlErrorCode: %d StatsErrorCode: %d State: %d StatsType: %d queryType"...)
>     at ../common/str.cpp:723
> 0000009 0x00007f9af93ae133 in ExMasterStats::getVariableStatsInfo (
>     this=<value optimized out>,
>     dataBuffer=0x7f9abb366190 "statsRowType: 15 Qid: MXID11000050557212371659699857497000000000206U3333308T150000000_19_XX CompStartTime: 212371659705751039 CompEndTime: 212371659714318958 ExeStartTime: 212371659714371318 ExeEndTim"...,
>     dataLen=0x7f9abb36618e "", maxLen=<value optimized out>)
>     at ../executor/ExStats.cpp:9008
> 0000010 0x00007f9af93b7325 in ExStatsTcb::getColumnValues (this=0x7f9afdbfa678,
>     stat=0x7f9ac07cf740) at ../executor/ExStats.cpp:8174
> 0000011 0x00007f9af93c0c41 in ExStatsTcb::work (this=0x7f9afdbfa678)
>     at ../executor/ExStats.cpp:7849
> 0000012 0x00007f9af939a81e in ExScheduler::work (this=0x7f9afdbfa1e0,
>     prevWaitTime=<value optimized out>) at ../executor/ExScheduler.cpp:331
> 0000013 0x00007f9af92571d2 in ex_root_tcb::execute (this=0x7f9afdbfb3e0,
>     cliGlobals=0x1a6c5a0, glob=0x7f9afdbc83e8, input_desc=0x7f9afdbe22f0,
>     diagsArea=@0x7ffc0642caa0, reExecute=0) at ../executor/ex_root.cpp:1010
> 0000014 0x00007f9afaa70325 in CliStatement::execute (this=0x7f9afdbe30d0,
>     cliGlobals=0x1a6c5a0, input_desc=0x7f9afdbe22f0, diagsArea=...,
>     execute_state=<value optimized out>, fixupOnly=0, cliflags=0)
>     at ../cli/Statement.cpp:3421
> 0000015 0x00007f9afa9f9aad in SQLCLI_PerformTasks(CliGlobals *, ULng32, SQLSTMT_ID *, SQLDESC_ID *, SQLDESC_ID *, Lng32, Lng32, typedef __va_list_tag __va_list_tag *, SQLCLI_PTR_PAIRS *, SQLCLI_PTR_PAIRS *) (cliGlobals=0x1a6c5a0, tasks=4882,
>     statement_id=0x6a88900, input_descriptor=0x8f567a0, output_descriptor=0x0,
>     num_input_ptr_pairs=0, num_output_ptr_pairs=0, ap=0x7ffc0642cc50,
>     input_ptr_pairs=0x0, output_ptr_pairs=0x0) at ../cli/Cli.cpp:3237
> 0000016 0x00007f9afa9fa5f2 in SQLCLI_Exec(CliGlobals *, SQLSTMT_ID *, SQLDESC_ID *, Lng32, typedef __va_list_tag __va_list_tag *, SQLCLI_PTR_PAIRS *) (
>     cliGlobals=<value optimized out>, statement_id=<value optimized out>,
>     input_descriptor=<value optimized out>,
>     num_ptr_pairs=<value optimized out>, ap=<value optimized out>,
>     ptr_pairs=<value optimized out>) at ../cli/Cli.cpp:3484
> 0000017 0x00007f9afaa78c5b in SQL_EXEC_Exec (statement_id=0x6a88900,
>     input_descriptor=0x8f567a0, num_ptr_pairs=0) at ../cli/CliExtern.cpp:2093
> 0000018 0x00007f9afd4a64eb in SqlCmd::doExec (sqlci_env=0x1a54aa0, stmt=0x6a88900,
>     prep_stmt=<value optimized out>, numUnnamedParams=<value optimized out>,
>     unnamedParamArray=<value optimized out>,
>     unnamedParamCharSetArray=<value optimized out>, handleError=1)
>     at ../sqlci/SqlCmd.cpp:1821
> 0000019 0x00007f9afd4a6f14 in SqlCmd::do_execute (sqlci_env=0x1a54aa0,
>     prep_stmt=0x8e50f40, numUnnamedParams=0, unnamedParamArray=0x0,
>     unnamedParamCharSetArray=0x0, prepcode=0) at ../sqlci/SqlCmd.cpp:2161
> 0000020 0x00007f9afd4a761d in DML::process (this=0x8f24850, sqlci_env=0x1a54aa0)
>     at ../sqlci/SqlCmd.cpp:2936
> 0000021 0x00007f9afd49356c in SqlciEnv::executeCommands (this=0x1a54aa0,
>     input_stmt=@0x7ffc0642e648) at ../sqlci/SqlciEnv.cpp:848
> 0000022 0x00007f9afd49590b in SqlciEnv::run (this=0x1a54aa0)
>     at ../sqlci/SqlciEnv.cpp:657
> 0000023 0x00000000004021a9 in main (argc=1, argv=0x7ffc0642e858)
>     at ../bin/SqlciMain.cpp:342



--
This message was sent by Atlassian JIRA
(v6.4.14#64029)