Ich habe gerade angefangen, an Oracle BI zu arbeiten, habe ich ein Szenario, in dem ein Dashboard, wenn geladen wird dauert eine ganze Weile. Zuerst dachte ich, dass der Grund für diese langsame Leistung Datenbankabfragen waren. Aber wenn die Protokolle angezeigt wurden, zeigen Abfragen, die bei der Ausführung auf der Datenbank (MDS) kaum eine Sekunde gedauert haben, in Weblogics 6 Sekunden als Ausführungszeit an.Abfrage dauert mehr Zeit bei der Ausführung in OBIEE Weblogic als auf der Datenbank
Unten ist das Protokoll einer einfachen Abfrage, die dauert fast 6s auf Weblogics und dauert 897 Millisekunden, wenn auf Datenbank ausgeführt.
[2016-04-04T05:11:58.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-0] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:9:3] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] ############################################## [[
-------------------- SQL Request, logical request hash:
44507272
SET VARIABLE QUERY_SRC_CD='ValuePrompt';SELECT "Project"."Project Type#1" saw_0 FROM "PLM PPM - Project Summary" ORDER BY saw_0
FETCH FIRST 65001 ROWS ONLY
]]
[2016-04-04T05:11:58.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-23] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:9:3] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- General Query Info: [[
Repository: Star, Subject Area: PLMA, Presentation: PLM PPM - Project Summary
]]
[2016-04-04T05:11:58.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-2] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:9:3] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Logical Request (before navigation): [[
RqList distinct
Dim - Project.Project Type as c1 GB
OrderBy: c1 asc
]]
[2016-04-04T05:11:58.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-48] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:9:5] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- The logical query block fail to hits or seed the cache in subrequest level due to [[
only one subrequest
]]
[2016-04-04T05:11:58.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-51] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:9:5] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- The logical plan contains non-cacheable node, plan [[
RqList <<82402988>> distinct
D1.c1 as c1 GB
Child Nodes (RqJoinSpec): <<82403017>>
RqJoinNode <<82403016>> []
(
RqList <<82402995>>
Dim_PPM_PROJECT_D.PRJ_USRDEF_LIST0 as c1 GB
Child Nodes (RqJoinSpec): <<82403009>>
RqJoinNode <<82403008>> []
PPM_PROJECT_D AS Dim_PPM_PROJECT_D
DetailFilter: Dim_PPM_PROJECT_D.DELETE_FLG = 0
) as D1
OrderBy: c1 asc
node cache seed not inserted due to multiple plan not cacheable
]]
[2016-04-04T05:11:58.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-50] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:9:5] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- The logical query seed the plan cache [[
plan
RqList <<82403049>> [for database 3023:57:PLMA,57] distinct /* FETCH FIRST 65001 ROWS ONLY */
Dim_PPM_PROJECT_D.PRJ_USRDEF_LIST0 as c1 GB [for database 3023:57,57]
Child Nodes (RqJoinSpec): <<82403053>> [for database 3023:57:PLMA,57]
RqJoinNode <<82403054>> []
PPM_PROJECT_D AS Dim_PPM_PROJECT_D
DetailFilter: Dim_PPM_PROJECT_D.DELETE_FLG = 0 [for database 3023:57]
OrderBy: c1 asc [for database 3023:57,57]
]]
[2016-04-04T05:11:58.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-16] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:9:5] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Execution plan: [[
RqList <<82402995>> [for database 3023:57:PLMA,57] distinct /* FETCH FIRST 65001 ROWS ONLY */
Dim_PPM_PROJECT_D.PRJ_USRDEF_LIST0 as c1 GB [for database 3023:57,57]
Child Nodes (RqJoinSpec): <<82403009>> [for database 3023:57:PLMA,57]
RqJoinNode <<82403008>> []
PPM_PROJECT_D AS Dim_PPM_PROJECT_D
DetailFilter: Dim_PPM_PROJECT_D.DELETE_FLG = 0 [for database 3023:57]
OrderBy: c1 asc [for database 3023:57,57]
]]
[2016-04-04T05:11:58.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-18] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:9:5] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Sending query to database named PLMA (id: <<82402995>>), connection pool named Connection Pool, logical request hash 44507272, physical request hash f82d8b03: [[
select D1.c1 as c1 from (select distinct T286689.PRJ_USRDEF_LIST0 as c1
from
PPM_PROJECT_D T286689 /* Dim_PPM_PROJECT_D */
where (T286689.DELETE_FLG = 0)
order by c1) D1 where rownum <= 65001
]]
[2016-04-04T05:12:04.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-34] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:11] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Query Status: Successful Completion [[
]]
[2016-04-04T05:12:04.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-26] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:11] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Rows 5, bytes 20060 retrieved from database query id: <<82402995>> [[
]]
[2016-04-04T05:12:04.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-28] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:11] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Physical query response time 5 (seconds), id <<82402995>> [[
]]
[2016-04-04T05:12:04.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-29] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:11] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Physical Query Summary Stats: Number of physical queries 1, Cumulative time 5, DB-connect time 0 (seconds) [[
]]
[2016-04-04T05:12:04.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-24] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:11] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Rows returned to Client 5 [[
]]
[2016-04-04T05:12:04.000-07:00] [OracleBIServerComponent] [TRACE:4] [USER-33] [] [ecid: 77bb740f357d872f:52e5f112:1522a219085:-8000-00000000004961ca,0:1:11] [tid: dbf7c700] [requestid: 157d0024] [sessionid: 157d0000] [username: weblogic] -------------------- Logical Query Summary Stats: Elapsed time 6, Response time 5, Compilation time 0 (seconds) [[
]]
Kann mir jemand sagen, wie ich die Ursache dieses Problems finden kann.
Dieser Satz im Protokoll 'Physische Abfrage Antwortzeit 5 (Sekunden)' lässt mich denken, dass es die physische Abfrage in der Datenbank ist ... oder zumindest die Zeit, um eine Verbindung zur Datenbank herzustellen. Melden Sie sich bei der Anmeldung als derselbe Benutzer an, unter dem OBIEE ausgeführt wird? Sind Sie in derselben db-Partition, wenn Sie mehrere haben? Müssen Sie die Anzahl der Verbindungen im Verbindungspool erhöhen? –