110616 14:19:54 [Note] Plugin 'FEDERATED' is disabled.
110616 14:19:55 InnoDB: The InnoDB memory heap is disabled
110616 14:19:55 InnoDB: Mutexes and rw_locks use Windows interlocked functions
110616 14:19:55 InnoDB: Compressed tables use zlib 1.2.3
110616 14:19:55 InnoDB: Initializing buffer pool, size = 686.0M
110616 14:19:55 InnoDB: Completed initialization of buffer pool
110616 14:19:55 InnoDB: highest supported file format is Barracuda.
110616 14:19:55  InnoDB: Waiting for the background threads to start
110616 14:19:56 InnoDB: 1.1.7 started; log sequence number 26444271711
110616 14:19:57 [Note] Event Scheduler: Loaded 0 events
110616 14:19:57 [Note] C:\Program Files\MySQL\MySQL Server 5.5\bin\mysqld: ready for connections.
Version: '5.5.13'  socket: ''  port: 3306  MySQL Community Server (GPL)
InnoDB: Warning: a long semaphore wait:
--Thread 2640 has waited at trx0undo.ic line 156 for 241.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
InnoDB: Pending preads 0, pwrites 0

=====================================
110617 10:04:15 INNODB MONITOR OUTPUT
=====================================
Per second averages calculated from the last 56 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 51190 1_second, 51190 sleeps, 4729 10_second, 3920 background, 3920 flush
srv_master_thread log flush and writes: 51254
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 8614, signal count 8630
--Thread 2640 has waited at trx0undo.ic line 156 for 248.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
--Thread 3960 has waited at row0ins.c line 2002 for 147.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 0000000017D62F40 created in file buf0buf.c line 898
a writer (thread id 3960) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file ..\..\..\mysql-5.5.13\storage\innobase\btr\btr0sea.c line 903
Mutex spin waits 2419, rounds 20470, OS waits 248
RW-shared spins 8256, rounds 246485, OS waits 8170
RW-excl spins 167, rounds 5653, OS waits 157
Spin rounds per wait: 8.46 mutex, 29.86 RW-shared, 33.85 RW-excl
------------
TRANSACTIONS
------------
Trx id counter D3A593
Purge done for trx's n:o < D2F9FF undo n:o < 0
History list length 300
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION D3A58B, not started
MySQL thread id 15207, query id 495281 localhost 127.0.0.1 root
---TRANSACTION D3A592, ACTIVE 147 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15208, query id 495293 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('466', '678',  NOW(), 18)
---TRANSACTION D3A58A, ACTIVE 248 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15206, query id 495259 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('620', '4', 20110617100105, '165')
--------
FILE I/O
--------
I/O thread 0 state: wait Windows aio (insert buffer thread)
I/O thread 1 state: wait Windows aio (log thread)
I/O thread 2 state: wait Windows aio (read thread)
I/O thread 3 state: wait Windows aio (read thread)
I/O thread 4 state: wait Windows aio (read thread)
I/O thread 5 state: wait Windows aio (read thread)
I/O thread 6 state: wait Windows aio (write thread)
I/O thread 7 state: wait Windows aio (write thread)
I/O thread 8 state: wait Windows aio (write thread)
I/O thread 9 state: wait Windows aio (write thread)
Pending normal aio reads: 0 [0, 0, 0, 0] , aio writes: 1 [0, 0, 1, 0] ,
 ibuf aio reads: 0, log i/o's: 0, sync i/o's: 0
Pending flushes (fsync) log: 0; buffer pool: 0
182945 OS file reads, 308793 OS file writes, 115782 OS fsyncs
0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
-------------------------------------
INSERT BUFFER AND ADAPTIVE HASH INDEX
-------------------------------------
Ibuf: size 1, free list len 29, seg size 31, 310 merges
merged operations:
 insert 785, delete mark 1, delete 0
discarded operations:
 insert 0, delete mark 0, delete 0
Hash table size 1423691, node heap has 2 buffer(s)
0.00 hash searches/s, 0.00 non-hash searches/s
---
LOG
---
Log sequence number 26461897682
Log flushed up to   26461897682
Last checkpoint at  26461672973
0 pending log writes, 0 pending chkp writes
106082 log i/o's done, 0.00 log i/o's/second
----------------------
BUFFER POOL AND MEMORY
----------------------
Total memory allocated 736182272; in additional pool allocated 0
Dictionary memory allocated 89110
Buffer pool size   43904
Free buffers       0
Database pages     43902
Old database pages 16186
Modified db pages  254
Pending reads 0
Pending writes: LRU 0, flush list 48, single page 0
Pages made young 132455, not young 0
0.00 youngs/s, 0.00 non-youngs/s
Pages read 182929, created 554, written 196801
0.00 reads/s, 0.00 creates/s, 0.00 writes/s
No buffer pool page gets since the last printout
Pages read ahead 0.00/s, evicted without access 0.00/s
LRU len: 43902, unzip_LRU len: 0
I/O sum[0]:cur[0], unzip sum[0]:cur[0]
--------------
ROW OPERATIONS
--------------
2 queries inside InnoDB, 0 queries in queue
1 read views open inside InnoDB
Main thread id 2480, state: flushing buffer pool pages
Number of rows inserted 101241, updated 10, deleted 0, read 134034889
0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
----------------------------
END OF INNODB MONITOR OUTPUT
============================

=====================================
110617 10:04:35 INNODB MONITOR OUTPUT
=====================================
Per second averages calculated from the last 20 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 51190 1_second, 51190 sleeps, 4729 10_second, 3920 background, 3920 flush
srv_master_thread log flush and writes: 51254
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 8614, signal count 8630
--Thread 2640 has waited at trx0undo.ic line 156 for 268.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
--Thread 3960 has waited at row0ins.c line 2002 for 167.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 0000000017D62F40 created in file buf0buf.c line 898
a writer (thread id 3960) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file ..\..\..\mysql-5.5.13\storage\innobase\btr\btr0sea.c line 903
Mutex spin waits 2419, rounds 20470, OS waits 248
RW-shared spins 8256, rounds 246485, OS waits 8170
RW-excl spins 167, rounds 5653, OS waits 157
Spin rounds per wait: 8.46 mutex, 29.86 RW-shared, 33.85 RW-excl
------------
TRANSACTIONS
------------
Trx id counter D3A593
Purge done for trx's n:o < D2F9FF undo n:o < 0
History list length 300
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION D3A58B, not started
MySQL thread id 15207, query id 495281 localhost 127.0.0.1 root
---TRANSACTION D3A592, ACTIVE 167 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15208, query id 495293 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('466', '678',  NOW(), 18)
---TRANSACTION D3A58A, ACTIVE 268 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15206, query id 495259 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('620', '4', 20110617100105, '165')
--------
FILE I/O
--------
I/O thread 0 state: wait Windows aio (insert buffer thread)
I/O thread 1 state: wait Windows aio (log thread)
I/O thread 2 state: wait Windows aio (read thread)
I/O thread 3 state: wait Windows aio (read thread)
I/O thread 4 state: wait Windows aio (read thread)
I/O thread 5 state: wait Windows aio (read thread)
I/O thread 6 state: wait Windows aio (write thread)
I/O thread 7 state: wait Windows aio (write thread)
I/O thread 8 state: wait Windows aio (write thread)
I/O thread 9 state: wait Windows aio (write thread)
Pending normal aio reads: 0 [0, 0, 0, 0] , aio writes: 1 [0, 0, 1, 0] ,
 ibuf aio reads: 0, log i/o's: 0, sync i/o's: 0
Pending flushes (fsync) log: 0; buffer pool: 0
182945 OS file reads, 308793 OS file writes, 115782 OS fsyncs
0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
-------------------------------------
INSERT BUFFER AND ADAPTIVE HASH INDEX
-------------------------------------
Ibuf: size 1, free list len 29, seg size 31, 310 merges
merged operations:
 insert 785, delete mark 1, delete 0
discarded operations:
 insert 0, delete mark 0, delete 0
Hash table size 1423691, node heap has 2 buffer(s)
0.00 hash searches/s, 0.00 non-hash searches/s
---
LOG
---
Log sequence number 26461897682
Log flushed up to   26461897682
Last checkpoint at  26461672973
0 pending log writes, 0 pending chkp writes
106082 log i/o's done, 0.00 log i/o's/second
----------------------
BUFFER POOL AND MEMORY
----------------------
Total memory allocated 736182272; in additional pool allocated 0
Dictionary memory allocated 89110
Buffer pool size   43904
Free buffers       0
Database pages     43902
Old database pages 16186
Modified db pages  254
Pending reads 0
Pending writes: LRU 0, flush list 48, single page 0
Pages made young 132455, not young 0
0.00 youngs/s, 0.00 non-youngs/s
Pages read 182929, created 554, written 196801
0.00 reads/s, 0.00 creates/s, 0.00 writes/s
No buffer pool page gets since the last printout
Pages read ahead 0.00/s, evicted without access 0.00/s
LRU len: 43902, unzip_LRU len: 0
I/O sum[0]:cur[0], unzip sum[0]:cur[0]
--------------
ROW OPERATIONS
--------------
2 queries inside InnoDB, 0 queries in queue
1 read views open inside InnoDB
Main thread id 2480, state: flushing buffer pool pages
Number of rows inserted 101241, updated 10, deleted 0, read 134034889
0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
----------------------------
END OF INNODB MONITOR OUTPUT
============================
InnoDB: ###### Diagnostic info printed to the standard error stream
InnoDB: Warning: a long semaphore wait:
--Thread 2640 has waited at trx0undo.ic line 156 for 272.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
InnoDB: Pending preads 0, pwrites 0

=====================================
110617 10:04:51 INNODB MONITOR OUTPUT
=====================================
Per second averages calculated from the last 16 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 51190 1_second, 51190 sleeps, 4729 10_second, 3920 background, 3920 flush
srv_master_thread log flush and writes: 51254
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 8614, signal count 8630
--Thread 2640 has waited at trx0undo.ic line 156 for 284.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
--Thread 3960 has waited at row0ins.c line 2002 for 183.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 0000000017D62F40 created in file buf0buf.c line 898
a writer (thread id 3960) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file ..\..\..\mysql-5.5.13\storage\innobase\btr\btr0sea.c line 903
Mutex spin waits 2419, rounds 20470, OS waits 248
RW-shared spins 8256, rounds 246485, OS waits 8170
RW-excl spins 167, rounds 5653, OS waits 157
Spin rounds per wait: 8.46 mutex, 29.86 RW-shared, 33.85 RW-excl
------------
TRANSACTIONS
------------
Trx id counter D3A593
Purge done for trx's n:o < D2F9FF undo n:o < 0
History list length 300
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION D3A58B, not started
MySQL thread id 15207, query id 495281 localhost 127.0.0.1 root
---TRANSACTION D3A592, ACTIVE 183 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15208, query id 495293 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('466', '678',  NOW(), 18)
---TRANSACTION D3A58A, ACTIVE 284 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15206, query id 495259 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('620', '4', 20110617100105, '165')
--------
FILE I/O
--------
I/O thread 0 state: wait Windows aio (insert buffer thread)
I/O thread 1 state: wait Windows aio (log thread)
I/O thread 2 state: wait Windows aio (read thread)
I/O thread 3 state: wait Windows aio (read thread)
I/O thread 4 state: wait Windows aio (read thread)
I/O thread 5 state: wait Windows aio (read thread)
I/O thread 6 state: wait Windows aio (write thread)
I/O thread 7 state: wait Windows aio (write thread)
I/O thread 8 state: wait Windows aio (write thread)
I/O thread 9 state: wait Windows aio (write thread)
Pending normal aio reads: 0 [0, 0, 0, 0] , aio writes: 1 [0, 0, 1, 0] ,
 ibuf aio reads: 0, log i/o's: 0, sync i/o's: 0
Pending flushes (fsync) log: 0; buffer pool: 0
182945 OS file reads, 308793 OS file writes, 115782 OS fsyncs
0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
-------------------------------------
INSERT BUFFER AND ADAPTIVE HASH INDEX
-------------------------------------
Ibuf: size 1, free list len 29, seg size 31, 310 merges
merged operations:
 insert 785, delete mark 1, delete 0
discarded operations:
 insert 0, delete mark 0, delete 0
Hash table size 1423691, node heap has 2 buffer(s)
0.00 hash searches/s, 0.00 non-hash searches/s
---
LOG
---
Log sequence number 26461897682
Log flushed up to   26461897682
Last checkpoint at  26461672973
0 pending log writes, 0 pending chkp writes
106082 log i/o's done, 0.00 log i/o's/second
----------------------
BUFFER POOL AND MEMORY
----------------------
Total memory allocated 736182272; in additional pool allocated 0
Dictionary memory allocated 89110
Buffer pool size   43904
Free buffers       0
Database pages     43902
Old database pages 16186
Modified db pages  254
Pending reads 0
Pending writes: LRU 0, flush list 48, single page 0
Pages made young 132455, not young 0
0.00 youngs/s, 0.00 non-youngs/s
Pages read 182929, created 554, written 196801
0.00 reads/s, 0.00 creates/s, 0.00 writes/s
No buffer pool page gets since the last printout
Pages read ahead 0.00/s, evicted without access 0.00/s
LRU len: 43902, unzip_LRU len: 0
I/O sum[0]:cur[0], unzip sum[0]:cur[0]
--------------
ROW OPERATIONS
--------------
2 queries inside InnoDB, 0 queries in queue
1 read views open inside InnoDB
Main thread id 2480, state: flushing buffer pool pages
Number of rows inserted 101241, updated 10, deleted 0, read 134034889
0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
----------------------------
END OF INNODB MONITOR OUTPUT
============================
InnoDB: ###### Diagnostic info printed to the standard error stream
InnoDB: Warning: a long semaphore wait:
--Thread 2640 has waited at trx0undo.ic line 156 for 303.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
InnoDB: Pending preads 0, pwrites 0

=====================================
110617 10:05:11 INNODB MONITOR OUTPUT
=====================================
Per second averages calculated from the last 20 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 51190 1_second, 51190 sleeps, 4729 10_second, 3920 background, 3920 flush
srv_master_thread log flush and writes: 51254
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 8614, signal count 8630
--Thread 2640 has waited at trx0undo.ic line 156 for 304.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
0
--Thread 2640 has waited at trx0undo.ic line 156 for 304.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
--Thread 3960 has waited at row0ins.c line 2002 for 203.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 0000000017D62F40 created in file buf0buf.c line 898
a writer (thread id 3960) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file ..\..\..\mysql-5.5.13\storage\innobase\btr\btr0sea.c line 903
Mutex spin waits 2419, rounds 20470, OS waits 248
RW-shared spins 8256, rounds 246485, OS waits 8170
RW-excl spins 167, rounds 5653, OS waits 157
Spin rounds per wait: 8.46 mutex, 29.86 RW-shared, 33.85 RW-excl
------------
TRANSACTIONS
------------
Trx id counter D3A593
Purge done for trx's n:o < D2F9FF undo n:o < 0
History list length 300
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION D3A58B, not started
MySQL thread id 15207, query id 495281 localhost 127.0.0.1 root
---TRANSACTION D3A592, ACTIVE 203 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15208, query id 495293 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('466', '678',  NOW(), 18)
---TRANSACTION D3A58A, ACTIVE 304 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15206, query id 495259 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('620', '4', 20110617100105, '165')
--------
FILE I/O
--------
I/O thread 0 state: wait Windows aio (insert buffer thread)
I/O thread 1 state: wait Windows aio (log thread)
I/O thread 2 state: wait Windows aio (read thread)
I/O thread 3 state: wait Windows aio (read thread)
I/O thread 4 state: wait Windows aio (read thread)
I/O thread 5 state: wait Windows aio (read thread)
I/O thread 6 state: wait Windows aio (write thread)
I/O thread 7 state: wait Windows aio (write thread)
I/O thread 8 state: wait Windows aio (write thread)
I/O thread 9 state: wait Windows aio (write thread)
Pending normal aio reads: 0 [0, 0, 0, 0] , aio writes: 1 [0, 0, 1, 0] ,
 ibuf aio reads: 0, log i/o's: 0, sync i/o's: 0
Pending flushes (fsync) log: 0; buffer pool: 0
182945 OS file reads, 308793 OS file writes, 115782 OS fsyncs
0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
-------------------------------------
INSERT BUFFER AND ADAPTIVE HASH INDEX
-------------------------------------
Ibuf: size 1, free list len 29, seg size 31, 310 merges
merged operations:
 insert 785, delete mark 1, delete 0
discarded operations:
 insert 0, delete mark 0, delete 0
Hash table size 1423691, node heap has 2 buffer(s)
0.00 hash searches/s, 0.00 non-hash searches/s
---
LOG
---
Log sequence number 26461897682
Log flushed up to   26461897682
Last checkpoint at  26461672973
0 pending log writes, 0 pending chkp writes
106082 log i/o's done, 0.00 log i/o's/second
----------------------
BUFFER POOL AND MEMORY
----------------------
Total memory allocated 736182272; in additional pool allocated 0
Dictionary memory allocated 89110
Buffer pool size   43904
Free buffers       0
Database pages     43902
Old database pages 16186
Modified db pages  254
Pending reads 0
Pending writes: LRU 0, flush list 48, single page 0
Pages made young 132455, not young 0
0.00 youngs/s, 0.00 non-youngs/s
Pages read 182929, created 554, written 196801
0.00 reads/s, 0.00 creates/s, 0.00 writes/s
No buffer pool page gets since the last printout
Pages read ahead 0.00/s, evicted without access 0.00/s
LRU len: 43902, unzip_LRU len: 0
I/O sum[0]:cur[0], unzip sum[0]:cur[0]
--------------
ROW OPERATIONS
--------------
2 queries inside InnoDB, 0 queries in queue
1 read views open inside InnoDB
Main thread id 2480, state: flushing buffer pool pages
Number of rows inserted 101241, updated 10, deleted 0, read 134034889
0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
----------------------------
END OF INNODB MONITOR OUTPUT
============================

=====================================
110617 10:05:31 INNODB MONITOR OUTPUT
=====================================
Per second averages calculated from the last 20 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 51190 1_second, 51190 sleeps, 4729 10_second, 3920 background, 3920 flush
srv_master_thread log flush and writes: 51254
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 8614, signal count 8630
--Thread 2640 has waited at trx0undo.ic line 156 for 324.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
--Thread 3960 has waited at row0ins.c line 2002 for 223.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 0000000017D62F40 created in file buf0buf.c line 898
a writer (thread id 3960) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file ..\..\..\mysql-5.5.13\storage\innobase\btr\btr0sea.c line 903
Mutex spin waits 2419, rounds 20470, OS waits 248
RW-shared spins 8256, rounds 246485, OS waits 8170
RW-excl spins 167, rounds 5653, OS waits 157
Spin rounds per wait: 8.46 mutex, 29.86 RW-shared, 33.85 RW-excl
------------
TRANSACTIONS
------------
Trx id counter D3A593
Purge done for trx's n:o < D2F9FF undo n:o < 0
History list length 300
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION D3A58B, not started
MySQL thread id 15207, query id 495281 localhost 127.0.0.1 root
---TRANSACTION D3A592, ACTIVE 223 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15208, query id 495293 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('466', '678',  NOW(), 18)
---TRANSACTION D3A58A, ACTIVE 324 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15206, query id 495259 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('620', '4', 20110617100105, '165')
--------
FILE I/O
--------
I/O thread 0 state: wait Windows aio (insert buffer thread)
I/O thread 1 state: wait Windows aio (log thread)
I/O thread 2 state: wait Windows aio (read thread)
I/O thread 3 state: wait Windows aio (read thread)
I/O thread 4 state: wait Windows aio (read thread)
I/O thread 5 state: wait Windows aio (read thread)
I/O thread 6 state: wait Windows aio (write thread)
I/O thread 7 state: wait Windows aio (write thread)
I/O thread 8 state: wait Windows aio (write thread)
I/O thread 9 state: wait Windows aio (write thread)
Pending normal aio reads: 0 [0, 0, 0, 0] , aio writes: 1 [0, 0, 1, 0] ,
 ibuf aio reads: 0, log i/o's: 0, sync i/o's: 0
Pending flushes (fsync) log: 0; buffer pool: 0
182945 OS file reads, 308793 OS file writes, 115782 OS fsyncs
0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
-------------------------------------
INSERT BUFFER AND ADAPTIVE HASH INDEX
-------------------------------------
Ibuf: size 1, free list len 29, seg size 31, 310 merges
merged operations:
 insert 785, delete mark 1, delete 0
discarded operations:
 insert 0, delete mark 0, delete 0
Hash table size 1423691, node heap has 2 buffer(s)
0.00 hash searches/s, 0.00 non-hash searches/s
---
LOG
---
Log sequence number 26461897682
Log flushed up to   26461897682
Last checkpoint at  26461672973
0 pending log writes, 0 pending chkp writes
106082 log i/o's done, 0.00 log i/o's/second
----------------------
BUFFER POOL AND MEMORY
----------------------
Total memory allocated 736182272; in additional pool allocated 0
Dictionary memory allocated 89110
Buffer pool size   43904
Free buffers       0
Database pages     43902
Old database pages 16186
Modified db pages  254
Pending reads 0
Pending writes: LRU 0, flush list 48, single page 0
Pages made young 132455, not young 0
0.00 youngs/s, 0.00 non-youngs/s
Pages read 182929, created 554, written 196801
0.00 reads/s, 0.00 creates/s, 0.00 writes/s
No buffer pool page gets since the last printout
Pages read ahead 0.00/s, evicted without access 0.00/s
LRU len: 43902, unzip_LRU len: 0
I/O sum[0]:cur[0], unzip sum[0]:cur[0]
--------------
ROW OPERATIONS
--------------
2 queries inside InnoDB, 0 queries in queue
1 read views open inside InnoDB
Main thread id 2480, state: flushing buffer pool pages
Number of rows inserted 101241, updated 10, deleted 0, read 134034889
0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
----------------------------
END OF INNODB MONITOR OUTPUT
============================
InnoDB: ###### Diagnostic info printed to the standard error stream
InnoDB: Warning: a long semaphore wait:
--Thread 2640 has waited at trx0undo.ic line 156 for 334.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
InnoDB: Pending preads 0, pwrites 0

=====================================
110617 10:05:51 INNODB MONITOR OUTPUT
=====================================
Per second averages calculated from the last 20 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 51190 1_second, 51190 sleeps, 4729 10_second, 3920 background, 3920 flush
srv_master_thread log flush and writes: 51254
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 8614, signal count 8630
--Thread 2640 has waited at trx0undo.ic line 156 for 344.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
--Thread 3960 has waited at row0ins.c line 2002 for 243.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 0000000017D62F40 created in file buf0buf.c line 898
a writer (thread id 3960) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file ..\..\..\mysql-5.5.13\storage\innobase\btr\btr0sea.c line 903
Mutex spin waits 2419, rounds 20470, OS waits 248
RW-shared spins 8256, rounds 246485, OS waits 8170
RW-excl spins 167, rounds 5653, OS waits 157
Spin rounds per wait: 8.46 mutex, 29.86 RW-shared, 33.85 RW-excl
------------
TRANSACTIONS
------------
Trx id counter D3A593
Purge done for trx's n:o < D2F9FF undo n:o < 0
History list length 300
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION D3A58B, not started
MySQL thread id 15207, query id 495281 localhost 127.0.0.1 root
---TRANSACTION D3A592, ACTIVE 243 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15208, query id 495293 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('466', '678',  NOW(), 18)
---TRANSACTION D3A58A, ACTIVE 344 sec inserting, thread declared inside InnoDB 500
mysql tables in use 1, locked 1
1 lock struct(s), heap size 376, 0 row lock(s)
MySQL thread id 15206, query id 495259 localhost 127.0.0.1 mirth update
INSERT INTO eav_data (StudyID, AttributeID, value_timestamp, value_int) VALUES ('620', '4', 20110617100105, '165')
--------
FILE I/O
--------
I/O thread 0 state: wait Windows aio (insert buffer thread)
I/O thread 1 state: wait Windows aio (log thread)
I/O thread 2 state: wait Windows aio (read thread)
I/O thread 3 state: wait Windows aio (read thread)
I/O thread 4 state: wait Windows aio (read thread)
I/O thread 5 state: wait Windows aio (read thread)
I/O thread 6 state: wait Windows aio (write thread)
I/O thread 7 state: wait Windows aio (write thread)
I/O thread 8 state: wait Windows aio (write thread)
I/O thread 9 state: wait Windows aio (write thread)
Pending normal aio reads: 0 [0, 0, 0, 0] , aio writes: 1 [0, 0, 1, 0] ,
 ibuf aio reads: 0, log i/o's: 0, sync i/o's: 0
Pending flushes (fsync) log: 0; buffer pool: 0
182945 OS file reads, 308793 OS file writes, 115782 OS fsyncs
0.00 reads/s, 0 avg bytes/read, 0.00 writes/s, 0.00 fsyncs/s
-------------------------------------
INSERT BUFFER AND ADAPTIVE HASH INDEX
-------------------------------------
Ibuf: size 1, free list len 29, seg size 31, 310 merges
merged operations:
 insert 785, delete mark 1, delete 0
discarded operations:
 insert 0, delete mark 0, delete 0
Hash table size 1423691, node heap has 2 buffer(s)
0.00 hash searches/s, 0.00 non-hash searches/s
---
LOG
---
Log sequence number 26461897682
Log flushed up to   26461897682
Last checkpoint at  26461672973
0 pending log writes, 0 pending chkp writes
106082 log i/o's done, 0.00 log i/o's/second
----------------------
BUFFER POOL AND MEMORY
----------------------
Total memory allocated 736182272; in additional pool allocated 0
Dictionary memory allocated 89110
Buffer pool size   43904
Free buffers       0
Database pages     43902
Old database pages 16186
Modified db pages  254
Pending reads 0
Pending writes: LRU 0, flush list 48, single page 0
Pages made young 132455, not young 0
0.00 youngs/s, 0.00 non-youngs/s
Pages read 182929, created 554, written 196801
0.00 reads/s, 0.00 creates/s, 0.00 writes/s
No buffer pool page gets since the last printout
Pages read ahead 0.00/s, evicted without access 0.00/s
LRU len: 43902, unzip_LRU len: 0
I/O sum[0]:cur[0], unzip sum[0]:cur[0]
--------------
ROW OPERATIONS
--------------
2 queries inside InnoDB, 0 queries in queue
1 read views open inside InnoDB
Main thread id 2480, state: flushing buffer pool pages
Number of rows inserted 101241, updated 10, deleted 0, read 134034889
0.00 inserts/s, 0.00 updates/s, 0.00 deletes/s, 0.00 reads/s
----------------------------
END OF INNODB MONITOR OUTPUT
============================
InnoDB: ###### Diagnostic info printed to the standard error stream
InnoDB: Warning: a long semaphore wait:
--Thread 2640 has waited at trx0undo.ic line 156 for 365.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 000000001761F540 created in file buf0buf.c line 898
a writer (thread id 2640) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file G:\pb2\build\sb_0-3314961-1305139748.93\mysql-5.5.13\storage\innobase\include\trx0undo.ic line 156
InnoDB: Warning: a long semaphore wait:
--Thread 3960 has waited at row0ins.c line 2002 for 264.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 0000000017D62F40 created in file buf0buf.c line 898
a writer (thread id 3960) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 0, lock_word: ffffffff
Last time read locked in file buf0flu.c line 1292
Last time write locked in file ..\..\..\mysql-5.5.13\storage\innobase\btr\btr0sea.c line 903
InnoDB: ###### Starts InnoDB Monitor for 30 secs to print diagnostic info:
InnoDB: Pending preads 0, pwrites 0

=====================================
110617 10:06:31 INNODB MONITOR OUTPUT
=====================================
Per second averages calculated from the last 40 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 51200 1_second, 51199 sleeps, 4729 10_second, 3920 background, 3920 flush
srv_master_thread log flush and writes: 51263
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 8630, signal count 8648
Mutex spin waits 2441, rounds 20918, OS waits 262
RW-shared spins 8257, rounds 246493, OS waits 8170
RW-excl spins 167, rounds 5713, OS waits 159
Spin rounds per wait: 8.57 mutex, 29.85 RW-shared, 34.21 RW-excl
------------
TRANSACTIONS
------------
Trx id counter D3AB51
Purge done for trx's n:o < D2F9FF undo n:o < 0
History list length 300
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION D3A58B, not started
MySQL thread id 15207, query id 495281 localhost 127.0.0.1 root
--------
FILE I/O
--------
I/O thread 0 state: wait Windows aio (insert buffer thread)
I/O thread 1 state: wait Windows aio (log thread)
I/O thread 2 state: wait Windows aio (read thread)
I/O thread 3 state: wait Windows aio (read thread)
I/O thread 4 state: wait Windows aio (read thread)
I/O thread 5 state: wait Windows aio (read thread)
I/O thread 6 state: wait Windows aio (write thread)
I/O thread 7 state: wait Windows aio (write thread)
I/O thread 8 state: wait Windows aio (write thread)
I/O thread 9 state: wait Windows aio (write thread)
Pending normal aio reads: 0 [0, 0, 0, 0] , aio writes: 0 [0, 0, 0, 0] ,
 ibuf aio reads: 0, log i/o's: 0, sync i/o's: 0
Pending flushes (fsync) log: 0; buffer pool: 0
183002 OS file reads, 309733 OS file writes, 116608 OS fsyncs
1.42 reads/s, 16384 avg bytes/read, 23.50 writes/s, 20.65 fsyncs/s
-------------------------------------
INSERT BUFFER AND ADAPTIVE HASH INDEX
-------------------------------------
Ibuf: size 3, free list len 27, seg size 31, 339 merges
merged operations:
 insert 1159, delete mark 1, delete 0
discarded operations:
 insert 0, delete mark 0, delete 0
Hash table size 1423691, node heap has 2 buffer(s)
18.55 hash searches/s, 96.72 non-hash searches/s
---
LOG
---
Log sequence number 26462138154
Log flushed up to   26462128707
Last checkpoint at  26461672973
0 pending log writes, 0 pending chkp writes
106901 log i/o's done, 20.47 log i/o's/second
----------------------
BUFFER POOL AND MEMORY
----------------------
Total memory allocated 736182272; in additional pool allocated 0
Dictionary memory allocated 89110
Buffer pool size   43904
Free buffers       1
Database pages     43901
Old database pages 16185
Modified db pages  274
Pending reads 0
Pending writes: LRU 0, flush list 0, single page 0
Pages made young 132484, not young 0
0.72 youngs/s, 0.00 non-youngs/s
Pages read 182986, created 558, written 196920
1.42 reads/s, 0.10 creates/s, 2.97 writes/s
Buffer pool hit rate 998 / 1000, young-making rate 1 / 1000 not 0 / 1000
Pages read ahead 0.00/s, evicted without access 0.00/s
LRU len: 43901, unzip_LRU len: 0
I/O sum[0]:cur[147], unzip sum[0]:cur[0]
--------------
ROW OPERATIONS
--------------
0 queries inside InnoDB, 0 queries in queue
1 read views open inside InnoDB
Main thread id 2480, state: sleeping
Number of rows inserted 102056, updated 10, deleted 0, read 134100891
20.37 inserts/s, 0.00 updates/s, 0.00 deletes/s, 1650.01 reads/s
----------------------------
END OF INNODB MONITOR OUTPUT
============================
InnoDB: ###### Diagnostic info printed to the standard error stream