Ошибка ORA-03136 : Oracle

genius-na · █ 20.07.2010 05:17

Доброе время суток, у меня нечто похожая проблема. На базе одного из магазинов при расчете товародвижения (руками), при сохранении результатов в базу вылетает диалог с ошибкой и ссылкой на лог файл во временной папочке следующего содержания:

Цитата:

SQL*Loader: Release 10.2.0.4.0 - Production on Вт Июл 20 09:31:55 2010
>
>
> Copyright (c) 1982, 2007, Oracle. All rights reserved.
>
>
> SQL*Loader-128: невозможно начать сеанс
>
> ORA-03113: принят сигнал конца файла по коммуникационному каналу

В остальном все работает нормально, никаких глюков не замечено. Подскажите, в чем может быть дело? Архив с файлами из временной папочки, созданными в результате переноса и расчета товародвижения высылаю. СМ2000 1.27.2, Oracle 10.2.0.4.0.x64. Сервер супермага находится на отделльной машине x32 - c нее и делается расчет. Ранее все было нормально. На всякий слуйчай привожу последние строки alert'та старого, и специально полученного нового:

Старый:

Цитата:

Starting up ORACLE RDBMS Version: 10.2.0.4.0.
System parameters with non-default values:
processes = 150
__shared_pool_size = 989855744
__large_pool_size = 16777216
__java_pool_size = 16777216
__streams_pool_size = 0
nls_language = RUSSIAN
nls_territory = RUSSIA
sga_target = 1610612736
control_files = D:\ORACLE\ORADATA\PRIVOZRD\CONTROL01.CTL, D:\ORACLE\ORADATA\PRIVOZRD\CONTROL02.CTL, D:\ORACLE\ORADATA\PRIVOZRD\CONTROL03.CTL
db_block_size = 8192
__db_cache_size = 570425344
compatible = 10.2.0.3.0
db_file_multiblock_read_count= 16
db_recovery_file_dest = D:\oracle\product\10.2.0\flash_recovery_area
db_recovery_file_dest_size= 2147483648
undo_management = AUTO
undo_tablespace = UNDOTBS1
O7_DICTIONARY_ACCESSIBILITY= TRUE
remote_login_passwordfile= EXCLUSIVE
db_domain =
dispatchers = (PROTOCOL=TCP) (SERVICE=PRIVOZRDXDB)
job_queue_processes = 10
audit_file_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\PRIVOZRD\ADUMP
background_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\PRIVOZRD\BDUMP
user_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\PRIVOZRD\UDUMP
core_dump_dest = D:\ORACLE\PRODUCT\10.2.0\ADMIN\PRIVOZRD\CDUMP
db_name = PRIVOZRD
open_cursors = 300
pga_aggregate_target = 847249408
PMON started with pid=2, OS id=940
PSP0 started with pid=3, OS id=1072
MMAN started with pid=4, OS id=1140
DBW0 started with pid=5, OS id=1308
LGWR started with pid=6, OS id=1388
CKPT started with pid=7, OS id=1616
SMON started with pid=8, OS id=1648
RECO started with pid=9, OS id=1480
CJQ0 started with pid=10, OS id=1828
MMON started with pid=11, OS id=1784
Mon Jul 19 20:44:59 2010
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL=TCP))'...
MMNL started with pid=12, OS id=1780
Mon Jul 19 20:44:59 2010
starting up 1 shared server(s) ...
Mon Jul 19 20:45:00 2010
alter database mount exclusive
Mon Jul 19 20:45:05 2010
Setting recovery target incarnation to 1
Mon Jul 19 20:45:05 2010
Successful mount of redo thread 1, with mount id 1784895436
Mon Jul 19 20:45:05 2010
Database mounted in Exclusive Mode
Completed: alter database mount exclusive
Mon Jul 19 20:45:05 2010
alter database open
Mon Jul 19 20:45:05 2010
Beginning crash recovery of 1 threads
parallel recovery started with 7 processes
Mon Jul 19 20:45:06 2010
Started redo scan
Mon Jul 19 20:45:07 2010
Completed redo scan
428 redo blocks read, 116 data blocks need recovery
Mon Jul 19 20:45:07 2010
Started redo application at
Thread 1: logseq 1157, block 43236
Mon Jul 19 20:45:07 2010
Recovery of Online Redo Log: Thread 1 Group 2 Seq 1157 Reading mem 0
Mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO02.LOG
Mon Jul 19 20:45:07 2010
Completed redo application
Mon Jul 19 20:45:07 2010
Completed crash recovery at
Thread 1: logseq 1157, block 43664, scn 30776272
116 data blocks read, 116 data blocks written, 428 redo blocks read
Mon Jul 19 20:45:08 2010
Thread 1 advanced to log sequence 1158 (thread open)
Thread 1 opened at log sequence 1158
Current log# 3 seq# 1158 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO03.LOG
Successful open of redo thread 1
Mon Jul 19 20:45:08 2010
MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set
Mon Jul 19 20:45:08 2010
SMON: enabling cache recovery
Mon Jul 19 20:45:09 2010
Successfully onlined Undo Tablespace 1.
Mon Jul 19 20:45:09 2010
SMON: enabling tx recovery
Mon Jul 19 20:45:09 2010
Database Characterset is CL8MSWIN1251
Opening with internal Resource Manager plan
where NUMA PG = 1, CPUs = 8
replication_dependency_tracking turned off (no async multimaster replication found)
Starting background process QMNC
QMNC started with pid=24, OS id=2032
Mon Jul 19 20:45:15 2010
Completed: alter database open
Mon Jul 19 20:45:15 2010
db_recovery_file_dest_size of 2048 MB is 0.00% used. This is a
user-specified limit on the amount of space that will be used by this
database for recovery-related files, and does not reflect the amount of
space available in the underlying filesystem or ASM diskgroup.
Mon Jul 19 20:49:32 2010
WARNING: inbound connection timed out (ORA-3136)
Mon Jul 19 20:54:25 2010
WARNING: inbound connection timed out (ORA-3136)
Mon Jul 19 20:54:26 2010
WARNING: inbound connection timed out (ORA-3136)
Mon Jul 19 20:55:38 2010
WARNING: inbound connection timed out (ORA-3136)
Mon Jul 19 20:55:40 2010
WARNING: inbound connection timed out (ORA-3136)
Mon Jul 19 20:59:04 2010
WARNING: inbound connection timed out (ORA-3136)
Mon Jul 19 23:13:57 2010
Thread 1 advanced to log sequence 1159 (LGWR switch)
Current log# 1 seq# 1159 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO01.LOG
Tue Jul 20 00:00:19 2010
Thread 1 advanced to log sequence 1160 (LGWR switch)
Current log# 2 seq# 1160 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO02.LOG
Tue Jul 20 00:01:09 2010
Thread 1 advanced to log sequence 1161 (LGWR switch)
Current log# 3 seq# 1161 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO03.LOG
Tue Jul 20 01:00:55 2010
Thread 1 advanced to log sequence 1162 (LGWR switch)
Current log# 1 seq# 1162 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO01.LOG
Tue Jul 20 01:02:23 2010
Thread 1 advanced to log sequence 1163 (LGWR switch)
Current log# 2 seq# 1163 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO02.LOG
Tue Jul 20 01:03:08 2010
Thread 1 cannot allocate new log, sequence 1164
Checkpoint not complete
Current log# 2 seq# 1163 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO02.LOG
Tue Jul 20 01:03:11 2010
Thread 1 advanced to log sequence 1164 (LGWR switch)
Current log# 3 seq# 1164 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO03.LOG
Tue Jul 20 01:30:18 2010
Thread 1 advanced to log sequence 1165 (LGWR switch)
Current log# 1 seq# 1165 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO01.LOG
Tue Jul 20 05:01:45 2010
Thread 1 advanced to log sequence 1166 (LGWR switch)
Current log# 2 seq# 1166 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO02.LOG
Tue Jul 20 05:02:26 2010
Thread 1 advanced to log sequence 1167 (LGWR switch)
Current log# 3 seq# 1167 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO03.LOG
Tue Jul 20 05:03:21 2010
Thread 1 cannot allocate new log, sequence 1168
Checkpoint not complete
Current log# 3 seq# 1167 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO03.LOG
Tue Jul 20 05:03:21 2010
Thread 1 advanced to log sequence 1168 (LGWR switch)
Current log# 1 seq# 1168 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO01.LOG
Tue Jul 20 05:04:26 2010
Thread 1 cannot allocate new log, sequence 1169
Checkpoint not complete
Current log# 1 seq# 1168 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO01.LOG
Tue Jul 20 05:04:27 2010
Thread 1 advanced to log sequence 1169 (LGWR switch)
Current log# 2 seq# 1169 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO02.LOG
Tue Jul 20 07:50:10 2010
Thread 1 advanced to log sequence 1170 (LGWR switch)
Current log# 3 seq# 1170 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO03.LOG
Tue Jul 20 09:28:12 2010
Thread 1 advanced to log sequence 1171 (LGWR switch)
Current log# 1 seq# 1171 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO01.LOG
Tue Jul 20 09:32:56 2010
WARNING: inbound connection timed out (ORA-3136)

И новый:

Цитата:

Tue Jul 20 10:31:33 2010
WARNING: inbound connection timed out (ORA-3136)
Tue Jul 20 10:31:35 2010
WARNING: inbound connection timed out (ORA-3136)
Tue Jul 20 11:00:06 2010
Thread 1 advanced to log sequence 1172 (LGWR switch)
Current log# 2 seq# 1172 mem# 0: D:\ORACLE\ORADATA\PRIVOZRD\REDO02.LOG

Mtirt · █ 20.07.2010 06:47

На той машине, где ты делаешь отчет не установлена компонента Sql loader.
Надо взять инстольники серверной части оракла и поставить на ней.

OlegON · █ 20.07.2010 07:33

Нет, loader есть, он и ругается. Другое дело, что странно ругается. Это все ошибки, которые были? Что база (сервер) в этот момент делает? Предлагаю заглянуть и в виндовые журналы и sqlnet.log. Либо машина перегружена, либо скачет сетка. Предполагаю помойку и первое.
Если вообще влом с этим разбираться - выставь параметры INBOUND_CONNECT_TIMEOUT_имя_листенера ($ORACLE_HOME/network/admin/listener.ora) и SQLNET.INBOUND_CONNECT_TIMEOUT($ORACLE_HOME/network/admin/sqlnet.ora) в 0.

kadr · █ 20.07.2010 07:33

Цитата:

genius-na ➤ .... Сервер супермага находится на отделльной машине x32 - c нее и делается расчет. Ранее все было нормально....

Что установлено на машине, сколько ORACLE_HOME, какие?
После чего началось? Что-то ставилось новое, что-то настраивалось?

вот что гласит ошибка в алерте

Цитата:

03136, 00000, "inbound connection timed out"
// *Cause: Inbound connection was timed out by the server because
// user authentication was not completed within the given time
// specified by SQLNET.INBOUND_CONNECT_TIMEOUT or its default value
// *Action: 1) Check SQL*NET and RDBMS log for trace of suspicious connections.
// 2) Configure SQL*NET with a proper inbound connect timeout value
// if necessary.

т.е. лоадер вроде и начал соединение, но не смог до конца соединиться, как сервер разорвал эту попытку по таймауту

genius-na · █ 20.07.2010 08:56

Цитата:

Mtirt ➤ На той машине, где ты делаешь отчет не установлена компонента Sql loader.
Надо взять инстольники серверной части оракла и поставить на ней.

100% установлена, ранее полгода все работало. Мы еще не добралисть до оптимайзера, поэтому все считаем ручками:connie_swatfly:

Mtirt · █ 20.07.2010 08:57

А что, я что-то пропустила и оптимайзер научился считать товародвижение?

OlegON · █ 20.07.2010 09:02

Цитата:

Mtirt ➤ А что, я что-то пропустила и оптимайзер научился считать товародвижение?

Нет, только перенос пока :)

genius-na · █ 20.07.2010 09:04

Цитата:

OlegON ➤ Нет, loader есть, он и ругается. Другое дело, что странно ругается. Это все ошибки, которые были? Что база (сервер) в этот момент делает? Предлагаю заглянуть и в виндовые журналы и sqlnet.log. Либо машина перегружена, либо скачет сетка. Предполагаю помойку и первое.
Если вообще влом с этим разбираться - выставь параметры INBOUND_CONNECT_TIMEOUT_имя_листенера ($ORACLE_HOME/network/admin/listener.ora) и SQLNET.INBOUND_CONNECT_TIMEOUT($ORACLE_HOME/network/admin/sqlnet.ora) в 0.

Сервер новый, 2003R264x, из "левого" софта лишь Касперский для серверов (наслышан что Olegon не допускает такого "соседства", правда?). Полгода работы - все замечательно,ни тормозов, не повисонов. 2003 Оракл и Каспер, шар нет, вирусов тоже. 2003 настроен на оптимизацию работы служб а не программ. И вот неделю назад обратил внимание что сервер все время что-то делает дисками, т.е. светодиоды всего масссива горят пратически не мигая. Перегружал, массив сказал что все ок, загружается быстро и корректно, полчаса работы см2000 - начинаются тормаза и полная загрузка дисков. Я думал может быть он задания из адм. модуля начинает днем выполнять, хотя все задания настроены на ночь.

Логи винды и SQLNet сейчас предоставлю

genius-na · █ 20.07.2010 09:06

Цитата:

OlegON ➤ Нет, только перенос пока :)

А если td.exe после оптимайзера? (у меня кстати td не логинится к базе, хотя все по рекомендациям*01)

genius-na · █ 20.07.2010 09:21

Цитата:

OlegON ➤ Нет, loader есть, он и ругается. Другое дело, что странно ругается. Это все ошибки, которые были? Что база (сервер) в этот момент делает? Предлагаю заглянуть и в виндовые журналы и sqlnet.log. Либо машина перегружена, либо скачет сетка. Предполагаю помойку и первое.
Если вообще влом с этим разбираться - выставь параметры INBOUND_CONNECT_TIMEOUT_имя_листенера ($ORACLE_HOME/network/admin/listener.ora) и SQLNET.INBOUND_CONNECT_TIMEOUT($ORACLE_HOME/network/admin/sqlnet.ora) в 0.

sqlnet обнаружилось 2
вот sqlnet #1 (D:\oracle\product\10.2.0\db_1\NETWORK\log)

Код:

***********************************************************************
Fatal NI connect error 12170.

  VERSION INFORMATION:
	TNS for 64-bit Windows: Version 10.2.0.4.0 - Production
	Oracle Bequeath NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
	Windows NT TCP/IP NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
  Time: 20-ИЮЛ-2010 09:32:56
  Tracing not turned on.
  Tns error struct:
    ns main err code: 12535
    TNS-12535: TNS:таймаут операции
    ns secondary err code: 12606
    nt main err code: 0
    nt secondary err code: 0
    nt OS err code: 0
  Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.10.240)(PORT=3345))


***********************************************************************
Fatal NI connect error 12170.

  VERSION INFORMATION:
	TNS for 64-bit Windows: Version 10.2.0.4.0 - Production
	Oracle Bequeath NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
	Windows NT TCP/IP NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
  Time: 20-ИЮЛ-2010 10:31:33
  Tracing not turned on.
  Tns error struct:
    ns main err code: 12535
    TNS-12535: TNS:таймаут операции
    ns secondary err code: 12606
    nt main err code: 0
    nt secondary err code: 0
    nt OS err code: 0
  Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.10.240)(PORT=1175))


***********************************************************************
Fatal NI connect error 12170.

  VERSION INFORMATION:
	TNS for 64-bit Windows: Version 10.2.0.4.0 - Production
	Oracle Bequeath NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
	Windows NT TCP/IP NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
  Time: 20-ИЮЛ-2010 10:31:35
  Tracing not turned on.
  Tns error struct:
    ns main err code: 12535
    TNS-12535: TNS:таймаут операции
    ns secondary err code: 12606
    nt main err code: 0
    nt secondary err code: 0
    nt OS err code: 0
  Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=192.168.10.240)(PORT=1178))

вот sqlnet #2 (D:\oracle\product\10.2.0\db_1\ServerOraLazo_PRIVOZRD\sysman\emd)

Код:

***********************************************************************
Fatal NI connect error 12505, connecting to:
 (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ServerOraLazo)(PORT=1521))(CONNECT_DATA=(SID=PRIVOZRD)(CID=(PROGRAM=D:\oracle\product\10.2.0\db_1\bin\emagent.exe)(HOST=SERVERORALAZO)(USER=SYSTEM))))

  VERSION INFORMATION:
	TNS for 64-bit Windows: Version 10.2.0.4.0 - Production
	Windows NT TCP/IP NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
  Time: 19-ИЮЛ-2010 20:13:00
  Tracing not turned on.
  Tns error struct:
    ns main err code: 12564
    TNS-12564: TNS:соединение отвергнуто
    ns secondary err code: 0
    nt main err code: 0
    nt secondary err code: 0
    nt OS err code: 0


***********************************************************************
Fatal NI connect error 12505, connecting to:
 (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ServerOraLazo)(PORT=1521))(CONNECT_DATA=(SID=PRIVOZRD)(CID=(PROGRAM=D:\oracle\product\10.2.0\db_1\bin\emagent.exe)(HOST=SERVERORALAZO)(USER=SYSTEM))))

  VERSION INFORMATION:
	TNS for 64-bit Windows: Version 10.2.0.4.0 - Production
	Windows NT TCP/IP NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
  Time: 19-ИЮЛ-2010 20:13:15
  Tracing not turned on.
  Tns error struct:
    ns main err code: 12564
    TNS-12564: TNS:соединение отвергнуто
    ns secondary err code: 0
    nt main err code: 0
    nt secondary err code: 0
    nt OS err code: 0


***********************************************************************
Fatal NI connect error 12505, connecting to:
 (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ServerOraLazo)(PORT=1521))(CONNECT_DATA=(SID=PRIVOZRD)(CID=(PROGRAM=D:\oracle\product\10.2.0\db_1\bin\emagent.exe)(HOST=SERVERORALAZO)(USER=SYSTEM))))

  VERSION INFORMATION:
	TNS for 64-bit Windows: Version 10.2.0.4.0 - Production
	Windows NT TCP/IP NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
  Time: 19-ИЮЛ-2010 20:13:30
  Tracing not turned on.
  Tns error struct:
    ns main err code: 12564
    TNS-12564: TNS:соединение отвергнуто
    ns secondary err code: 0
    nt main err code: 0
    nt secondary err code: 0
    nt OS err code: 0


***********************************************************************
Fatal NI connect error 12528, connecting to:
 (DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=ServerOraLazo)(PORT=1521))(CONNECT_DATA=(SID=PRIVOZRD)(CID=(PROGRAM=D:\oracle\product\10.2.0\db_1\bin\emagent.exe)(HOST=SERVERORALAZO)(USER=SYSTEM))))

  VERSION INFORMATION:
	TNS for 64-bit Windows: Version 10.2.0.4.0 - Production
	Windows NT TCP/IP NT Protocol Adapter for 64-bit Windows: Version 10.2.0.4.0 - Production
  Time: 19-ИЮЛ-2010 20:13:45
  Tracing not turned on.
  Tns error struct:
    ns main err code: 12564
    TNS-12564: TNS:соединение отвергнуто
    ns secondary err code: 0
    nt main err code: 0
    nt secondary err code: 0
    nt OS err code: 0

В логах винды кроме того что сервис поднялся ничего интересного