
Новые сообщения [новые:0]
Дайджест
Горячие темы
Избранное [новые:0]
Форумы
Пользователи
Статистика
Статистика нагрузки
Мод. лог
Поиск
|
|
14.02.2006, 13:03
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
Есть подозрение, что восстановление большой базы onbar -r где-то подвисает, поскольку уже более 3 часов (!) от него никаких известий. Последняя запись в логе onbar: 2006-02-14 11:11:35 8100 8099 Begin warm level 0 restore plandbs И уже более 3 часов ничего... В списке процессов эти 8100 и 8099 вроде как работают.... База конечно огромная, занимает около 5 чанков. Restore маленьких баз проходило нормально. Подскажите, что с этим делать, и вообще, примерно сколько времени занимает восстановление базы подобного размера? Система UnixWare7.1.3, Infirmix Dynamic Server 7.31, базы в чанках на сыром устройстве. ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
14.02.2006, 13:35
|
|||
|---|---|---|---|
Непонятки с On-Bar |
|||
|
#18+
Каким storage manager' ом пользуетесь? 2006-02-14 11:11:35 8100 8099 Begin warm level 0 restore plandbs это запись из bar_act.log А что в журнале online.log ? ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
14.02.2006, 14:04
|
|||
|---|---|---|---|
Непонятки с On-Bar |
|||
|
#18+
Информации по железу маловато для оценки времени. Проследить идет ли восстановление можно через onstat -u (по последнему столбцу), сессия onbar-a должна записать примерно столько, сколько было забекаплено. Судя по тому, что IDS у вас 7.3, чанки размером не более 2Гб. Т.е. базка всегото 10Гб, 3 часа для восстановления такой БД может говорить о 3-х вещах: - железо дохлое (бекап и данные лежат на одном диске и дисковая система просто перегружена); - восстановление совсем не выполняется; - после восстановления архива идет накат логов, вот это может быть очень длительный процесс. Я человек древний, у меня ontape, поэтому как оно себя ведет в логах сказать не смогу. ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
14.02.2006, 14:15
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
Через onstat -D отлично мониторится что и куда и сколько уже. ----------------------------------------------------------- Решительный шаг вперед -- результат хорошего пинка сзади ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
14.02.2006, 16:12
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
авторКаким storage manager' ом пользуетесь? ism 2006-02-14 11:11:35 8100 8099 Begin warm level 0 restore plandbs авторэто запись из bar_act.log да авторА что в журнале online.log ? 11:11:35 WARNING! Chunk 12 is being taken OFFLINE for recovery 11:11:35 Physical restore of plandbs started И все. С тех пор никаких напоминаний об этом.... Все это творилось в статическом режиме IDS. Часа через 4 останавливал его и перезапускал. И Вот что дальше: 15:05:17 Informix Dynamic Server Stopped. 15:05:29 Segment locked: addr=0xa000000, size=1079631872 15:05:29 Segment locked: addr=0xa000000, size=1079631872 Tue Feb 14 15:05:29 2006 15:05:29 Event alarms enabled. ALARMPROG = '/informix/etc/log_full.sh' 15:05:35 DR: DRAUTO is 0 (Off) 15:05:35 Informix Dynamic Server Version 7.31.UD1 Software Serial Number AAD#J300440 15:05:41 Informix Dynamic Server Initialized -- Shared Memory Initialized. 15:05:41 Physical Recovery Started. 15:05:41 Physical Recovery Complete: 0 Pages Restored. 15:05:41 Logical Recovery Started. 15:05:45 Logical Recovery Complete. 0 Committed, 0 Rolled Back, 0 Open, 0 Bad Locks 15:05:46 Dataskip is now OFF for all dbspaces 15:05:46 On-Line Mode 15:05:46 Affinitied VP 1 to phys proc 0 15:05:46 Affinitied VP 4 to phys proc 2 15:05:46 Affinitied VP 3 to phys proc 1 15:05:46 Checkpoint Completed: duration was 0 seconds. 15:05:46 Checkpoint loguniq 13, logpos 0xd018 ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
14.02.2006, 20:22
|
|||
|---|---|---|---|
Непонятки с On-Bar |
|||
|
#18+
выставьте параметры BAR_DEBUG 9 BAR_DEBUG_LOG <имя файла лога> BAR_ACT_LOG <имя файла > попробуйте еще раз выполнить архивирование, окончание обоих логов запостите здесь. Почитайте http://seer.support.veritas.com/docs/256662.htm В таком вот аксепте ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
14.02.2006, 20:24
|
|||
|---|---|---|---|
Непонятки с On-Bar |
|||
|
#18+
Кстати, для отслеживания процесса архивирования полезна onstat -g arc В таком вот аксепте ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
15.02.2006, 08:25
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
Выбегалловыставьте параметры BAR_DEBUG 9 BAR_DEBUG_LOG <имя файла лога> BAR_ACT_LOG <имя файла > попробуйте еще раз выполнить архивирование, окончание обоих логов запостите здесь. Вот начало Debug: 2006-02-15 09:17:50 7614 7613 bar_get_hostname: enter 2006-02-15 09:17:50 7614 7613 bar_get_hostname: input new_svr dbserver 2006-02-15 09:17:50 7614 7613 bar_get_hostname: output hostname max 2006-02-15 09:17:50 7614 7613 bar_get_hostname: return 0 (0x00) 2006-02-15 09:17:50 7614 7613 read_config:server dbserver:0 max_backup 0 retry 1 actfd 3 2006-02-15 09:17:50 7614 7613 debugfd 5 debug 9 bootfd -1 log_blks 10000 2006-02-15 09:17:50 7614 7613 buf size 63488 buf count 10 ltapedev /home/informix/backup/log 2006-02-15 09:17:50 7614 7613 read_config: return 0 2006-02-15 09:17:50 7614 7613 bar_main: server status 1 2006-02-15 09:17:50 7614 7613 do_args: enter 3 2006-02-15 09:17:50 7614 7613 do_args: got -r command 2006-02-15 09:17:50 7614 7613 bar_add_dbslist: enter 2006-02-15 09:17:50 7614 7613 bar_add_dbslist: input dbs_name plandbs 2006-02-15 09:17:50 7614 7613 bar_add_dbslist: return 0 (0x00) 2006-02-15 09:17:50 7614 7613 Removing the onbar_restore file 2006-02-15 09:17:50 7614 7613 do_args: workflags b2 2006-02-15 09:17:50 7614 7613 do_args: return 0 2006-02-15 09:17:50 7614 7613 bar_siginit: enter 2006-02-15 09:17:50 7614 7613 bar_siginit: return Вот конец на текущий момент: 2006-02-15 09:57:20 7614 7613 0x00c30b82 0x0090 48303056 58074 58070 2006-02-15 09:57:20 7614 7613 0x00c30b83 0x0090 48303061 58075 58071 2006-02-15 09:57:20 7614 7613 0x00c30b84 0x0090 48303066 58076 58072 2006-02-15 09:57:20 7614 7613 0x00c30b85 0x0090 48303071 58077 58073 2006-02-15 09:57:20 7614 7613 0x00c30b86 0x0090 48303076 58078 58074 2006-02-15 09:57:20 7614 7613 0x00c30b87 0x0090 48303081 58079 58075 2006-02-15 09:57:20 7614 7613 0x00c30b88 0x0090 48303086 58080 58076 2006-02-15 09:57:20 7614 7613 0x00c30b89 0x0090 48303091 58081 58077 2006-02-15 09:57:20 7614 7613 0x00c30b8a 0x0090 48303096 58082 58078 2006-02-15 09:57:20 7614 7613 0x00c30b8b 0x0090 48303101 58083 58079 2006-02-15 09:57:20 7614 7613 0x00c30b8c 0x0090 48303106 58084 58080 2006-02-15 09:57:20 7614 7613 0x00c30b8d 0x0090 48303111 58085 58081 2006-02-15 09:57:20 7614 7613 0x00c30b8e 0x0090 48303116 58086 58082 2006-02-15 09:57:20 7614 7613 0x00c30b8f 0x0090 48303121 58087 58083 2006-02-15 09:57:20 7614 7613 0x00c30b90 0x0090 48303126 58088 58084 2006-02-15 09:57:20 7614 7613 do_phys_restore: calling bar_phys_write_restore(buf 0x803edcc, bufnbytes 63488, events, errtxt) 2006-02-15 09:57:20 7614 7613 bar_phys_write_restore: enter 2006-02-15 09:57:20 7614 7613 bar_phys_write_restore: input buf 0xae014400 bufnbytes 63488 2006-02-15 09:57:20 7614 7613 bar_phys_write_restore: output buf 0xae024400 events 0 errtxt 2006-02-15 09:57:20 7614 7613 bar_phys_write_restore: return 0 (0x00) 2006-02-15 09:57:20 7614 7613 barGetData: enter 2006-02-15 09:57:20 7614 7613 BSAGetData: enter То бишь процесс вроде идет, но почему столько времени!!!Судя по выводу onstat -D, наполнение тоже вроже идет. Вот кусок bar_act.log: 2006-02-15 00:20:06 2024 2018 Begin level 0 backup kausdbs. 2006-02-15 00:20:06 2024 2018 Successfully connected to Storage Manager. 2006-02-15 00:20:06 2023 2018 Completed level 0 backup defadbs. 2006-02-15 00:20:22 2023 2018 Process 2023 2018 completed. 2006-02-15 00:24:07 2024 2018 Completed level 0 backup kausdbs. ... 2006-02-15 09:17:50 7614 7613 /informix/bin/onbar_d -r plandbs 2006-02-15 09:17:50 7614 7613 Successfully connected to Storage Manager. 2006-02-15 09:17:51 7614 7613 Begin warm level 0 restore plandbs. И с тех пор ничего... Я здесь специально включил еще кусок (первые строчки), проиллюстрировать сколько времени выполняется бэкап базы kasudbs (plandbs - ee копия) ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
15.02.2006, 14:55
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
После прерванного onbar -r , состояние чанков по выводу команды onstat -d недовосстановленная dbspace имеет флаг NR, и ее чанки флаг PI- Как можно их восстановить в нормальное состояние, чтобы потом перезалить туда базу dbimport-ом? PS: Просьба ногами не пинать, я в информиксе без году неделя, а со сроками конкретно придавили - вынь и положь! ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
15.02.2006, 15:14
|
|||
|---|---|---|---|
Непонятки с On-Bar |
|||
|
#18+
Продолжить восстановление (у onbar такая возможность есть, но должна быть включенной) или провести восстановление заново. Если времени на это нет, то просто переинициализировать сервер (будут удалены все ДБ-пространства и заново создан rootdbs), создать необходимые пространства и залить БД dbimport-ом, если есть с чего... ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
15.02.2006, 15:18
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
mrbob...PS: Просьба ногами не пинать, я в информиксе без году неделя, а со сроками конкретно придавили - вынь и положь!В такой кампании не стоит работать. А придавили так наступи им на яйца -- напиши по собственному. ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
15.02.2006, 16:35
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
Журавлев Денис[В такой кампании не стоит работать. Не сыпь мне соль на раны :) Все чаще и чаще такие мысли посещают ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
15.02.2006, 19:17
|
|||
|---|---|---|---|
Непонятки с On-Bar |
|||
|
#18+
Похоже, storage manager медленно читает. С чего восстанавливаетесь ? В таком вот аксепте ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
16.02.2006, 09:45
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
ВыбегаллоПохоже, storage manager медленно читает. С чего восстанавливаетесь ? Бэкап настроен пока в файл, находящийся в системном разделе. Сами базы в чанках на дисковом массиве. Вот кусок onconfig: ------------------------ #BAR_DEBUG 9 #BAR_DEBUG_LOG /tmp/bar.log BAR_ACT_LOG /tmp/bar_act.log BAR_MAX_BACKUP 0 BAR_RETRY 1 BAR_NB_XPORT_COUNT 10 BAR_XFER_BUF_SIZE 31 # Informix Storage Manager variables ISM_DATA_POOL ISMDiskData ISM_LOG_POOL ISMDiskLogs OFF_RECVRY_THREADS 10 ON_RECVRY_THREADS 1 RESTARTABLE_RESTORE on ---------------------------- ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
16.02.2006, 20:44
|
|||
|---|---|---|---|
Непонятки с On-Bar |
|||
|
#18+
Из BAR_DEBUG_LOG файла интересует, в какой функции onbar проводит так много времени. Из приведенных кусков этого не видно. В таком вот аксепте ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
17.02.2006, 07:06
|
|||
|---|---|---|---|
|
|||
Непонятки с On-Bar |
|||
|
#18+
ВыбегаллоИз BAR_DEBUG_LOG файла интересует, в какой функции onbar проводит так много времени. Из приведенных кусков этого не видно. В таком вот аксепте 2006-02-15 09:17:51 7614 7613 do_phys_restore: calling bar_phys_write_restore(buf 0x803edcc, bufnbytes 63488, events, errtxt) 2006-02-15 09:17:51 7614 7613 bar_phys_write_restore: enter 2006-02-15 09:17:51 7614 7613 bar_phys_write_restore: input buf 0xadfe4400 bufnbytes 63488 2006-02-15 09:17:51 7614 7613 bar_phys_write_restore: output buf 0xadff4400 events 0 errtxt 2006-02-15 09:17:51 7614 7613 bar_phys_write_restore: return 0 (0x00) 2006-02-15 09:17:51 7614 7613 barGetData: enter 2006-02-15 09:17:51 7614 7613 BSAGetData: enter 2006-02-15 09:17:52 7614 7613 BSAGetData: output: bufferLen = 63488, numBytes = 63488 2006-02-15 09:17:52 7614 7613 BSAGetData: return 14 (0x0e) 2006-02-15 09:17:52 7614 7613 barGetData: output last_lap 2006-02-15 09:17:52 7614 7613 barGetData: return 0 (0x00) 2006-02-15 09:17:52 7614 7613 address flags stamp uniqid number 2006-02-15 09:17:52 7614 7613 0x00c0005e 0x00b0 46490565 0 0 2006-02-15 09:17:52 7614 7613 0x00c0005f 0x00b0 46490566 0 0 2006-02-15 09:17:52 7614 7613 0x00c00060 0x0001 46490564 0 0 Милисекунд здесь конечно не показывается, но время на 1 секунду всегда набавляется на этой операции - BSAGetData. Не на каждой этой операции, но получается, что всегда имено на ней. Вообще винован получается ISM? Может как-то перемонтировать каталоги для хранения архивов? На что тут обратить внимание? ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|
17.02.2006, 20:12
|
|||
|---|---|---|---|
Непонятки с On-Bar |
|||
|
#18+
Проверить, не крэшится ли диск помаленьку. проще всего - выполнив dd на сохраненные файлы, нормально ли (и быстро ли) читаются. Включить трассировку XBSA (BSAGetData, очевидно, реализована в этой библиотеке) и посмотреть, что пишет XBSA библиотека в лог ($INFORMIX/applogs/xbsa.messages ) Как включить трассировку : http://www-1.ibm.com/support/docview.wss?rs=865&context=SWB00&dc=DB510&dc=DB520&dc=D800&dc=D900&dc=DA900&dc=DA800&dc=DB530&dc=DA600&dc=D600&dc=D700&dc=DA500&dc=D200&dc=DA410&dc=DA450&dc=DA430&dc=DA440&dc=DB550&dc=D100&q1=%2bxbsa+%2btracing&uid=swg21223248&loc=en_US&cs=UTF-8&lang=all --------- STEPS 1. Login as user informix. 2. Set environment variable ISM_DEBUG_LEVEL to 9 for maximum tracing. 3. Set environment variable ISM_DEBUG_FILE to the full path name of the log file. 4. Run the onbar command. To disable tracing and return to the defaults, unset the environment variables ISM_DEBUG_LEVEL and ISM_DEBUG_FILE. On UNIX, the default XBSA messages log file for ISM is $INFORMIXDIR/ism/applogs/xbsa.messages. When ISM_DEBUG_LEVEL is not set, only XBSA failures are logged (equivalent to ISM_DEBUG_LEVEL 1). On Windows, ISM_DEBUG_LEVEL and ISM_DEBUG_FILE must be set to trace any XBSA communications between onbar and ISM. -------- Гугл находит похожую проблему http://groups.google.com/group/comp.databases.informix/browse_frm/thread/11996808039492ff/0dcb5e1e2518477b?lnk=st&q=BSAGetData+ism&rnum=1&hl=en#0dcb5e1e2518477b В крайнем случае, придется смотреть системные вызовы - какие функции вызываются и сколько в них проводится времени. Саппорта, конечно, нет ? В таком вот аксепте ... |
|||
|
:
Нравится:
Не нравится:
|
|||
|
|
|

start [/forum/topic.php?fid=44&mobile=1&tid=1608756]: |
0ms |
get settings: |
6ms |
get forum list: |
11ms |
check forum access: |
3ms |
check topic access: |
3ms |
track hit: |
41ms |
get topic data: |
9ms |
get forum data: |
2ms |
get page messages: |
36ms |
get tp. blocked users: |
1ms |
| others: | 210ms |
| total: | 322ms |

| 0 / 0 |
