[
https://issues.apache.org/jira/browse/TRAFODION-2754?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Selvaganesan Govindarajan resolved TRAFODION-2754.
--------------------------------------------------
Resolution: Fixed
> 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)
