一、事件信息8月15日上午9点左右,车间客户端有人发现在IDS连接不上找到IT人员,IT人员通过windows远程桌面以administrator身份登录,
以启动windows服务方式启动实例。(之前是以informix身份在dos窗口中oninit前台启动运行的)。发现DB_LOCALE为en_US.819
客户端连接异常,然后支持人员电话指导下。修改ol_dbserver01.cmd环境变量其中三项为(PS:建库时DB_LOCALE为en_US.819
无法处理生僻字。需要改以下三项。见
如何正确设置 Informix GLS 及 CSDK 语言环境)
set CLIENT_LOCALE=zh_cn.GB
set DB_LOCALE=zh_cn.GB
set IFMX_UNDOC_B168163=1
停止服务后,手工在dos窗口正常前台启动实例。各客户端可用,从ol_dbserver01.log可看出此时informix在做快速恢复一直持续到了10点。
10点时IT人员突然想起以前老服务器出问题时要重启OS。便立即重启OS并再次以administrator用户登录并前台启动实例。
正常使用至今天。问题是15日1点-9点的员工打卡记录全部丢失,16日HR部门统计考勤时才发现后问责IT人员。
二、问题需求如何确认15日发现什么问题。客户IT人员几次启动导致IDS后台发生了什么(前台没看到报错)
如何找回15日的数据。可否回滚到15日8:50.如何操作。
操作前应该如何备份保证数据完整性。
三、IDS实例相关信息0、人事考勤系统主要记录员工上班打卡。每个车间一台PC客户端。通过PB开发的客户端直接写数据库。
1、运行平台VMware vSphere5.0、操作系统windows2003—64bit IDS 11.7 64bit。
2、实例名ol_dbserver01 环境变量如下:
set INFORMIXDIR=D:Informix
set INFORMIXSERVER=ol_dbserver01
set ONCONFIG=ONCONFIG.ol_dbserver01
set PATH=D:Informixbin;%PATH%
set CLASSPATH=%INFORMIXDIR%extendkrakatoakrakatoa.jar;%INFORMIXDIR%extendkrakatoajdbc.jar;%CLASSPATH%
set DBTEMP=D:Informixinfxtmp
set CLIENT_LOCALE=zh_cn.GB
set DB_LOCALE=zh_cn.GB
set IFMX_UNDOC_B168163=1
mode con codepage select=1252
3.IDS日志及onconfig见附件!截取部分如下
Wed Aug 15 01:00:08 2012
01:00:08 Checkpoint Completed: duration was 7 seconds.
01:00:08 Wed Aug 15 - loguniq 9, logpos 0x9ee4018, timestamp: 0xcb4bb8e Interval: 168
01:00:08 Maximum server connections 92
01:00:08 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 27486, Llog used 2313
01:00:10 Level 1 Archive started on rootdbs, blobdbs, plogdbs, llogdbs, bimsdbs, datadbs
01:03:58 Archive on rootdbs, blobdbs, plogdbs, llogdbs, bimsdbs, datadbs Completed.
08:17:06 listener-thread: err = -951: oserr = 0: errstr = [email]self@192.9.198.138[/email]: Incorrect password or user [email]self@192.9.198.138[/email] is not known on the database server.
08:57:22 Dynamically allocated new virtual shared memory segment (size 8192KB)
08:57:23 Memory sizes:resident:3145728 KB, virtual:6562304 KB, no SHMTOTAL limit
08:57:25 Dynamically allocated new virtual shared memory segment (size 8192KB)
08:57:25 Memory sizes:resident:3145728 KB, virtual:6570496 KB, no SHMTOTAL limit
08:57:28 Dynamically allocated new virtual shared memory segment (size 8192KB)
08:57:28 Memory sizes:resident:3145728 KB, virtual:6578688 KB, no SHMTOTAL limit
08:57:31 Dynamically allocated new virtual shared memory segment (size 8192KB)
08:57:31 Memory sizes:resident:3145728 KB, virtual:6586880 KB, no SHMTOTAL limit
08:57:34 Dynamically allocated new virtual shared memory segment (size 8192KB)
08:57:34 Memory sizes:resident:3145728 KB, virtual:6595072 KB, no SHMTOTAL limit
08:57:38 Dynamically allocated new virtual shared memory segment (size 8192KB)
08:57:38 Memory sizes:resident:3145728 KB, virtual:6603264 KB, no SHMTOTAL limit
08:57:41 Dynamically allocated new virtual shared memory segment (size 8192KB)
08:57:41 Memory sizes:resident:3145728 KB, virtual:6611456 KB, no SHMTOTAL limit
09:05:39 IBM Informix Dynamic Server Started.
09:05:40 Segment locked: addr=0000000080000000, size=3221225472
09:05:41 Segment locked: addr=0000000141460000, size=3221225472
09:05:41 Requested shared memory segment size rounded from 2278924KB to 2278976KB
09:05:41 Dynamically allocated new virtual shared memory segment (size 2278976KB)
09:05:41 Memory sizes:resident:3145728 KB, virtual:5424704 KB, no SHMTOTAL limit
09:05:41 Requested shared memory segment size rounded from 326560KB to 326592KB
09:05:41 Dynamically allocated new virtual shared memory segment (size 326592KB)
09:05:41 Memory sizes:resident:3145728 KB, virtual:5751296 KB, no SHMTOTAL limit
Wed Aug 15 09:05:42 2012
09:05:42 Booting Language
from module <>
09:05:42 Loading Module
09:05:42 Booting Language from module <>
09:05:43 Loading Module
09:05:49 DR: DRAUTO is 0 (Off)
09:05:49 DR: ENCRYPT_HDR is 0 (HDR encryption Disabled)
09:05:49 IBM Informix Dynamic Server Version 11.70.FC5 Software Serial Number AAA#B000000
09:05:49 (5) connection rejected - no calls allowed for sqlexec
09:05:49 (6) connection rejected - no calls allowed for sqlexec
09:05:49 (7) connection rejected - no calls allowed for sqlexec
09:05:49 (8) connection rejected - no calls allowed for sqlexec
09:05:49 (9) connection rejected - no calls allowed for sqlexec
09:05:50 Performance Advisory: The physical log size is smaller than the recommended size for a
server configured with RTO_SERVER_RESTART.
09:05:50 Results: Fast recovery performance might not be optimal.
09:05:50 Action: For best fast recovery performance when RTO_SERVER_RESTART is enabled,
increase the physical log size to at least 8800000 KB. For servers
configured with a large buffer pool, this might not be necessary.
09:05:50 IBM Informix Dynamic Server Initialized -- Shared Memory Initialized.
09:05:50 Started 1 B-tree scanners.
09:05:50 B-tree scanner threshold set at 5000.
09:05:50 B-tree scanner range scan size set to -1.
09:05:50 B-tree scanner ALICE mode set to 6.
09:05:50 B-tree scanner index compression level set to med.
09:05:50 Physical Recovery Started at Page (2:2083).
09:05:51 Physical Recovery Complete: 13515 Pages Examined, 13515 Pages Restored.
09:05:51 Logical Recovery Started.
09:05:51 10 recovery worker threads will be started.
09:05:52 Logical Recovery has reached the transaction cleanup phase.
09:05:52 Logical Recovery Complete.
159 Committed, 0 Rolled Back, 0 Open, 0 Bad Locks
09:05:53 Dataskip is now OFF for all dbspaces
09:05:53 Init operation complete - Mode Online
09:05:56 SCHAPI: Started dbScheduler thread.
09:05:57 Booting Language from module <>
09:05:57 Loading Module
09:05:57 Auto Registration is synced
09:05:57 SCHAPI: Started 2 dbWorker threads.
09:05:58 Defragmenter cleaner thread now running
09:05:58 Defragmenter cleaner thread cleaned:0 partitions
09:05:58 Checkpoint Completed: duration was 5 seconds.
09:05:58 Wed Aug 15 - loguniq 9, logpos 0x9f8f0c0, timestamp: 0xcbf072a Interval: 169
09:05:58 Maximum server connections 2
09:05:58 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 13572, Llog used 5
09:05:58 On-Line Mode
09:07:13 SCHAPI: thread dbWorker1 task mon_config_startup(3-24) shutting down
09:07:13 SCHAPI: thread dbWorker2 task mon_sysenv(4-24) shutting down
09:07:14 SCHAPI: thread dbScheduler(56) shutting down
09:07:17 Shutdown Mode
09:07:17 listener-thread: err = -27002: oserr = 0: errstr = : No connections are allowed in quiescent mode.
09:07:18 Quiescent Mode
09:07:18 Checkpoint Completed: duration was 0 seconds.
09:07:18 Wed Aug 15 - loguniq 9, logpos 0x9faa018, timestamp: 0xcbf1668 Interval: 170
09:07:18 Maximum server connections 18
09:07:18 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 26, Llog used 27
09:05:57 IBM Informix Dynamic Server Started.
09:05:58 Segment locked: addr=0000000080000000, size=3221225472
09:05:59 Segment locked: addr=0000000141460000, size=3221225472
09:05:59 Requested shared memory segment size rounded from 2278924KB to 2278976KB
09:06:00 Dynamically allocated new virtual shared memory segment (size 2278976KB)
09:06:00 Memory sizes:resident:3145728 KB, virtual:5424704 KB, no SHMTOTAL limit
09:06:00 Requested shared memory segment size rounded from 326560KB to 326592KB
09:06:00 Dynamically allocated new virtual shared memory segment (size 326592KB)
09:06:00 Memory sizes:resident:3145728 KB, virtual:5751296 KB, no SHMTOTAL limit
Wed Aug 15 09:06:01 2012
09:06:01 Booting Language from module <>
09:06:01 Loading Module
09:06:01 Booting Language from module <>
09:06:01 Loading Module
09:06:07 DR: DRAUTO is 0 (Off)
09:06:07 DR: ENCRYPT_HDR is 0 (HDR encryption Disabled)
09:06:07 IBM Informix Dynamic Server Version 11.70.FC5 Software Serial Number AAA#B000000
09:06:08 (5) connection rejected - no calls allowed for sqlexec
09:06:08 Performance Advisory: The physical log size is smaller than the recommended size for a
server configured with RTO_SERVER_RESTART.
09:06:08 Results: Fast recovery performance might not be optimal.
09:06:08 Action: For best fast recovery performance when RTO_SERVER_RESTART is enabled,
increase the physical log size to at least 8800000 KB. For servers
configured with a large buffer pool, this might not be necessary.
09:06:08 IBM Informix Dynamic Server Initialized -- Shared Memory Initialized.
09:06:08 Started 1 B-tree scanners.
09:06:08 B-tree scanner threshold set at 5000.
09:06:08 B-tree scanner range scan size set to -1.
09:06:08 B-tree scanner ALICE mode set to 6.
09:06:08 B-tree scanner index compression level set to med.
09:06:08 Physical Recovery Started at Page (2:15681).
09:06:09 Physical Recovery Complete: 5 Pages Examined, 5 Pages Restored.
09:06:09 Logical Recovery Started.
09:06:09 10 recovery worker threads will be started.
09:06:09 Logical Recovery has reached the transaction cleanup phase.
09:06:09 Logical Recovery Complete.
0 Committed, 0 Rolled Back, 0 Open, 0 Bad Locks
09:06:10 Dataskip is now OFF for all dbspaces
09:06:10 Init operation complete - Mode Online
09:06:11 Checkpoint Completed: duration was 0 seconds.
09:06:11 Wed Aug 15 - loguniq 9, logpos 0x9fac0c0, timestamp: 0xcbf1681 Interval: 171
09:06:11 Maximum server connections 0
09:06:11 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 10, Llog used 1
09:06:11 On-Line Mode
09:06:13 SCHAPI: Started dbScheduler thread.
09:06:15 Booting Language from module <>
09:06:15 Loading Module
09:06:15 Auto Registration is synced
09:06:15 SCHAPI: Started 2 dbWorker threads.
09:06:15 Defragmenter cleaner thread now running
09:06:15 Defragmenter cleaner thread cleaned:0 partitions
09:06:19 Checkpoint Completed: duration was 0 seconds.
09:06:19 Wed Aug 15 - loguniq 9, logpos 0x9fb2018, timestamp: 0xcbf1748 Interval: 172
09:06:19 Maximum server connections 4
09:06:19 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 10, Llog used 6
09:06:24 Checkpoint Completed: duration was 0 seconds.
09:06:24 Wed Aug 15 - loguniq 9, logpos 0x9fb4018, timestamp: 0xcbf176a Interval: 173
09:06:24 Maximum server connections 5
09:06:24 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 6, Llog used 2
09:06:34 Checkpoint Completed: duration was 0 seconds.
09:06:34 Wed Aug 15 - loguniq 9, logpos 0x9fb6018, timestamp: 0xcbf1782 Interval: 174
09:06:34 Maximum server connections 5
09:06:34 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 3, Llog used 2
09:06:39 Checkpoint Completed: duration was 0 seconds.
09:06:39 Wed Aug 15 - loguniq 9, logpos 0x9fb8018, timestamp: 0xcbf1855 Interval: 175
09:06:39 Maximum server connections 7
09:06:39 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 0, Llog used 2
09:06:40 Checkpoint Completed: duration was 0 seconds.
09:06:40 Wed Aug 15 - loguniq 9, logpos 0x9fba018, timestamp: 0xcbf18c1 Interval: 176
09:06:40 Maximum server connections 7
09:06:40 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1, Plog used 0, Llog used 2
09:06:41 Checkpoint Completed: duration was 0 seconds.
09:06:41 Wed Aug 15 - loguniq 9, logpos 0x9fbc018, timestamp: 0xcbf1937 Interval: 177
09:06:41 Maximum server connections 7
09:06:41 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1, Plog used 0, Llog used 2
09:06:42 Checkpoint Completed: duration was 0 seconds.
09:06:42 Wed Aug 15 - loguniq 9, logpos 0x9fbe018, timestamp: 0xcbf19a5 Interval: 178
09:06:42 Maximum server connections 7
09:06:42 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1, Plog used 0, Llog used 2
09:06:43 Checkpoint Completed: duration was 0 seconds.
09:06:43 Wed Aug 15 - loguniq 9, logpos 0x9fc0018, timestamp: 0xcbf19fc Interval: 179
09:06:43 Maximum server connections 7
09:06:43 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1, Plog used 0, Llog used 2
09:06:44 Checkpoint Completed: duration was 0 seconds.
09:06:44 Wed Aug 15 - loguniq 9, logpos 0x9fc2018, timestamp: 0xcbf1a09 Interval: 180
09:06:44 Maximum server connections 7
09:06:44 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 1, Plog used 0, Llog used 2
09:06:45 Checkpoint Completed: duration was 0 seconds.
09:06:45 Wed Aug 15 - loguniq 9, logpos 0x9fc4018, timestamp: 0xcbf1a14 Interval: 181
。。。。。。。。。。。。。。。。。。。。。。。。
。。。。。。。。。。。省略N行。。。。。。。。。
。。。。。。。。。。。。。。。。。。。。。。。
09:59:50 Checkpoint Completed: duration was 0 seconds.
09:59:50 Wed Aug 15 - loguniq 9, logpos 0xa812018, timestamp: 0xcc5223c Interval: 816
09:59:50 Maximum server connections 50
09:59:50 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 11, Llog used 2
09:59:55 Checkpoint Completed: duration was 0 seconds.
09:59:55 Wed Aug 15 - loguniq 9, logpos 0xa814018, timestamp: 0xcc52256 Interval: 817
09:59:55 Maximum server connections 50
09:59:55 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 4, Llog used 2
10:00:00 Checkpoint Completed: duration was 0 seconds.
10:00:00 Wed Aug 15 - loguniq 9, logpos 0xa816018, timestamp: 0xcc52277 Interval: 818
10:00:00 Maximum server connections 50
10:00:00 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 0, Llog used 2
10:00:15 Checkpoint Completed: duration was 0 seconds.
10:00:15 Wed Aug 15 - loguniq 9, logpos 0xa818018, timestamp: 0xcc522ad Interval: 819
10:00:15 Maximum server connections 50
10:00:15 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 9, Llog used 2
10:00:20 Checkpoint Completed: duration was 0 seconds.
10:00:20 Wed Aug 15 - loguniq 9, logpos 0xa81a018, timestamp: 0xcc522c2 Interval: 820
10:00:20 Maximum server connections 50
10:00:20 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 5, Llog used 2
10:00:25 SCHAPI: thread dbWorker1 task Low Memory Reconfig(34-260) shutting down
10:00:25 SCHAPI: thread dbWorker2 task mon_page_usage(42-8) shutting down
10:00:25 Checkpoint Completed: duration was 0 seconds.
10:00:25 Wed Aug 15 - loguniq 9, logpos 0xa81c018, timestamp: 0xcc522e3 Interval: 821
10:00:25 Maximum server connections 50
10:00:25 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 0, Llog used 2
10:00:26 SCHAPI: thread dbScheduler(53) shutting down
10:00:28 Shutdown Mode
10:00:29 listener-thread: err = -27002: oserr = 0: errstr = : No connections are allowed in quiescent mode.
10:00:29 Quiescent Mode
10:00:29 Checkpoint Completed: duration was 0 seconds.
10:00:29 Wed Aug 15 - loguniq 9, logpos 0xa81e018, timestamp: 0xcc5230d Interval: 822
10:00:29 Maximum server connections 50
10:00:29 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 0, Llog used 2
10:00:30 IBM Informix Dynamic Server Stopped.
10:02:46 IBM Informix Dynamic Server Started.
10:02:47 Segment locked: addr=0000000080000000, size=3221225472
10:02:48 Segment locked: addr=0000000141460000, size=3221225472
10:02:48 Requested shared memory segment size rounded from 2278924KB to 2278976KB
10:02:48 Dynamically allocated new virtual shared memory segment (size 2278976KB)
10:02:48 Memory sizes:resident:3145728 KB, virtual:5424704 KB, no SHMTOTAL limit
10:02:48 Requested shared memory segment size rounded from 326560KB to 326592KB
10:02:48 Dynamically allocated new virtual shared memory segment (size 326592KB)
10:02:48 Memory sizes:resident:3145728 KB, virtual:5751296 KB, no SHMTOTAL limit
Wed Aug 15 10:02:49 2012
10:02:49 Booting Language from module <>
10:02:49 Loading Module
10:02:49 Booting Language from module <>
10:02:49 Loading Module
10:02:55 DR: DRAUTO is 0 (Off)
10:02:55 DR: ENCRYPT_HDR is 0 (HDR encryption Disabled)
10:02:55 IBM Informix Dynamic Server Version 11.70.FC5 Software Serial Number AAA#B000000
10:02:56 Performance Advisory: The physical log size is smaller than the recommended size for a
server configured with RTO_SERVER_RESTART.
10:02:56 Results: Fast recovery performance might not be optimal.
10:02:56 Action: For best fast recovery performance when RTO_SERVER_RESTART is enabled,
increase the physical log size to at least 8800000 KB. For servers
configured with a large buffer pool, this might not be necessary.
10:02:56 IBM Informix Dynamic Server Initialized -- Shared Memory Initialized.
10:02:56 Started 1 B-tree scanners.
10:02:56 B-tree scanner threshold set at 5000.
10:02:56 B-tree scanner range scan size set to -1.
10:02:56 B-tree scanner ALICE mode set to 6.
10:02:56 B-tree scanner index compression level set to med.
10:02:57 Physical Recovery Started at Page (2:31770).
10:02:57 Physical Recovery Complete: 0 Pages Examined, 0 Pages Restored.
10:02:57 Logical Recovery Started.
10:02:57 10 recovery worker threads will be started.
10:02:57 Logical Recovery has reached the transaction cleanup phase.
10:02:57 Logical Recovery Complete.
0 Committed, 0 Rolled Back, 0 Open, 0 Bad Locks
10:02:58 Dataskip is now OFF for all dbspaces
10:02:58 Init operation complete - Mode Online
10:02:58 Checkpoint Completed: duration was 0 seconds.
10:02:58 Wed Aug 15 - loguniq 9, logpos 0xa8200c0, timestamp: 0xcc52330 Interval: 823
10:02:58 Maximum server connections 0
10:02:58 Checkpoint Statistics - Avg. Txn Block Time 0.000, # Txns blocked 0, Plog used 4, Llog used 1
10:02:58 On-Line Mode
10:03:01 SCHAPI: Started dbScheduler thread.
10:03:02 Booting Language from module <>
10:03:02 Loading Module
10:03:02 Auto Registration is synced
10:03:02 SCHAPI: Started 2 dbWorker threads.
10:03:03 Defragmenter cleaner thread now running
10:03:03 Defragmenter cleaner thread cleaned:0 partitions
11:21:23 listener-thread: err = -951: oserr = 0: errstr = [email]informix@192.9.159.172[/email][xzx]: Incorrect password or user [email]informix@192.9.159.172[/email][xzx] is not known on the database server.附件:
ol_dbserver01.log (354.09 KB)
ol_dbserver01.cmd (383 Bytes)
ONCONFIG.ol_dbserver01 (70.22 KB)
收起