Re: Fatal error in ADM VP at mt.c:12239
A user running IDS 9.40.FC2 (on AIX) posted an assertion failure: "Invalid Mutex Type" in mt.c, crashing the server, with the failing thread being btscanner 0 (the B-tree cleaner); the AF file showed a locked/waited pt_ mutex held by that thread. Paul Watson identified it as a known B-tree cleaner bug in FC2 and advised upgrading to FC3 or later (he had moved to FC5). The poster agreed to upgrade, then asked which part of the AF file pointed to the B-tree cleaner — that follow-up question got no answer in the thread.
Auto-generated by DrWatson from the posts below — may be imperfect; read the full thread.
09:31:35
09:31:35 IBM Informix Dynamic Server Version 9.40.FC2 SoftwareSerial Number AAA#B000000
09:31:35 Assert Failed: Invalid Mutex Type
09:31:35 Who: Session(18, informix@sjjz2, 0, 7000000904707e8)
Thread(44, btscanner 0, 700000090432168, 5)
File: mt.c Line: 7804
09:31:35 Stack for thread: 44 btscanner 0
base: 0x0700000091380000
len: 69632
pc: 0x000000010004f330
tos: 0x07000000913904b0
state: running
vp: 5
09:31:35 See Also: /tmp/af.414c057
---------------------------------
Begin System Alarm Program Output
---------------------------------
Assertion Failure Type: CRASH
Host Name: sjjz2
Database Server Name: jzonline
Time of failure: Thu Nov 18 09:31:36 CST 2004
AF file: /tmp/af.414c057
Shared memory file: None
System Blocking: OFF
===========------------- - - - - - -
tail -100 /home/informix/online.log:
timestamp: 1811258661.
06:45:58 Checkpoint loguniq 339, logpos 0x4d01160, timestamp:1811258661
06:45:58 Maximum server connections 9
06:49:24 Logical Log 339 Complete, timestamp:1812090977.
06:50:59 Fuzzy Checkpoint Completed: duration was 0 seconds, 3buffers not flushed,
timestamp: 1812477293.
06:50:59 Checkpoint loguniq 340, logpos 0x975154, timestamp:1812477293
06:50:59 Maximum server connections 9
06:56:00 Fuzzy Checkpoint Completed: duration was 0 seconds, 4buffers not flushed,
timestamp: 1813688049.
06:56:00 Checkpoint loguniq 340, logpos 0x26d5160, timestamp:1813688049
06:56:00 Maximum server connections 9
07:01:01 Fuzzy Checkpoint Completed: duration was 0 seconds, 5buffers not flushed,
timestamp: 1814967144.
07:01:01 Checkpoint loguniq 340, logpos 0x44df0dc, timestamp:1814967144
07:01:01 Maximum server connections 9
07:05:52 Logical Log 340 Complete, timestamp:1816147590.
07:06:01 Fuzzy Checkpoint Completed: duration was 0 seconds, 3buffers not flushed,
timestamp: 1816184906.
07:06:01 Checkpoint loguniq 341, logpos 0xf00c4, timestamp: 1816184906
07:06:01 Maximum server connections 9
07:11:02 Fuzzy Checkpoint Completed: duration was 0 seconds, 4buffers not flushed,
timestamp: 1817399550.
07:11:02 Checkpoint loguniq 341, logpos 0x1e83160, timestamp:1817399550
07:11:02 Maximum server connections 9
07:14:14 Logical Log 341 Complete, timestamp:1817693438.
07:16:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 5buffers not flushed,
timestamp: 1817844477.
07:16:03 Checkpoint loguniq 342, logpos 0x27bd0dc, timestamp:1817844477
07:16:03 Maximum server connections 9
07:18:25 Logical Log 342 Complete, timestamp:1818053868.
07:21:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 3buffers not flushed,
timestamp: 1818290110.
07:21:03 Checkpoint loguniq 343, logpos 0x4481064, timestamp:1818290110
07:21:03 Maximum server connections 9
07:22:11 Logical Log 343 Complete, timestamp:1818395539.
07:26:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 4buffers not flushed,
timestamp: 1818747167.
07:26:03 Checkpoint loguniq 344, logpos 0x5dfe070, timestamp:1818747167
07:26:03 Maximum server connections 9
07:26:14 Logical Log 344 Complete, timestamp:1818763348.
07:30:31 Logical Log 345 Complete, timestamp:1819160924.
07:31:05 Fuzzy Checkpoint Completed: duration was 0 seconds, 2buffers not flushed,
timestamp: 1819214018.
07:31:05 Checkpoint loguniq 346, logpos 0xf56058, timestamp:1819214018
07:31:05 Maximum server connections 9
07:36:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 2buffers not flushed,
timestamp: 1819295536.
07:36:04 Checkpoint loguniq 346, logpos 0x2b440b8, timestamp:1819295536
07:36:04 Maximum server connections 9
07:41:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1buffers not flushed,
timestamp: 1819295541.
07:41:04 Checkpoint loguniq 346, logpos 0x2b4504c, timestamp:1819295541
07:41:04 Maximum server connections 9
09:06:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1buffers not flushed,
timestamp: 1819303975.
09:06:04 Checkpoint loguniq 346, logpos 0x2b49820, timestamp:1819303975
09:06:04 Maximum server connections 9
09:11:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1buffers not flushed,
timestamp: 1819303980.
09:11:04 Checkpoint loguniq 346, logpos 0x2b4a04c, timestamp:1819303980
09:11:04 Maximum server connections 9
09:21:05 Fuzzy Checkpoint Completed: duration was 0 seconds, 1431buffers not flushed,
timestamp: 1819358690.
09:21:05 Checkpoint loguniq 346, logpos 0x319f920, timestamp:1819358690
09:21:05 Maximum server connections 9
09:24:04 Logical Log 346 Complete, timestamp:1819902632.
09:26:08 Fuzzy Checkpoint Completed: duration was 3 seconds, 11179buffers not flushed,
timestamp: 1820432774.
09:26:08 Checkpoint loguniq 347, logpos 0x2fd50d0, timestamp:1820432774
09:26:08 Maximum server connections 9
09:28:39 Logical Log 347 Complete, timestamp:1821013530.
09:31:12 Fuzzy Checkpoint Completed: duration was 4 seconds, 4523buffers not flushed,
timestamp: 1821838784.
09:31:12 Checkpoint loguniq 348, logpos 0x47275ec, timestamp:1821838784
09:31:12 Maximum server connections 9
09:31:35 Assert Failed: Invalid Mutex Type
09:31:35 IBM Informix Dynamic Server Version 9.40.FC2
09:31:35 Who: Session(18, informix@sjjz2, 0, 7000000904707e8)
Thread(44, btscanner 0, 700000090432168, 5)
File: mt.c Line: 7804
09:31:35 stack trace for pid 47054 written to /tmp/af.414c057
09:31:35 See Also: /tmp/af.414c057
===========------------- - - - - - -
/home/informix/bin/onstat -g ath:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:48 -- 2549264 Kbytes
Threads:tid tcb rstcb prty status
vp-class name
2 700000090db4a78 0 2 sleeping forever
7lio lio vp 0
3 700000090dec1f8 0 2 sleeping forever
8pio pio vp 0
4 700000090e0c1f8 0 2 sleeping forever
9aio aio vp 0
5 700000090e2c1f8 0 2 sleeping forever
10msc msc vp 0
6 700000090e641f8 0 2 sleeping forever
11aio aio vp 1
7 700000090e841f8 0 2 sleeping forever
12aio aio vp 2
8 700000090ea41f8 0 2 sleeping forever
13aio aio vp 3
9 700000090ec41f8 0 2 sleeping forever
14aio aio vp 4
10 700000090ee41f8 0 2 sleeping forever
15aio aio vp 5
11 700000090f041f8 0 2 sleeping forever
16aio aio vp 6
12 700000090f241f8 0 2 sleeping forever
17aio aio vp 7
13 700000090f441f8 0 2 sleeping forever
18aio aio vp 8
14 700000090f641f8 0 2 sleeping forever
19aio aio vp 9
15 700000090f841f8 0 2 sleeping forever
20aio aio vp 10
16 700000090f
09:31:35
09:31:35 IBM Informix Dynamic Server Version 9.40.FC2 SoftwareSerial Number AAA#B000000
09:31:35 Assert Failed: Invalid Mutex Type
09:31:35 Who: Session(18, informix@sjjz2, 0, 7000000904707e8)
Thread(44, btscanner 0, 700000090432168, 5)
File: mt.c Line: 7804
09:31:35 Stack for thread: 44 btscanner 0
base: 0x0700000091380000
len: 69632
pc: 0x000000010004f330
tos: 0x07000000913904b0
state: running
vp: 5
09:31:35 See Also: /tmp/af.414c057
---------------------------------
Begin System Alarm Program Output
---------------------------------
Assertion Failure Type: CRASH
Host Name: sjjz2
Database Server Name: jzonline
Time of failure: Thu Nov 18 09:31:36 CST 2004
AF file: /tmp/af.414c057
Shared memory file: None
System Blocking: OFF
===========------------- - - - - - -
tail -100 /home/informix/online.log:
timestamp: 1811258661.
06:45:58 Checkpoint loguniq 339, logpos 0x4d01160, timestamp:1811258661
06:45:58 Maximum server connections 9
06:49:24 Logical Log 339 Complete, timestamp:1812090977.
06:50:59 Fuzzy Checkpoint Completed: duration was 0 seconds, 3buffers not flushed,
timestamp: 1812477293.
06:50:59 Checkpoint loguniq 340, logpos 0x975154, timestamp:1812477293
06:50:59 Maximum server connections 9
06:56:00 Fuzzy Checkpoint Completed: duration was 0 seconds, 4buffers not flushed,
timestamp: 1813688049.
06:56:00 Checkpoint loguniq 340, logpos 0x26d5160, timestamp:1813688049
06:56:00 Maximum server connections 9
07:01:01 Fuzzy Checkpoint Completed: duration was 0 seconds, 5buffers not flushed,
timestamp: 1814967144.
07:01:01 Checkpoint loguniq 340, logpos 0x44df0dc, timestamp:1814967144
07:01:01 Maximum server connections 9
07:05:52 Logical Log 340 Complete, timestamp:1816147590.
07:06:01 Fuzzy Checkpoint Completed: duration was 0 seconds, 3buffers not flushed,
timestamp: 1816184906.
07:06:01 Checkpoint loguniq 341, logpos 0xf00c4, timestamp: 1816184906
07:06:01 Maximum server connections 9
07:11:02 Fuzzy Checkpoint Completed: duration was 0 seconds, 4buffers not flushed,
timestamp: 1817399550.
07:11:02 Checkpoint loguniq 341, logpos 0x1e83160, timestamp:1817399550
07:11:02 Maximum server connections 9
07:14:14 Logical Log 341 Complete, timestamp:1817693438.
07:16:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 5buffers not flushed,
timestamp: 1817844477.
07:16:03 Checkpoint loguniq 342, logpos 0x27bd0dc, timestamp:1817844477
07:16:03 Maximum server connections 9
07:18:25 Logical Log 342 Complete, timestamp:1818053868.
07:21:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 3buffers not flushed,
timestamp: 1818290110.
07:21:03 Checkpoint loguniq 343, logpos 0x4481064, timestamp:1818290110
07:21:03 Maximum server connections 9
07:22:11 Logical Log 343 Complete, timestamp:1818395539.
07:26:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 4buffers not flushed,
timestamp: 1818747167.
07:26:03 Checkpoint loguniq 344, logpos 0x5dfe070, timestamp:1818747167
07:26:03 Maximum server connections 9
07:26:14 Logical Log 344 Complete, timestamp:1818763348.
07:30:31 Logical Log 345 Complete, timestamp:1819160924.
07:31:05 Fuzzy Checkpoint Completed: duration was 0 seconds, 2buffers not flushed,
timestamp: 1819214018.
07:31:05 Checkpoint loguniq 346, logpos 0xf56058, timestamp:1819214018
07:31:05 Maximum server connections 9
07:36:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 2buffers not flushed,
timestamp: 1819295536.
07:36:04 Checkpoint loguniq 346, logpos 0x2b440b8, timestamp:1819295536
07:36:04 Maximum server connections 9
07:41:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1buffers not flushed,
timestamp: 1819295541.
07:41:04 Checkpoint loguniq 346, logpos 0x2b4504c, timestamp:1819295541
07:41:04 Maximum server connections 9
09:06:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1buffers not flushed,
timestamp: 1819303975.
09:06:04 Checkpoint loguniq 346, logpos 0x2b49820, timestamp:1819303975
09:06:04 Maximum server connections 9
09:11:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1buffers not flushed,
timestamp: 1819303980.
09:11:04 Checkpoint loguniq 346, logpos 0x2b4a04c, timestamp:1819303980
09:11:04 Maximum server connections 9
09:21:05 Fuzzy Checkpoint Completed: duration was 0 seconds, 1431buffers not flushed,
timestamp: 1819358690.
09:21:05 Checkpoint loguniq 346, logpos 0x319f920, timestamp:1819358690
09:21:05 Maximum server connections 9
09:24:04 Logical Log 346 Complete, timestamp:1819902632.
09:26:08 Fuzzy Checkpoint Completed: duration was 3 seconds, 11179buffers not flushed,
timestamp: 1820432774.
09:26:08 Checkpoint loguniq 347, logpos 0x2fd50d0, timestamp:1820432774
09:26:08 Maximum server connections 9
09:28:39 Logical Log 347 Complete, timestamp:1821013530.
09:31:12 Fuzzy Checkpoint Completed: duration was 4 seconds, 4523buffers not flushed,
timestamp: 1821838784.
09:31:12 Checkpoint loguniq 348, logpos 0x47275ec, timestamp:1821838784
09:31:12 Maximum server connections 9
09:31:35 Assert Failed: Invalid Mutex Type
09:31:35 IBM Informix Dynamic Server Version 9.40.FC2
09:31:35 Who: Session(18, informix@sjjz2, 0, 7000000904707e8)
Thread(44, btscanner 0, 700000090432168, 5)
File: mt.c Line: 7804
09:31:35 stack trace for pid 47054 written to /tmp/af.414c057
09:31:35 See Also: /tmp/af.414c057
===========------------- - - - - - -
/home/informix/bin/onstat -g ath:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:48 -- 2549264 Kbytes
Threads:tid tcb rstcb prty status
vp-class name
2 700000090db4a78 0 2 sleeping forever
7lio lio vp 0
3 700000090dec1f8 0 2 sleeping forever
8pio pio vp 0
4 700000090e0c1f8 0 2 sleeping forever
9aio aio vp 0
5 700000090e2c1f8 0 2 sleeping forever
10msc msc vp 0
6 700000090e641f8 0 2 sleeping forever
11aio aio vp 1
7 700000090e841f8 0 2 sleeping forever
12aio aio vp 2
8 700000090ea41f8 0 2 sleeping forever
13aio aio vp 3
9 700000090ec41f8 0 2 sleeping forever
14aio aio vp 4
10 700000090ee41f8 0 2 sleeping forever
15aio aio vp 5
11 700000090f041f8 0 2 sleeping forever
16aio aio vp 6
12 700000090f241f8 0 2 sleeping forever
17aio aio vp 7
13 700000090f441f8 0 2 sleeping forever
18aio aio vp 8
14 700000090f641f8 0 2 sleeping forever
19aio aio vp 9
15 700000090f841f8 0 2 sleeping forever
20aio aio vp 10
16 700000090f
Here is another part of the af file:
===========------------- - - - - - -
/home/informix/bin/onstat -F:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:49 -- 2549264 Kbytes
Fg Writes LRU Writes Chunk Writes
0 8396195 3092833
address flusher state data
70000009042d848 0 I 0 = 0X0
70000009042e068 1 I 0 = 0X0
70000009042e888 2 I 0 = 0X0
70000009042f0a8 3 I 0 = 0X0
70000009042f8c8 4 I 0 = 0X0
7000000904300e8 5 I 0 = 0X0
700000090430908 6 I 0 = 0X0
700000090431128 7 I 0 = 0X0
states: Exit Idle Chunk Lru
===========------------- - - - - - -
/home/informix/bin/onstat -R:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:49 -- 2549264 Kbytes
16 buffer LRU queue pairs priority levels
# f/m pair total % of length LOW HIGH
0 f 28125 96.1% 27027 8049 18978
1 m 3.9% 1098 133 965
2 f 28125 95.5% 26857 7946 18911
3 m 4.5% 1268 135 1133
4 f 28125 96.5% 27132 8119 19013
5 m 3.5% 993 114 879
6 f 28124 96.3% 27084 8139 18945
7 m 3.7% 1040 101 939
8 f 28126 96.7% 27189 8167 19022
9 m 3.3% 937 111 826
10 f 28125 96.6% 27155 8197 18958
11 m 3.4% 970 110 860
12 f 28123 96.6% 27156 8224 18932
13 m 3.4% 967 102 865
14 f 28127 96.5% 27131 8201 18930
15 m 3.5% 996 117 879
16 f 28125 96.4% 27126 8173 18953
17 m 3.6% 999 104 895
18 f 28123 96.1% 27038 8091 18947
19 m 3.9% 1085 112 973
20 f 28127 95.7% 26924 7975 18949
21 m 4.3% 1203 142 1061
22 f 28124 96.2% 27055 8090 18965
23 m 3.8% 1069 124 945
24 F 28126 96.0% 27003 8050 18953
25 m 4.0% 1123 109 1014
26 f 28125 96.3% 27094 8153 18941
27 m 3.7% 1031 139 892
28 f 28125 95.6% 26893 7968 18925
29 m 4.4% 1232 140 1092
30 f 28125 96.4% 27116 8156 18960
31 m 3.6% 1009 106 903
17020 dirty, 450000 queued, 450000 total, 524288 hash buckets, 4096
buffer size
start clean at 10.000% (of pair total) dirty, or 2813 buffs dirty,
stop at 5.000%
===========------------- - - - - - -
/home/informix/bin/onstat -g glo:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:49 -- 2549264 Kbytes
MT global info:
sessions threads vps lngspins
4 60 27 3119
sched calls thread switches yield 0 yield n yield
forever
total: 1754192759 1199269368 181925227 233335077 220026023
per sec: 0 0 0 0 0
Virtual processor summary:
class vps usercpu syscpu total
cpu 5 146645.90 37211.36 183857.26
aio 16 8.14 23.81 31.95
shm 2 1.35 3.36 4.71
lio 1 0.55 1.52 2.07
pio 1 0.53 1.57 2.10
adm 1 2.86 7.15 10.01
msc 1 0.32 0.14 0.46
total 27 146659.65 37248.91 183908.56
Individual virtual processors:
vp pid class usercpu syscpu total
1 67980 cpu 36983.46 16367.14 53350.60
2 33392 adm 2.86 7.15 10.01
3 46094 cpu 42330.58 7427.96 49758.54
4 5960 cpu 22690.61 5422.77 28113.38
5 47054 cpu 12280.98 3280.47 15561.45
6 45888 cpu 32360.27 4713.02 37073.29
7 45108 lio 0.55 1.52 2.07
8 38282 pio 0.53 1.57 2.10
9 44278 aio 0.74 1.55 2.29
10 34918 msc 0.32 0.14 0.46
11 34070 aio 0.52 1.41 1.93
12 27416 aio 0.54 1.43 1.97
13 54356 aio 0.42 1.48 1.90
14 37334 aio 0.47 1.64 2.11
15 49316 aio 0.48 1.46 1.94
16 52684 aio 0.46 1.53 1.99
17 57644 aio 0.54 1.49 2.03
18 52390 aio 0.50 1.42 1.92
19 53056 aio 0.46 1.56 2.02
20 43332 aio 0.51 1.58 2.09
22 35454 aio 0.53 1.38 1.91
21 53910 aio 0.49 1.62 2.11
24 53478 aio 0.63 1.43 2.06
25 31752 aio 0.41 1.41 1.82
23 34740 aio 0.44 1.42 1.86
26 35238 shm 0.87 1.81 2.68
27 33548 shm 0.48 1.55 2.03
tot 146659.65 37248.91 183908.56
===========------------- - - - - - -
/home/informix/bin/onstat -g qst:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:49 -- 2549264 Kbytes
Queue statistics not enabled
===========------------- - - - - - -
/home/informix/bin/onstat -g wst:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:49 -- 2549264 Kbytes
Wait statistics not enabled
===========------------- - - - - - -
/home/informix/bin/onstat -g lmx:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:49 -- 2549264 Kbytes
Locked mutexes:
mid addr name holder lkcnt waiter
waittime
1252224 700000091536028 pt_500c3a 44 0 212645368
1
Number of mutexes on VP free lists: 249
===========------------- - - - - - -
/home/informix/bin/onstat -g wmx:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:49 -- 2549264 Kbytes
Mutexes with waiters:
mid addr name holder lkcnt waiter
waittime
1252224 700000091536028 pt_500c3a 44 0 212645368
1
Number of mutexes on VP free lists: 249
===========------------- - - - - - -
/home/informix/bin/onstat -g con:
IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
days 20:14:49 -- 2549264 Kbytes
Conditions with waiters:
cid addr name waiter waittime
495 700000090ee4ce8 arrived
I've post the af file, please help me to find the source of problem. Thanks in advance.
Upgrade to FC3+ as FC2 has a bug with btree cleaner, or at least our
FC2/Solaris does
readme wrote:
>
> 09:31:35
> 09:31:35 IBM Informix Dynamic Server Version 9.40.FC2 Software> Serial Number AAA#B000000
>
> 09:31:35 Assert Failed: Invalid Mutex Type
> 09:31:35 Who: Session(18, informix@sjjz2, 0, 7000000904707e8)
> Thread(44, btscanner 0, 700000090432168, 5)
> File: mt.c Line: 7804
> 09:31:35 Stack for thread: 44 btscanner 0>
> base: 0x0700000091380000
> len: 69632
> pc: 0x000000010004f330
> tos: 0x07000000913904b0
> state: running
> vp: 5
>
> 09:31:35 See Also: /tmp/af.414c057>
> ---------------------------------
> Begin System Alarm Program Output
> ---------------------------------
>
> Assertion Failure Type: CRASH
> Host Name: sjjz2
> Database Server Name: jzonline
> Time of failure: Thu Nov 18 09:31:36 CST 2004
> AF file: /tmp/af.414c057
> Shared memory file: None
> System Blocking: OFF
>
> ===========------------- - - - - - -
> tail -100 /home/informix/online.log:
>
> timestamp: 1811258661.
> 06:45:58 Checkpoint loguniq 339, logpos 0x4d01160, timestamp:> 1811258661
>
> 06:45:58 Maximum server connections 9
> 06:49:24 Logical Log 339 Complete, timestamp:1812090977.
> 06:50:59 Fuzzy Checkpoint Completed: duration was 0 seconds, 3> buffers not flushed,
> timestamp: 1812477293.
> 06:50:59 Checkpoint loguniq 340, logpos 0x975154, timestamp:> 1812477293
>
> 06:50:59 Maximum server connections 9
> 06:56:00 Fuzzy Checkpoint Completed: duration was 0 seconds, 4> buffers not flushed,
> timestamp: 1813688049.
> 06:56:00 Checkpoint loguniq 340, logpos 0x26d5160, timestamp:> 1813688049
>
> 06:56:00 Maximum server connections 9
> 07:01:01 Fuzzy Checkpoint Completed: duration was 0 seconds, 5> buffers not flushed,
> timestamp: 1814967144.
> 07:01:01 Checkpoint loguniq 340, logpos 0x44df0dc, timestamp:> 1814967144
>
> 07:01:01 Maximum server connections 9
> 07:05:52 Logical Log 340 Complete, timestamp:1816147590.
> 07:06:01 Fuzzy Checkpoint Completed: duration was 0 seconds, 3> buffers not flushed,
> timestamp: 1816184906.
> 07:06:01 Checkpoint loguniq 341, logpos 0xf00c4, timestamp: 1816184906
>
> 07:06:01 Maximum server connections 9
> 07:11:02 Fuzzy Checkpoint Completed: duration was 0 seconds, 4> buffers not flushed,
> timestamp: 1817399550.
> 07:11:02 Checkpoint loguniq 341, logpos 0x1e83160, timestamp:> 1817399550
>
> 07:11:02 Maximum server connections 9
> 07:14:14 Logical Log 341 Complete, timestamp:1817693438.
> 07:16:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 5> buffers not flushed,
> timestamp: 1817844477.
> 07:16:03 Checkpoint loguniq 342, logpos 0x27bd0dc, timestamp:> 1817844477
>
> 07:16:03 Maximum server connections 9
> 07:18:25 Logical Log 342 Complete, timestamp:1818053868.
> 07:21:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 3> buffers not flushed,
> timestamp: 1818290110.
> 07:21:03 Checkpoint loguniq 343, logpos 0x4481064, timestamp:> 1818290110
>
> 07:21:03 Maximum server connections 9
> 07:22:11 Logical Log 343 Complete, timestamp:1818395539.
> 07:26:03 Fuzzy Checkpoint Completed: duration was 0 seconds, 4> buffers not flushed,
> timestamp: 1818747167.
> 07:26:03 Checkpoint loguniq 344, logpos 0x5dfe070, timestamp:> 1818747167
>
> 07:26:03 Maximum server connections 9
> 07:26:14 Logical Log 344 Complete, timestamp:1818763348.
> 07:30:31 Logical Log 345 Complete, timestamp:1819160924.
> 07:31:05 Fuzzy Checkpoint Completed: duration was 0 seconds, 2> buffers not flushed,
> timestamp: 1819214018.
> 07:31:05 Checkpoint loguniq 346, logpos 0xf56058, timestamp:> 1819214018
>
> 07:31:05 Maximum server connections 9
> 07:36:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 2> buffers not flushed,
> timestamp: 1819295536.
> 07:36:04 Checkpoint loguniq 346, logpos 0x2b440b8, timestamp:> 1819295536
>
> 07:36:04 Maximum server connections 9
> 07:41:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1> buffers not flushed,
> timestamp: 1819295541.
> 07:41:04 Checkpoint loguniq 346, logpos 0x2b4504c, timestamp:> 1819295541
>
> 07:41:04 Maximum server connections 9
> 09:06:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1> buffers not flushed,
> timestamp: 1819303975.
> 09:06:04 Checkpoint loguniq 346, logpos 0x2b49820, timestamp:> 1819303975
>
> 09:06:04 Maximum server connections 9
> 09:11:04 Fuzzy Checkpoint Completed: duration was 0 seconds, 1> buffers not flushed,
> timestamp: 1819303980.
> 09:11:04 Checkpoint loguniq 346, logpos 0x2b4a04c, timestamp:> 1819303980
>
> 09:11:04 Maximum server connections 9
> 09:21:05 Fuzzy Checkpoint Completed: duration was 0 seconds, 1431> buffers not flushed,
> timestamp: 1819358690.
> 09:21:05 Checkpoint loguniq 346, logpos 0x319f920, timestamp:> 1819358690
>
> 09:21:05 Maximum server connections 9
> 09:24:04 Logical Log 346 Complete, timestamp:1819902632.
> 09:26:08 Fuzzy Checkpoint Completed: duration was 3 seconds, 11179> buffers not flushed,
> timestamp: 1820432774.
> 09:26:08 Checkpoint loguniq 347, logpos 0x2fd50d0, timestamp:> 1820432774
>
> 09:26:08 Maximum server connections 9
> 09:28:39 Logical Log 347 Complete, timestamp:1821013530.
> 09:31:12 Fuzzy Checkpoint Completed: duration was 4 seconds, 4523> buffers not flushed,
> timestamp: 1821838784.
> 09:31:12 Checkpoint loguniq 348, logpos 0x47275ec, timestamp:> 1821838784
>
> 09:31:12 Maximum server connections 9
> 09:31:35 Assert Failed: Invalid Mutex Type
> 09:31:35 IBM Informix Dynamic Server Version 9.40.FC2
> 09:31:35 Who: Session(18, informix@sjjz2, 0, 7000000904707e8)
> Thread(44, btscanner 0, 700000090432168, 5)
> File: mt.c Line: 7804
> 09:31:35 stack trace for pid 47054 written to /tmp/af.414c057
> 09:31:35 See Also: /tmp/af.414c057>
> ===========------------- - - - - - -
> /home/informix/bin/onstat -g ath:
>
> IBM Informix Dynamic Server Version 9.40.FC2 -- On-Line -- Up 1
> days 20:14:48 -- 2549264 Kbytes
>
> Threads:> tid tcb rstcb prty status
> vp-class name
> 2 700000090db4a78 0 2 sleeping forever
> 7lio lio vp 0
> 3 700000090dec1f8 0 2 sleeping forever
> 8pio pio vp 0
> 4 700000090e0c1f8 0 2 sleeping forever
> 9aio aio vp 0
> 5 700000090e2c1f8 0 2 sleeping forever
> 10msc msc vp 0
> 6 700000090e641f8 0 2 sleeping forever
> 11aio aio vp 1
> 7 700000090e841f8 0 2 sleeping forever
> 12aio aio vp 2
> 8 700000090ea41f8 0 2 sleeping forever
> 13aio aio vp 3
> 9 700000090ec41f8 0 2 sleeping forever
> 14aio aio vp 4
> 10 700000090ee41f8 0 2 sleeping foreve
On Sat, 20 Nov 2004 10:21:38 +0000, Paul Watson <paul@oninit.com> wrote: >Upgrade to FC3+ as FC2 has a bug with btree cleaner, or at least our >FC2/Solaris does > Verified fixed in FC3+, then . . .? JWC
Yes, bit I think I moved to FC5 John Carlson wrote: > > On Sat, 20 Nov 2004 10:21:38 +0000, Paul Watson <paul@oninit.com> > wrote: > > >Upgrade to FC3+ as FC2 has a bug with btree cleaner, or at least our > >FC2/Solaris does > > > > Verified fixed in FC3+, then . . .? > > JWC -- Paul Watson # Oninit Ltd # Growing old is mandatory Tel: +44 1436 672201 # Growing up is optional Fax: +44 1436 678693 # Mob: +44 7818 003457 # www.oninit.com #
I'll Upgrade, I appreciate everyone here verymuch.
Which part of the af file shows that problem is caused by the bugs of B-tree cleaner?
Related threads
- Posting from the Informix-list
- Migrating from IDS 9.40.UC6 to 11.50.UC3
- Ip for a network session
- questions onstat -g