|
JStatement::fetch, 335544364 req synch error - может блокировать вывод статистики в трейсе
#38613150
Ссылка:
Ссылка на сообщение:
Ссылка с названием темы:
Ссылка на профиль пользователя:
|
|
|
|
hi all
Запустил в isql: 1. 2. 3. 4. 5. 6.
SQL> out nul;
SQL> select h.id, d.ware_id
CON> from doc_list h
CON> join doc_data d on h.id=d.doc_id
CON> where
CON> h.optype_id = fn_oper_invoice_get()
CON> and h.state_id = fn_doc_open_state();
-- и получил в трейсе некий результат, содержавший статистику по этому запросу (см фрагмент синим цветом): 1. 2. 3. 4. 5. 6. 7. 8. 9. 10. 11. 12. 13. 14. 15. 16. 17. 18. 19. 20. 21. 22. 23. 24. 25. 26. 27. 28. 29. 30. 31. 32. 33. 34. 35. 36. 37. 38. 39. 40. 41. 42. 43. 44. 45. 46. 47. 48. 49. 50. 51. 52. 53. 54. 55. 56. 57. 58. 59. 60. 61. 62. 63. 64. 65. 66. 67. 68. 69. 70. 71. 72. 73. 74. 75. 76. 77. 78. 79. 80. 81. 82. 83. 84. 85. 86. 87. 88. 89. 90. 91. 92. 93. 94. 95. 96. 97. 98. 99. 100. 101. 102. 103. 104. 105. 106. 107. 108. 109. 110. 111. 112. 113. 114. 115. 116. 117. 118. 119. 120. 121. 122. 123. 124. 125. 126. 127. 128. 129. 130. 131. 132. 133. 134. 135. 136. 137. 138. 139. 140. 141. 142. 143. 144. 145. 146. 147. 148. 149. 150. 151. 152. 153. 154. 155. 156. 157. 158. 159. 160. 161. 162. 163. 164. 165. 166. 167. 168. 169. 170. 171. 172. 173. 174. 175.
2014-04-12T15:12:28.5580 (22502:0x7f840309d078) PREPARE_STATEMENT
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387102, READ_COMMITTED | NO_REC_VERSION | WAIT | READ_WRITE)
Statement 878951:
-------------------------------------------------------------------------------
select h.id, d.ware_id
from doc_list h
join doc_data d on h.id=d.doc_id
where
h.optype_id = fn_oper_invoice_get()
and h.state_id = fn_doc_open_state()
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN JOIN (D NATURAL, H INDEX (PK_DOC_LIST))
1 ms
2014-04-12T15:12:28.5590 (22502:0x7f840309d078) EXECUTE_STATEMENT_START
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
Statement 878951:
-------------------------------------------------------------------------------
select h.id, d.ware_id
from doc_list h
join doc_data d on h.id=d.doc_id
where
h.optype_id = fn_oper_invoice_get()
and h.state_id = fn_doc_open_state()
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN JOIN (D NATURAL, H INDEX (PK_DOC_LIST))
2014-04-12T15:12:28.5600 (22502:0x7f840309d078) PREPARE_STATEMENT
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
Statement 878953:
-------------------------------------------------------------------------------
select o.id from optypes o where o.m_qty_ord=? and o.m_qty_sup=?
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN (O NATURAL)
0 ms
2014-04-12T15:12:28.5600 (22502:0x7f840309d078) EXECUTE_STATEMENT_START
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
Statement 878953:
-------------------------------------------------------------------------------
select o.id from optypes o where o.m_qty_ord=? and o.m_qty_sup=?
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN (O NATURAL)
param0 = smallint, "-1"
param1 = smallint, "1"
2014-04-12T15:12:28.5600 (22502:0x7f840309d078) CLOSE_CURSOR
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
Statement 878953:
-------------------------------------------------------------------------------
select o.id from optypes o where o.m_qty_ord=? and o.m_qty_sup=?
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN (O NATURAL)
2014-04-12T15:12:28.5600 (22502:0x7f840309d078) SET_CONTEXT
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
[USER_SESSION] FN_OPER_INVOICE_GET = "2000"
2014-04-12T15:12:31.4220 (22502:0x7f840309d078) PREPARE_STATEMENT
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
Statement 878955:
-------------------------------------------------------------------------------
select s.id from doc_states s where s.mcode=?
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN (S INDEX (DOC_STATES_MCODE_UNQ))
0 ms
2014-04-12T15:12:31.4220 (22502:0x7f840309d078) EXECUTE_STATEMENT_START
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
Statement 878955:
-------------------------------------------------------------------------------
select s.id from doc_states s where s.mcode=?
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN (S INDEX (DOC_STATES_MCODE_UNQ))
param0 = varchar(320), "DOC_OPEN_STATE"
2014-04-12T15:12:31.4220 (22502:0x7f840309d078) CLOSE_CURSOR
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
Statement 878955:
-------------------------------------------------------------------------------
select s.id from doc_states s where s.mcode=?
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN (S INDEX (DOC_STATES_MCODE_UNQ))
2014-04-12T15:12:31.4220 (22502:0x7f840309d078) SET_CONTEXT
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
[USER_SESSION] FN_DOC_OPEN_STATE = "2000"
2014-04-12T15:12:38.0310 (22502:0x7f840309d078) EXECUTE_STATEMENT_FINISH
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
Statement 878951:
-------------------------------------------------------------------------------
select h.id, d.ware_id
from doc_list h
join doc_data d on h.id=d.doc_id
where
h.optype_id = fn_oper_invoice_get()
and h.state_id = fn_doc_open_state()
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN JOIN (D NATURAL, H INDEX (PK_DOC_LIST))
18036 records fetched
9441 ms, 5786789 fetch(es)
Table Natural Index Update Insert Delete Backout Purge Expunge
***************************************************************************************************************
DOC_LIST 775923
DOC_DATA 775923
2014-04-12T15:12:38.0620 (22502:0x7f840309d078) ERROR AT JStatement::fetch
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
335544364 : request synchronization error
2014-04-12T15:12:38.0850 (22502:0x7f840309d078) CLOSE_CURSOR
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
Statement 878951:
-------------------------------------------------------------------------------
select h.id, d.ware_id
from doc_list h
join doc_data d on h.id=d.doc_id
where
h.optype_id = fn_oper_invoice_get()
and h.state_id = fn_doc_open_state()
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN JOIN (D NATURAL, H INDEX (PK_DOC_LIST))
2014-04-12T15:17:44.4570 (22502:0x7f840309d078) FREE_STATEMENT
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
Statement 878951:
-------------------------------------------------------------------------------
select h.id, d.ware_id
from doc_list h
join doc_data d on h.id=d.doc_id
where
h.optype_id = fn_oper_invoice_get()
and h.state_id = fn_doc_open_state()
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN JOIN (D NATURAL, H INDEX (PK_DOC_LIST))
Далее запускаю в том же isql'e:
1. 2. 3. 4. 5. 6. 7. 8.
SQL> select x.id, d.ware_id
CON> from (
CON> select distinct h.id
CON> from doc_list h
CON> where
CON> h.optype_id = fn_oper_invoice_get()
CON> and h.state_id = fn_doc_open_state()
CON> ) x
CON> join doc_data d on x.id=d.doc_id;
- и НЕдополучаю в трейсе эту самую статистику: 1. 2. 3. 4. 5. 6. 7. 8. 9. 10. 11. 12. 13. 14. 15. 16. 17. 18. 19. 20. 21. 22. 23. 24. 25. 26. 27. 28. 29. 30. 31. 32. 33. 34. 35. 36. 37. 38. 39. 40. 41. 42. 43. 44. 45. 46. 47. 48. 49. 50. 51. 52. 53. 54. 55. 56. 57. 58. 59. 60. 61.
2014-04-12T15:17:44.4570 (22502:0x7f840309d078) PREPARE_STATEMENT
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387102, READ_COMMITTED | NO_REC_VERSION | WAIT | READ_WRITE)
Statement 878956:
-------------------------------------------------------------------------------
select x.id, d.ware_id
from (
select distinct h.id
from doc_list h
where
h.optype_id = fn_oper_invoice_get()
and h.state_id = fn_doc_open_state()
) x
join doc_data d on x.id=d.doc_id
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN JOIN (SORT (X H INDEX (FK_DOC_LIST_STATE, FK_DOC_LIST_OPTYPES)), D INDEX (FK_DOC_DATA_DOC_LISTS))
0 ms
2014-04-12T15:17:44.4580 (22502:0x7f840309d078) EXECUTE_STATEMENT_START
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
(TRA_1387101, CONCURRENCY | WAIT | READ_WRITE)
Statement 878956:
-------------------------------------------------------------------------------
select x.id, d.ware_id
from (
select distinct h.id
from doc_list h
where
h.optype_id = fn_oper_invoice_get()
and h.state_id = fn_doc_open_state()
) x
join doc_data d on x.id=d.doc_id
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN JOIN (SORT (X H INDEX (FK_DOC_LIST_STATE, FK_DOC_LIST_OPTYPES)), D INDEX (FK_DOC_DATA_DOC_LISTS))
2014-04-12T15:17:45.0240 (22502:0x7f840309d078) ERROR AT JStatement::fetch
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
335544364 : request synchronization error
2014-04-12T15:17:45.0480 (22502:0x7f840309d078) CLOSE_CURSOR
oltp30 (ATT_5812, SYSDBA:NONE, NONE, TCPv4:192.168.43.96)
C:\MIX\firebird\fb25\bin\isql.exe:3084
Statement 878956:
-------------------------------------------------------------------------------
select x.id, d.ware_id
from (
select distinct h.id
from doc_list h
where
h.optype_id = fn_oper_invoice_get()
and h.state_id = fn_doc_open_state()
) x
join doc_data d on x.id=d.doc_id
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
PLAN JOIN (SORT (X H INDEX (FK_DOC_LIST_STATE, FK_DOC_LIST_OPTYPES)), D INDEX (FK_DOC_DATA_DOC_LISTS))
Куда подевалась секция "EXECUTE_STATEMENT_FINISH" со статистикой ??
1. 2. 3. 4. 5.
ISQL Version: WI-V2.5.3.26730 Firebird 2.5
Server version:
Firebird/linux AMD64 (access method), version "LI-T3.0.0.31037 Firebird 3.0 Alpha 2"
Firebird/linux AMD64 (remote server), version "LI-T3.0.0.31037 Firebird 3.0 Alpha 2/tcp (oel64)/P12"
Firebird/x86/Windows NT (remote interface), version "WI-V2.5.3.26730 Firebird 2.5/tcp (csprog)/P12"
on disk structure version 12.0
|
|
|