Форум по программам и оборудованию > > >

Оптимайзер - 7 (вопросы и обсуждения) часть вторая

21.06.2018 14:58


[ОТВЕТИТЬ]
02.04.2016 18:35
OlegON
 
Первая часть закрылась по лимиту сообщений, продолжаем.

поправил проверку архивлогов в связи с этим https://olegon.ru/showthread.php?t=24325
05.04.2016 09:49
sh00r00p
 
Ребята, это просто весеннее обострение, все устаканится.
Shit happens, но зачем мосты-то сжигать?
14.04.2016 21:41
Diamondne
 
Поставил Оптимайзер-7, после 2-х запусков на почте сообщение:

14.04.16 21:16:52 -- Thu Apr 14 21:15:20 2016 ORA-1276 signalled during: alter database add logfile group 2 ('/u01/app/oracle/oradata/DRIBIN11/onlinelog/o1_mf_2_cjnsm9yw_.log') size 1024M reuse...

В логе выполнения Оптимайзера:

OLEGON-ERROR! 14.04.16 21:16:52 -- Thu Apr 14 21:15:20 2016 ORA-1276 signalled during: alter database add logfile group 2 ('/u01/app/oracle/oradata/DRIBIN11/onlinelog/o1_mf_2_cjnsm9yw_.log') size 1024M reuse...
14.04.16 21:17:01 -- Too few log groups...
OLEGON-ERROR! 14.04.16 21:17:03 -- Unhandled error : java.sql.SQLException: ORA-01184: logfile group 8 already exists ORA-06512: at line 1 * Oracle : 11.2.0.3.0 * Java : 1.7.0_99 * OS : Linux

Подскажите, пожалуйста, как это исправить.

Linux version 3.8.13-44.1.1.el6uek.x86_64 (mockbuild@ca-build44.us.oracle.com) (gcc version 4.4.7 20120313 (Red Hat 4.4.7-3)
Oracle 11.2.0.3.0 - 64bit
14.04.2016 23:00
OlegON
 
Мда... это несчастный OMF, который зачем-то вообще включают... если в добавлении файлов я его учел, то в оптимизации REDO - нет.
Если есть некоторое понимание ситуации, то рекомендую от OMF избавиться, если нет - просто отключите эту оптимизацию, специально сделал ее отключаемой: https://olegon.ru/showpost.php?p=255962&postcount=163 в этом параметре поставьте 0.
17.04.2016 14:12
Diamondne
 
Каждый день в часы МТ оптимизатор ругается следующим образом:

OLEGON-ERROR! 16.04.16 23:29:20 -- Unhandled error : java.sql.SQLException: ORA-01489: result of string concatenation is too long * Oracle : 11.2.0.3.0 * Java : 1.7.0_99 * OS : Linux

В логах по этому времени ни чего не нашел. Что он может делать в это время?
17.04.2016 20:56
OlegON
 
Хорошо бы увидеть не только саму ошибку, но и строки до этого... Т.е. по сообщению вижу "упал с ошибкой", но в каком месте, увы, не вижу. В целях безопасности не следует публично указывать номер клиента и ID. Все остальное (ну, юзеров и пути к базе еще лучше подтереть) секретом не будут, зато мне не гадать, что там может быть.
17.04.2016 22:01
Diamondne
 
Цитата:
OlegON Хорошо бы увидеть не только саму ошибку, но и строки до этого...
16.04.16 23:29:01 -- UTC+3
16.04.16 23:29:02 -- Current sysdate : 2016-04-16 23:29:02.0
16.04.16 23:29:02 -- ClientID:
16.04.16 23:29:02 -- IP :
16.04.16 23:29:02 -- ClientNum:
16.04.16 23:29:02 -- Oracle version: 11.2.0.3.0
16.04.16 23:29:02 -- Last optimizer run : 21:29:24 16.04.2016
16.04.16 23:29:02 -- Unregistered version.
16.04.16 23:29:02 -- Home : /u01/app/oracle/product/11.2.0/dbhome_1
16.04.16 23:29:02 -- Hosts :
16.04.16 23:29:02 -- Users : SUPERMAG-18; SYS-1
16.04.16 23:29:02 -- Statuses : ACTIVE-28; INACTIVE-17
16.04.16 23:29:02 -- Types : USER-19; BACKGROUND-26
16.04.16 23:29:02 -- Server : DEDICATED-44; SHARED-1
16.04.16 23:29:02 -- Database size : 35Gb
16.04.16 23:29:02 -- Locked objects .......
16.04.16 23:29:03 -- Кассовый модуль-SUPERMAG-KOSMOS\SERVER11SM-SYSTEM
16.04.16 23:29:03 -- Критическая секция-SUPERMAG-KOSMOS\SERVER11SM-SYSTEM
16.04.16 23:29:03 -- Почтовый модуль-SUPERMAG-KOSMOS\SERVER11SM-SYSTEM
16.04.16 23:29:03 -- Сервер приложений-SUPERMAG-KOSMOS\SERVER11SM-SYSTEM
16.04.16 23:29:03 -- Locked objects ^^^^^^^
16.04.16 23:29:03 -- Current SQL queries .......
16.04.16 23:29:03 -- 11-445-20:11 16.04-SUPERMAG-1037-pipe get-1--SYSTEM-KOSMOS\SERVER11SM-Sm.AppServer.exe-DEDICATED-begin Supermag.Core.NextMessage(rq=>:rq, rqData=>:rqD$
16.04.16 23:29:03 -- Current SQL queries ^^^^^^^
16.04.16 23:29:03 -- Tablespaces usage .......
16.04.16 23:29:03 -- USERS : 17528Mb
16.04.16 23:29:03 -- INDX : 17437Mb
16.04.16 23:29:03 -- SYSAUX : 546Mb
16.04.16 23:29:03 -- SYSTEM : 509Mb
16.04.16 23:29:03 -- UNDOTBS1 : 62Mb
16.04.16 23:29:03 -- Tablespaces usage ^^^^^^^
16.04.16 23:29:03 -- SGA dynamic components .......
16.04.16 23:29:03 -- DEFAULT buffer cache - Current: 5248Mb (SHRINK), Spfile: 3744Mb, Min: 48Mb
16.04.16 23:29:03 -- shared pool - Current: 288Mb (STATIC), Spfile: 288Mb, Min: 288Mb
16.04.16 23:29:03 -- java pool - Current: 32Mb (STATIC), Spfile: 32Mb, Min: 32Mb
16.04.16 23:29:03 -- large pool - Current: 16Mb (GROW), Spfile: 0Mb, Min: 0Mb
16.04.16 23:29:03 -- SGA dynamic components ^^^^^^^
16.04.16 23:29:03 -- Checking database parameters
16.04.16 23:29:03 -- /u01/app : 316109 Mb
16.04.16 23:29:03 -- /u01/app/oracle : 316109 Mb
16.04.16 23:29:03 -- /u01/app/oracle/admin/DRIBIN11 : 316109 Mb
16.04.16 23:29:03 -- /u01/app/oracle/diag/rdbms/dribin11/DRIBIN11 : 316109 Mb
16.04.16 23:29:03 -- /u01/app/oracle/oradata/DRIBIN11/datafile : 316109 Mb
16.04.16 23:29:03 -- /u01/app/oracle/product/11.2.0/dbhome_1/dbs : 316109 Mb
16.04.16 23:29:03 -- SYSAUX:13Gb
16.04.16 23:29:04 -- USERS:14Gb
16.04.16 23:29:04 -- SYSTEM:3Gb
16.04.16 23:29:04 -- INDX:14Gb
16.04.16 23:29:04 -- Log filename: /u01/app/oracle/diag/rdbms/dribin11/DRIBIN11/trace/alert_DRIBIN11.log 0Mb
OLEGON-ERROR! 16.04.16 23:29:20 -- Unhandled error : java.sql.SQLException: ORA-01489: result of string concatenation is too long * Oracle : 11.2.0.3.0 * Java : 1.7.0_99
17.04.2016 22:02
Diamondne
 
Собственно лог разового запуска...
18.04.2016 12:15
OlegON
 
Разобрались... Пофиксил проблему вывода очень большого списка инвалидов.
23.04.2016 09:06
konst
 
Со вчерашнего дня приблизительно с 15-00 - 16-00
перестал работать на некоторых базах...
запускается и тут же заканчивает работу...
23.04.16 01:07:01 -- UTC+3
23.04.16 01:07:02 -- Exit code 3
23.04.16 01:40:01 -- UTC+3
23.04.16 01:40:02 -- Exit code 3
23.04.16 02:13:02 -- UTC+3
23.04.16 02:13:03 -- Exit code 3
23.04.16 02:46:01 -- UTC+3
23.04.16 02:46:02 -- Exit code 3
23.04.16 03:19:04 -- UTC+3
23.04.16 03:19:05 -- Exit code 3
23.04.16 03:52:01 -- UTC+3
23.04.16 03:52:02 -- Exit code 3
23.04.16 04:25:01 -- UTC+3
23.04.16 04:25:02 -- Exit code 3
23.04.16 04:58:01 -- UTC+3

иногда отрабатывает подольше... но все равно до конца ни разу не дошел
23.04.2016 10:02
OlegON
 
Это говорит о том, что опт в базе. Т.е. запущен второй экземпляр или существует optimizer.pid
pid перестает учитываться минут через 5, а вот с тем, что застрял в базе... можно ребутнуть, но лучше найти последнюю строку, на чем он повис... судя по всему, это я что-то попутал в экспорте (другое ничего не правил), но у меня такого ни на одной БД нет...
23.04.2016 11:01
OlegON
 
Собственно, ребутить хост не обязательно - можно прибить java.exe, попробуй, интересно, что может быть причиной залипания...
23.04.2016 11:05
OlegON
 
Можешь и бросить, я приеду - допишу проверку, больше суток будет самоубиваться.
23.04.2016 22:54
OlegON
 
как там? добавил, что если обнаружится старая сессия оптимизатора, произойдет массовое убийство процессов java.exe
24.04.2016 07:19
konst
 
не отрабатывает на нескольких БД с одинаковыми симптомами
последний успешный запуск на этих базах был 22 апреля в 15:52-16:06
после этого останавливается вот здесь и висит:
Код:
24.04.16 07:13:54 -- SGA dynamic components ^^^^^^^
24.04.16 07:13:54 -- Checking database parameters
24.04.16 07:13:58 -- D:\ORACLE\ORADATA\DBNAME: 15974 Mb
24.04.16 07:13:58 -- D:\ORACLE\PRODUCT\10.2.0\DB_1\DATABASE : 15974 Mb
24.04.16 07:13:58 -- D:\Oracle\oradata\DBNAME: 15974 Mb
и остается optimizer.pid. Может что-то и делает... но не видно.
в задании стояло убивать процесс через 2 часа - так и работает
сегодня перезагрузил эти сервера - результат не изменился.
да и по поводу kill java - сейчас у многих на серверах параллельно еще и УТМ егаисовский крутится, а он java использует - не возникнут ли проблемы?
24.04.2016 08:42
OlegON
 
По поводу java - посмотрел там, где навтыкали УТМ - в списке процессов java.exe не вижу... На дисконнект из базы он может и забить, а определить, где нужная жаба нереально. Любой жаба-процесс должен перезапускаться регулярно, она такая, что нормально работать сервисом не может.

Вписал уведомление, что экспорт стартует (но это не он - в другом месте). Поставил обрамление на процедуру проверки места, давай посмотрим, выходит ли он из нее или нет... У тебя битых дисков там нет? Вообще, наверное, лучше бы ты мне кинул подключение - посмотреть, что происходит...

Поправил ошибку, при которой статистика по ТД вносилась несколько раз и видоизменил строку статистики. Сначала идет дата внесения записи, потом уже старт и стоп ТД.
24.04.2016 19:36
OlegON
 
Разобрались, обратите внимание на п. 4 https://olegon.ru/showthread.php?t=23510
25.04.2016 07:19
konst
 
Сегодня из всех БД пришла по почте ошибка:
Цитата:
25.04.16 07:02:41 -- Unhandled error : java.io.FileNotFoundException: C:\admin\optimizer\tdBDNAME.stat (Не удается найти указанный файл) * Oracle : 10.2.0.5.0 * Java : 1.8.0_74 * OS : Windows XP
вообщем все логично - в МХ я товародвижение не рассчитываю...
и с этих же баз не пришли ежедневные отчеты.
25.04.2016 08:07
OlegON
 
опаньки... независимо от того, что рассчитываешь ты ТД или нет, файлик должен был создаться хотя бы с записью, что ТД нет... загадочно... поправил, чтобы существование учитывалось, спасибо.
25.04.2016 19:42
VitorJ
 
Добрый день!
Сегодня после обновления, перестал запускать optimizer, в логах OLEGON-ERROR! Email was not defined!!!
Поменялся механизм подключения к почтовому серверу?
25.04.2016 20:02
OlegON
 
нет... скорее всего, какая-то проблема с ini. сегодня вообще чисто косметические правки были, касаемо журнала ТД...
28.04.2016 14:44
OlegON
 
Цитата:
VitorJ Добрый день!
Сегодня после обновления, перестал запускать optimizer, в логах OLEGON-ERROR! Email was not defined!!!
Поменялся механизм подключения к почтовому серверу?
Чем закончилось-то?
28.04.2016 14:46
OlegON
 
В билде десятиминутной давности поправлен баг, вследствие которого некоторые программы, запускаемые из оптимизатора, могли оптимизатор подвесить.
Механизм запуска внешних утилит существенно переработан, надеюсь, ничего не накосячил.
01.05.2016 17:36
Diamondne
 
Добрый день!
Оптимизатор шлет такие ошибки:

01.05.16 00:27:19 -- Threaded statement 'alter table "SUPERMAG"."SMWAYBILLSOUT" enable validate constraint SMCWAYBILLSOUTHDR' error java.sql.SQLIntegrityConstraintViolationException: ORA-02298: cannot validate (SUPERMAG.SMCWAYBILLSOUTHDR) - parent keys not found

01.05.16 00:27:19 -- Threaded statement 'alter table "SUPERMAG"."SMWAYBILLSIN" enable validate constraint SMCWAYBILLSINHDR' error java.sql.SQLIntegrityConstraintViolationException: ORA-02298: cannot validate (SUPERMAG.SMCWAYBILLSINHDR) - parent keys not found

01.05.16 00:27:21 -- Threaded statement 'alter table "SUPERMAG"."SMCOMMONBASES" enable validate constraint SMCCOMMONBASES_DOC' error java.sql.SQLIntegrityConstraintViolationException: ORA-02298: cannot validate (SUPERMAG.SMCCOMMONBASES_DOC) - parent keys not found

01.05.16 00:28:51 -- Threaded statement 'alter table "SUPERMAG"."SMSPEC" enable validate constraint SMCSPECDOC' error java.sql.SQLIntegrityConstraintViolationException: ORA-02298: cannot validate (SUPERMAG.SMCSPECDOC) - parent keys not found

Как-то возможно от него получить информацию, чтоб найти ручками эти записи в вышеперечисленных таблицах?
01.05.2016 19:18
OlegON
 
Нет, он просто пытается включить эти ограничения, которые какой-то умелец включил без проверки, нарушив целостность базы. Как с этим бороться, я писал где-то в оракловой теме. Тут не машинное решение нужно, а административное. Оптимизатор совсем не при чем.
02.05.2016 16:55
Diamondne
 
При первом запуске на одной из баз, оптимайзер отваливается от базы... при этом в алерте все чисто, юзеры работают штатно. Прилагаю лог разового запуска с "-d=3" https://storage.olegon.ru/supermag/u...timizer.log.7z
02.05.2016 20:43
Diamondne
 
добавлю:
Java(TM) SE Runtime Environment (build 1.8.0_91-b14)
Linux version 2.6.39-300.28.1.el6uek.x86_64 (mockbuild@ca-build44.us.oracle.com) (gcc version 4.4.6 20110731 (Red Hat 4.4.6-3) (GCC) )
02.05.2016 22:13
OlegON
 
Так он (оракловый клиент) же честно пишет...
TNS-12535: TNS:operation timed out
в этом и проблема...
19.05.2016 09:07
Diamondne
 
Оптимизатор в суточном отчете пишет, что кассовый документ за одно число создан частично, при этом, все кассы выгружены, оперативных чеков нет, суммы чеков и документа совпадают, соответствие z-отчетам стоит "да". Пробовал пересоздавать этот документ, - не помогает. Что еще ему может не нравиться?
19.05.2016 09:07
OlegON
 
Это не ему, а Супермагу не нравится. В Супермаге эта метка стоит. Почему - могу только догадываться. Предлагаю удалить Z и выгрузить с кассы заново.


Опции темы


Часовой пояс GMT +3, время: 14:58.

 

Форум сделан на основе vBulletin®
Copyright ©2000 - 2018, Jelsoft Enterprises Ltd. Перевод: zCarot и OlegON
В случае заимствования информации гипертекстовая индексируемая ссылка на Форум обязательна.