Problems with Informix on NT - Please Help
Posted in 1999
Topics: Backup & Restore, Storage & Space Management, Error Codes & Troubleshooting, Server Administration, Logging & Checkpoints
Hello
We are working with Informix TC5 on a Compaq machine with Windows NT 4.0
(Service Pack 3 applied).
On July 6 we had a problem with the database server. The database
suddenly stopped, and there was no reason for that. No problems with NT
(as far as we could see), and no exceptions running on the machine, just
the usual jobs. The database server seemed to be freezed, even the
checkpoints stopped, and there was no messages being written to the log.
30 minutes later, the database became offline, with many error messages.
Could somebody help me with these messages ??? I've never seem them
before, I don't know what happened... It seemed that the database have
lost the configuration file...
I'm sending my onconfig file too, I hope that somebody knows what does
this mean...
Thanks in advance
--
Paulo Roberto Marelli de Amorim
TS&0 Consulting
Brasil
MESSAGE LOG FILE
================
08:00:49 Checkpoint Completed: duration was 0 seconds.
08:05:02 Logical Log 637 Complete.
08:06:36 Logical Log 636 - Backup Started
08:06:38 Logical Log 636 - Backup Completed
08:06:38 Logical Log 637 - Backup Started
08:06:38 Logical Log 637 - Backup Completed
08:11:01 Checkpoint Completed: duration was 0 seconds.
08:21:01 Checkpoint Completed: duration was 0 seconds.
08:31:01 Checkpoint Completed: duration was 0 seconds.
08:41:01 Checkpoint Completed: duration was 0 seconds.
08:51:01 Checkpoint Completed: duration was 0 seconds.
09:01:01 Checkpoint Completed: duration was 0 seconds.
09:11:01 Checkpoint Completed: duration was 0 seconds.
09:21:01 Checkpoint Completed: duration was 0 seconds.
09:31:01 Checkpoint Completed: duration was 0 seconds.
09:41:01 Checkpoint Completed: duration was 0 seconds.
09:51:01 Checkpoint Completed: duration was 0 seconds.
10:01:01 Checkpoint Completed: duration was 1 seconds.
10:11:01 Checkpoint Completed: duration was 0 seconds.
10:21:01 Checkpoint Completed: duration was 0 seconds.
10:31:01 Checkpoint Completed: duration was 1 seconds.
10:41:31 Checkpoint Completed: duration was 0 seconds.
10:51:31 Checkpoint Completed: duration was 0 seconds.
11:01:31 Checkpoint Completed: duration was 0 seconds.
11:11:31 Checkpoint Completed: duration was 0 seconds.
11:21:31 Checkpoint Completed: duration was 0 seconds.
11:31:31 Checkpoint Completed: duration was 0 seconds.
11:41:31 Checkpoint Completed: duration was 0 seconds.
11:51:31 Checkpoint Completed: duration was 0 seconds.
12:01:31 Checkpoint Completed: duration was 0 seconds.
12:11:31 Checkpoint Completed: duration was 0 seconds.
12:21:31 Checkpoint Completed: duration was 0 seconds.
12:31:31 Checkpoint Completed: duration was 0 seconds.
12:41:31 Checkpoint Completed: duration was 0 seconds.
12:51:31 Checkpoint Completed: duration was 0 seconds.
13:01:30 Checkpoint Completed: duration was 0 seconds.
13:11:31 Checkpoint Completed: duration was 1 seconds.
13:22:01 Checkpoint Completed: duration was 0 seconds.
13:32:01 Checkpoint Completed: duration was 0 seconds.
13:42:01 Checkpoint Completed: duration was 0 seconds.
13:52:01 Checkpoint Completed: duration was 0 seconds.
14:02:01 Checkpoint Completed: duration was 1 seconds.
14:12:30 Checkpoint Completed: duration was 0 seconds.
14:22:31 Checkpoint Completed: duration was 1 seconds.
14:27:44 Logical Log 638 Complete.
14:27:45 Logical Log 638 - Backup Started
14:27:47 Logical Log 638 - Backup Completed
14:33:02 Checkpoint Completed: duration was 2 seconds.
14:43:03 Checkpoint Completed: duration was 1 seconds.
14:53:04 Checkpoint Completed: duration was 1 seconds.
15:03:05 Checkpoint Completed: duration was 0 seconds.
15:13:05 Checkpoint Completed: duration was 0 seconds.
15:23:05 Checkpoint Completed: duration was 1 seconds.
15:33:33 Checkpoint Completed: duration was 0 seconds.
15:44:01 Checkpoint Completed: duration was 0 seconds.
15:54:01 Checkpoint Completed: duration was 0 seconds.
16:04:01 Checkpoint Completed: duration was 1 seconds.
16:14:31 Checkpoint Completed: duration was 1 seconds.
16:24:31 Checkpoint Completed: duration was 0 seconds.
16:34:31 Checkpoint Completed: duration was 1 seconds.
Tue Jul 06 17:07:27 1999
17:07:27 DR: DRAUTO is 0 (Off)
17:07:37 Informix Dynamic Server Version 7.30.TC5 Software SerialNumber AAC#J525093
17:07:37 WARNING! Physical Log size 0 is too small. Physical Log overflows may occur during peak activity.
Recommended minimum Physical Log size is 20 times maximum
concurrent user threads.
17:07:37 WARNING! Logical log layout may cause Dynamic Server to getinto
a locked state. Recommended smallest logical log size
is 2 times maximum concurrent user threads.
17:07:38 I/O bad request chunk 4095, pagenum 1048575, pagecnt 1
17:07:38 Assert Failed: No Exception Handler
17:07:38 Informix Dynamic Server Version 7.30.TC5
17:07:38 Who: Session(6, informix@la04vcp.vcp.com.br, 181, 0)
Thread(15, ontape, 0, 1)
Exception at Addr: 0x589476, TOS: 0x149ddac4,
FP:0x149ddb24, Exc: c0000005
17:07:38 Results: Exception Caught. Type: MT EX OS, Context: mem
17:07:38 Action: Please notify Informix Technical Support.
17:07:38 Informix Dynamic Server Initialized -- Shared MemoryInitialized.
17:07:38 Warning: Invalid dbspace ':tempdbs' listed in DBSPACETEMP.
17:07:38 Physical Recovery Started.
17:07:38 Physical Recovery Complete: 101 Pages Restored.
17:07:38 Logical Recovery Started.
17:07:41 (7) connection rejected - no calls allowed for sqlexec
17:07:41 listener-thread: err = -27002: oserr = 0: errstr = : Noconnections are allowed in Dynamic Server quiescent mode.
17:07:41 (11) connection rejected - no calls allowed for sqlexec
17:07:41 listener-thread: err = -27002: oserr = 0: errstr = : Noconnections are allowed in Dynamic Server quiescent mode.
17:07:43 (12) connection rejected - no calls allowed for sqlexec
17:07:43 listener-thread: err = -27002: oserr = 0: errstr = : Noconnections are allowed in Dynamic Server quiescent mode.
17:07:46 (13) connection rejected - no calls allowed for sqlexec
17:07:46 listener-thread: err = -27002: oserr = 0: errstr = : Noconnections are allowed in Dynamic Server quiescent mode.
17:07:54 (14) connection rejected - no calls allowed for sqlexec
17:07:54 listener-thread: err = -27002: oserr = 0: errstr = : Noconnections are allowed in Dynamic Server quiescent mode.
17:07:56 See Also: af.f6209
17:07:56 \
You had a disk error on the 6th at 17:07:38 which may or may not have
been corrected and your ONCONFIG file has ONDBSPACEDOWN=2 which means
pause all operations and wait for the chunk to be repaired and marked
back online. Does onstat -d show any chunks and/or dbspaces with a 'D'
in the flags column? You must repair or replace that chunk then run
onspaces -O to mark the chunk back online. Then the engine willcontinue normally. If you do not want this behavior change the value
of ONDBSPACEDOWN to 1 (crash) or 0 (continue) for the next restart.
Art S. Kagel
Paulo Amorim wrote:
>
> Hello
>
> We are working with Informix TC5 on a Compaq machine with Windows NT 4.0
> (Service Pack 3 applied).
>
> On July 6 we had a problem with the database server. The database
> suddenly stopped, and there was no reason for that. No problems with NT
> (as far as we could see), and no exceptions running on the machine, just
> the usual jobs. The database server seemed to be freezed, even the
> checkpoints stopped, and there was no messages being written to the log.
> 30 minutes later, the database became offline, with many error messages.
>
> Could somebody help me with these messages ??? I've never seem them
> before, I don't know what happened... It seemed that the database have
> lost the configuration file...
>
> I'm sending my onconfig file too, I hope that somebody knows what does
> this mean...
>
> Thanks in advance
>
> --
> Paulo Roberto Marelli de Amorim
> TS&0 Consulting
> Brasil
>
> MESSAGE LOG FILE
> ================
> 08:00:49 Checkpoint Completed: duration was 0 seconds.
> 08:05:02 Logical Log 637 Complete.
> 08:06:36 Logical Log 636 - Backup Started
> 08:06:38 Logical Log 636 - Backup Completed
> 08:06:38 Logical Log 637 - Backup Started
> 08:06:38 Logical Log 637 - Backup Completed
> 08:11:01 Checkpoint Completed: duration was 0 seconds.
> 08:21:01 Checkpoint Completed: duration was 0 seconds.
> 08:31:01 Checkpoint Completed: duration was 0 seconds.
> 08:41:01 Checkpoint Completed: duration was 0 seconds.
> 08:51:01 Checkpoint Completed: duration was 0 seconds.
> 09:01:01 Checkpoint Completed: duration was 0 seconds.
> 09:11:01 Checkpoint Completed: duration was 0 seconds.
> 09:21:01 Checkpoint Completed: duration was 0 seconds.
> 09:31:01 Checkpoint Completed: duration was 0 seconds.
> 09:41:01 Checkpoint Completed: duration was 0 seconds.
> 09:51:01 Checkpoint Completed: duration was 0 seconds.
> 10:01:01 Checkpoint Completed: duration was 1 seconds.
> 10:11:01 Checkpoint Completed: duration was 0 seconds.
> 10:21:01 Checkpoint Completed: duration was 0 seconds.
> 10:31:01 Checkpoint Completed: duration was 1 seconds.
> 10:41:31 Checkpoint Completed: duration was 0 seconds.
> 10:51:31 Checkpoint Completed: duration was 0 seconds.
> 11:01:31 Checkpoint Completed: duration was 0 seconds.
> 11:11:31 Checkpoint Completed: duration was 0 seconds.
> 11:21:31 Checkpoint Completed: duration was 0 seconds.
> 11:31:31 Checkpoint Completed: duration was 0 seconds.
> 11:41:31 Checkpoint Completed: duration was 0 seconds.
> 11:51:31 Checkpoint Completed: duration was 0 seconds.
> 12:01:31 Checkpoint Completed: duration was 0 seconds.
> 12:11:31 Checkpoint Completed: duration was 0 seconds.
> 12:21:31 Checkpoint Completed: duration was 0 seconds.
> 12:31:31 Checkpoint Completed: duration was 0 seconds.
> 12:41:31 Checkpoint Completed: duration was 0 seconds.
> 12:51:31 Checkpoint Completed: duration was 0 seconds.
> 13:01:30 Checkpoint Completed: duration was 0 seconds.
> 13:11:31 Checkpoint Completed: duration was 1 seconds.
> 13:22:01 Checkpoint Completed: duration was 0 seconds.
> 13:32:01 Checkpoint Completed: duration was 0 seconds.
> 13:42:01 Checkpoint Completed: duration was 0 seconds.
> 13:52:01 Checkpoint Completed: duration was 0 seconds.
> 14:02:01 Checkpoint Completed: duration was 1 seconds.
> 14:12:30 Checkpoint Completed: duration was 0 seconds.
> 14:22:31 Checkpoint Completed: duration was 1 seconds.
> 14:27:44 Logical Log 638 Complete.
> 14:27:45 Logical Log 638 - Backup Started
> 14:27:47 Logical Log 638 - Backup Completed
> 14:33:02 Checkpoint Completed: duration was 2 seconds.
> 14:43:03 Checkpoint Completed: duration was 1 seconds.
> 14:53:04 Checkpoint Completed: duration was 1 seconds.
> 15:03:05 Checkpoint Completed: duration was 0 seconds.
> 15:13:05 Checkpoint Completed: duration was 0 seconds.
> 15:23:05 Checkpoint Completed: duration was 1 seconds.
> 15:33:33 Checkpoint Completed: duration was 0 seconds.
> 15:44:01 Checkpoint Completed: duration was 0 seconds.
> 15:54:01 Checkpoint Completed: duration was 0 seconds.
> 16:04:01 Checkpoint Completed: duration was 1 seconds.
> 16:14:31 Checkpoint Completed: duration was 1 seconds.
> 16:24:31 Checkpoint Completed: duration was 0 seconds.
> 16:34:31 Checkpoint Completed: duration was 1 seconds.>
> Tue Jul 06 17:07:27 1999
>
> 17:07:27 DR: DRAUTO is 0 (Off)
> 17:07:37 Informix Dynamic Server Version 7.30.TC5 Software Serial> Number AAC#J525093
> 17:07:37 WARNING! Physical Log size 0 is too small.> Physical Log overflows may occur during peak activity.
> Recommended minimum Physical Log size is 20 times maximum
> concurrent user threads.
>
> 17:07:37 WARNING! Logical log layout may cause Dynamic Server to get> into
> a locked state. Recommended smallest logical log size
> is 2 times maximum concurrent user threads.
>
> 17:07:38 I/O bad request chunk 4095, pagenum 1048575, pagecnt 1
> 17:07:38 Assert Failed: No Exception Handler
> 17:07:38 Informix Dynamic Server Version 7.30.TC5
> 17:07:38 Who: Session(6, informix@la04vcp.vcp.com.br, 181, 0)
> Thread(15, ontape, 0, 1)
> Exception at Addr: 0x589476, TOS: 0x149ddac4,
> FP:0x149ddb24, Exc: c0000005
> 17:07:38 Results: Exception Caught. Type: MT EX OS, Context: mem
> 17:07:38 Action: Please notify Informix Technical Support.
> 17:07:38 Informix Dynamic Server Initialized -- Shared Memory> Initialized.
> 17:07:38 Warning: Invalid dbspace ':tempdbs' listed in DBSPACETEMP.
> 17:07:38 Physical Recovery Started.
> 17:07:38 Physical Recovery Complete: 101 Pages Restored.
> 17:07:38 Logical Recovery Started.
> 17:07:41 (7) connection rejected - no calls allowed for sqlexec
> 17:07:41 listener-thread: err = -27002: oserr = 0: errstr = : No> connections are allowed in Dynamic Server quiescent mode.
>
> 17:07:41 (11) connection rejected - no calls allowed for sqlexec
> 17:07:41 listener-thread: err = -27002: oserr = 0: errstr = : No> connections are allowed in Dynamic Server quiescent mode.
>
> 17:07:43 (12) connection rejected - no calls allowed for sqlexec
> 17:07:43 listener-thread: err = -27002: oserr = 0: errstr = : No> connections are allowed in Dynamic Server quiescent mode.
>
> 17:07:46 (13) connection rejected - no calls allowed for sqlexec
> 17:07:46 listener-thread: err = -27002: oserr = 0: errstr = : No> connections are allowed in Dynamic Server quiescent mode.
>
> 17:07:54 (14) connecti