[MDEV-14205] Windows : race condition writing into error log and setvbuf, innodb.doublewrite fails in buildbot Created: 2017-10-29  Updated: 2017-11-17  Resolved: 2017-11-14

Status: Closed
Project: MariaDB Server
Component/s: Tests
Affects Version/s: 10.1, 10.2
Fix Version/s: 10.1.29, 10.2.11

Type: Bug Priority: Major
Reporter: Elena Stepanova Assignee: Vladislav Vaintroub
Resolution: Fixed Votes: 0
Labels: None


 Description   

http://buildbot.askmonty.org/buildbot/builders/winx64-debug/builds/5805/steps/test/logs/stdio

innodb.doublewrite '4k,innodb'           w3 [ fail ]
 
        Test ended at 2017-10-27 08:33:00
 
 
 
CURRENT_TEST: innodb.doublewrite
 
 
 
 
 
Server [mysqld.1 - pid: 4520, winpid: 4520, exit: 65280] failed during test run
 
Server log from this test:
 
----------SERVER LOG START-----------
 
2017-10-27  8:32:33 4420 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe (mysqld 10.2.10-MariaDB-debug-log) starting as process 2096 ...
 
2017-10-27  8:32:33 4420 [Note] Plugin 'partition' is disabled.
 
2017-10-27  8:32:33 4420 [Note] InnoDB: innodb_page_size=4096
 
2017-10-27  8:32:33 4420 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-10-27  8:32:33 4420 [Note] InnoDB: Mutexes and rw_locks use Windows interlocked functions
 
2017-10-27  8:32:33 4420 [Note] InnoDB: Uses event mutexes
 
2017-10-27  8:32:33 4420 [Note] InnoDB: Compressed tables use zlib 1.2.3
 
2017-10-27  8:32:33 4420 [Note] InnoDB: Number of pools: 1
 
2017-10-27  8:32:33 4420 [Note] InnoDB: Using generic crc32 instructions
 
2017-10-27  8:32:33 4420 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M
 
2017-10-27  8:32:33 4420 [Note] InnoDB: Completed initialization of buffer pool
 
2017-10-27  8:32:33 4420 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-10-27  8:32:34 4420 [Note] InnoDB: 128 out of 128 rollback segments are active.
 
2017-10-27  8:32:34 4420 [Note] InnoDB: Creating shared tablespace for temporary tables
 
2017-10-27  8:32:34 4420 [Note] InnoDB: Setting file '.\ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
 
2017-10-27  8:32:34 4420 [Note] InnoDB: File '.\ibtmp1' size is now 12 MB.
 
2017-10-27  8:32:35 4420 [Note] InnoDB: Waiting for purge to start
 
2017-10-27  8:32:35 4420 [Note] InnoDB: Waiting for purge to start
 
2017-10-27  8:32:35 4420 [Note] InnoDB: 5.7.20 started; log sequence number 730942
 
2017-10-27  8:32:35 3860 [Note] InnoDB: Loading buffer pool(s) from D:\winx64-debug\build\mysql-test\var\3\mysqld.1\data\ib_buffer_pool
 
2017-10-27  8:32:35 4420 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'user_variables' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-10-27  8:32:35 4420 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-10-27  8:32:35 4420 [Warning] D:/winx64-debug/build/sql//Debug/mysqld.exe: unknown option '--loose-pam-debug'
 
2017-10-27  8:32:35 4420 [Note] Server socket created on IP: '::'.
 
2017-10-27  8:32:35 4420 [Note] Reading of all Master_info entries succeded
 
2017-10-27  8:32:35 4420 [Note] Added new Master_info '' to hash table
 
2017-10-27  8:32:35 4420 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe: ready for connections.
 
Version: '10.2.10-MariaDB-debug-log'  socket: ''  port: 16040  Source distribution
 
2017-10-27  8:32:35 3860 [Note] InnoDB: Buffer pool(s) load completed at 171027  8:32:35
 
2017-10-27  8:32:36 3084 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe (root[root] @ localhost [::1]): Normal shutdown
 
 
 
2017-10-27  8:32:36 3084 [Note] Event Scheduler: Purging the queue. 0 events
 
2017-10-27  8:32:36 4136 [Note] InnoDB: FTS optimize thread exiting.
 
2017-10-27  8:32:36 3084 [Note] InnoDB: Starting shutdown...
 
2017-10-27  8:32:36 3860 [Note] InnoDB: Dumping buffer pool(s) to D:\winx64-debug\build\mysql-test\var\3\mysqld.1\data\ib_buffer_pool
 
2017-10-27  8:32:36 3860 [Note] InnoDB: Buffer pool(s) dump completed at 171027  8:32:36
 
2017-10-27  8:32:37 3084 [Note] InnoDB: Shutdown completed; log sequence number 730961
 
2017-10-27  8:32:37 3084 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1"
 
2017-10-27  8:32:37 3084 [Note] Debug sync points hit:                   1266
 
2017-10-27  8:32:37 3084 [Note] Debug sync points executed:              0
 
2017-10-27  8:32:37 3084 [Note] Debug sync points max active per thread: 0
 
2017-10-27  8:32:37 3084 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe: Shutdown complete
 
 
 
2017-10-27  8:32:38 3476 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe (mysqld 10.2.10-MariaDB-debug-log) starting as process 2868 ...
 
2017-10-27  8:32:38 3476 [Note] Plugin 'partition' is disabled.
 
2017-10-27  8:32:38 3476 [Note] InnoDB: innodb_page_size=4096
 
2017-10-27  8:32:38 3476 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-10-27  8:32:38 3476 [Note] InnoDB: Mutexes and rw_locks use Windows interlocked functions
 
2017-10-27  8:32:38 3476 [Note] InnoDB: Uses event mutexes
 
2017-10-27  8:32:38 3476 [Note] InnoDB: Compressed tables use zlib 1.2.3
 
2017-10-27  8:32:38 3476 [Note] InnoDB: Number of pools: 1
 
2017-10-27  8:32:38 3476 [Note] InnoDB: Using generic crc32 instructions
 
2017-10-27  8:32:38 3476 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M
 
2017-10-27  8:32:38 3476 [Note] InnoDB: Completed initialization of buffer pool
 
2017-10-27  8:32:38 3476 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-10-27  8:32:39 3476 [Note] InnoDB: 128 out of 128 rollback segments are active.
 
2017-10-27  8:32:39 3476 [Note] InnoDB: Creating shared tablespace for temporary tables
 
2017-10-27  8:32:39 3476 [Note] InnoDB: Setting file '.\ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
 
2017-10-27  8:32:39 3476 [Note] InnoDB: File '.\ibtmp1' size is now 12 MB.
 
2017-10-27  8:32:40 3476 [Note] InnoDB: Waiting for purge to start
 
2017-10-27  8:32:40 3476 [Note] InnoDB: 5.7.20 started; log sequence number 730961
 
2017-10-27  8:32:40 576 [Note] InnoDB: Loading buffer pool(s) from D:\winx64-debug\build\mysql-test\var\3\mysqld.1\data\ib_buffer_pool
 
2017-10-27  8:32:40 3476 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-10-27  8:32:40 576 [Note] InnoDB: Buffer pool(s) load completed at 171027  8:32:40
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'user_variables' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-10-27  8:32:40 3476 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-10-27  8:32:40 3476 [Warning] D:/winx64-debug/build/sql//Debug/mysqld.exe: unknown option '--loose-pam-debug'
 
2017-10-27  8:32:40 3476 [Note] Server socket created on IP: '::'.
 
2017-10-27  8:32:40 3476 [Note] Reading of all Master_info entries succeded
 
2017-10-27  8:32:40 3476 [Note] Added new Master_info '' to hash table
 
2017-10-27  8:32:40 3476 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe: ready for connections.
 
Version: '10.2.10-MariaDB-debug-log'  socket: ''  port: 16040  Source distribution
 
2017-10-27  8:32:40 1484 [Note] InnoDB: Sync to disk of `test`.`t1` started.
 
2017-10-27  8:32:40 1484 [Note] InnoDB: Stopping purge
 
2017-10-27  8:32:40 1484 [Note] InnoDB: Writing table metadata to '.\test\t1.cfg'
 
2017-10-27  8:32:40 1484 [Note] InnoDB: Table `test`.`t1` flushed to disk
 
2017-10-27  8:32:40 2476 [Note] InnoDB: Deleting the meta-data file '.\test\t1.cfg'
 
2017-10-27  8:32:40 2476 [Note] InnoDB: Resuming purge
 
2017-10-27  8:32:40 2476 [Note] InnoDB: Saving InnoDB page number: 0
 
2017-10-27  8:32:40 2476 [Note] InnoDB: Dirtying page: [page id: space=4, page number=0]
 
2017-10-27  8:32:42 4476 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe (mysqld 10.2.10-MariaDB-debug-log) starting as process 2668 ...
 
2017-10-27  8:32:42 4476 [Note] Plugin 'partition' is disabled.
 
2017-10-27  8:32:42 4476 [Note] InnoDB: innodb_page_size=4096
 
2017-10-27  8:32:42 4476 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Mutexes and rw_locks use Windows interlocked functions
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Uses event mutexes
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Compressed tables use zlib 1.2.3
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Number of pools: 1
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Using generic crc32 instructions
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Completed initialization of buffer pool
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Starting crash recovery from checkpoint LSN=730961
 
2017-10-27  8:32:42 4476 [ERROR] InnoDB: Header page consists of zero bytes in datafile: .\test\t1.ibd, Space ID:0, Flags: 0. Please refer to http://dev.mysql.com/doc/refman/5.7/en/innodb-troubleshooting-datadict.html for how to resolve the issue.
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Page size:1024. Pages to analyze:24
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Page size: 1024. Possible space_id count:0
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Page size:2048. Pages to analyze:12
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Page size: 2048. Possible space_id count:0
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Page size:4096. Pages to analyze:6
 
2017-10-27  8:32:42 4476 [Note] InnoDB: VALID: space:4 page_no:1 page_size:4096
 
2017-10-27  8:32:42 4476 [Note] InnoDB: VALID: space:4 page_no:2 page_size:4096
 
2017-10-27  8:32:42 4476 [Note] InnoDB: VALID: space:4 page_no:3 page_size:4096
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Page size: 4096. Possible space_id count:1
 
2017-10-27  8:32:42 4476 [Note] InnoDB: space_id:4, Number of pages matched: 3/3 (4096)
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Chosen space:4
 
2017-10-27  8:32:42 4476 [Note] InnoDB: Restoring page [page id: space=4, page number=0] of datafile '.\test\t1.ibd' from the doublewrite buffer. Writing 4096 bytes into file '.\test\t1.ibd'
 
2017-10-27  8:32:44 4476 [Warning] InnoDB: adjusting FSP_SPACE_FLAGS of tablespace 4 from 0x6021 to 0xe1
 
2017-10-27  8:32:44 4476 [Note] InnoDB: 1 transaction(s) which must be rolled back or cleaned up in total 1 row operations to undo
 
2017-10-27  8:32:44 4476 [Note] InnoDB: Trx id counter is 2304
 
2017-10-27  8:32:44 4476 [Note] InnoDB: Starting final batch to recover 5 pages from redo log.
 
2017-10-27  8:32:45 4476 [Note] InnoDB: 128 out of 128 rollback segments are active.
 
2017-10-27  8:32:45 4476 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1"
 
2017-10-27  8:32:45 4476 [Note] InnoDB: Creating shared tablespace for temporary tables
 
2017-10-27  8:32:45 4476 [Note] InnoDB: Setting file '.\ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
 
2017-10-27  8:32:45 4476 [Note] InnoDB: File '.\ibtmp1' size is now 12 MB.
 
2017-10-27  8:32:45 4588 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-10-27  8:32:45 4588 [Note] InnoDB: Rolling back trx with id 1798, 1 rows to undo
 
2017-10-27  8:32:45 4588 [Note] InnoDB: Rollback of trx with id 1798 completed
 
2017-10-27  8:32:46 4588 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-10-27  8:32:46 4476 [Note] InnoDB: Waiting for purge to start
 
2017-10-27  8:32:46 4476 [Note] InnoDB: Waiting for purge to start
 
2017-10-27  8:32:46 4476 [Note] InnoDB: 5.7.20 started; log sequence number 735949
 
2017-10-27  8:32:46 4476 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'user_variables' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-10-27  8:32:46 4476 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-10-27  8:32:46 4476 [Warning] D:/winx64-debug/build/sql//Debug/mysqld.exe: unknown option '--loose-pam-debug'
 
2017-10-27  8:32:46 4476 [Note] Server socket created on IP: '::'.
 
2017-10-27  8:32:46 3260 [Note] InnoDB: Loading buffer pool(s) from D:\winx64-debug\build\mysql-test\var\3\mysqld.1\data\ib_buffer_pool
 
2017-10-27  8:32:46 4476 [Note] Reading of all Master_info entries succeded
 
2017-10-27  8:32:46 4476 [Note] Added new Master_info '' to hash table
 
2017-10-27  8:32:46 4476 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe: ready for connections.
 
Version: '10.2.10-MariaDB-debug-log'  socket: ''  port: 16040  Source distribution
 
2017-10-27  8:32:46 3260 [Note] InnoDB: Buffer pool(s) load completed at 171027  8:32:46
 
2017-10-27  8:32:47 1484 [Note] InnoDB: Sync to disk of `test`.`t1` started.
 
2017-10-27  8:32:47 1484 [Note] InnoDB: Stopping purge
 
2017-10-27  8:32:47 1484 [Note] InnoDB: Writing table metadata to '.\test\t1.cfg'
 
2017-10-27  8:32:47 1484 [Note] InnoDB: Table `test`.`t1` flushed to disk
 
2017-10-27  8:32:47 3540 [Note] InnoDB: Deleting the meta-data file '.\test\t1.cfg'
 
2017-10-27  8:32:47 3540 [Note] InnoDB: Resuming purge
 
2017-10-27  8:32:47 1484 [Note] InnoDB: Saving InnoDB page number: 0
 
2017-10-27  8:32:47 1484 [Note] InnoDB: Dirtying page: [page id: space=4, page number=0]
 
2017-10-27  8:32:48 1320 [Note] D:/winx64-debug/build/sql//Debug/mysqld.exe (mysqld 10.2.10-MariaDB-debug-log) starting as process 5024 ...
 
2017-10-27  8:32:48 1320 [Note] Plugin 'partition' is disabled.
 
2017-10-27  8:32:48 1320 [Note] InnoDB: innodb_page_size=4096
 
2017-10-27  8:32:48 1320 [Note] InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Mutexes and rw_locks use Windows interlocked functions
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Uses event mutexes
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Compressed tables use zlib 1.2.3
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Number of pools: 1
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Using generic crc32 instructions
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Initializing buffer pool, total size = 8M, instances = 1, chunk size = 8M
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Completed initialization of buffer pool
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-10-27  8:32:48 1320 [Note] InnoDB: Starting crash recovery from checkpoint LSN=736026
 
2017-10-27  8:32:50 1320 [Note] InnoDB: 1 transaction(s) which must be rolled back or cleaned up in total 1 row operations to undo
 
2017-10-27  8:32:50 1320 [Note] InnoDB: Trx id counter is 2816
 
2017-10-27  8:32:50 1320 [Note] InnoDB: Starting final batch to recover 1 pages from redo log.
 
2017-10-27  8:32:51 1320 [Note] InnoDB: 128 out of 128 rollback segments are active.
 
2017-10-27  8:32:51 1320 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1"
 
2017-10-27  8:32:51 1320 [Note] InnoDB: Creating shared tablespace for temporary tables
 
2017-10-27  8:32:51 1320 [Note] InnoDB: Setting file '.\ibtmp1' size to 12 MB. Physically writing the file full; Please wait ...
 
2017-10-27  8:32:51 1320 [Note] InnoDB: File '.\ibtmp1' size is now 12 MB.
 
2017-10-27  8:32:51 4640 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-10-27  8:32:51 4640 [Note] InnoDB: Rolling back trx with id 2307, 1 rows to undo
 
2017-10-27  8:32:51 4640 [Note] InnoDB: Rollback of trx with id 2307 completed
 
2017-10-27  8:32:51 4640 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-10-27  8:32:52 1320 [Note] InnoDB: Waiting for purge to start
 
2017-10-27  8:32:52 1320 [Note] InnoDB: 5.7.20 started; log sequence number 736152
 
2017-10-27  8:32:52 4532 [Note] InnoDB: Loading buffer pool(s) from D:\winx64-debug\build\mysql-test\var\3\mysqld.1\data\ib_buffer_pool
 
2017-10-27  8:32:52 1320 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'user_variables' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-10-27  8:32:52 1320 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-10-27  8:32:52 1320 [Warning] D:/winx64-debug/build/sql//Debug/mysqld.exe: unknown option '--loose-pam-debug'
 
2017-10-27  8:32:52 1320 [Note] Server socket created on IP: '::'.


171027  8:32:52 [ERROR] mysqld got exception 0x80000003 ;
 
This could be because you hit a bug. It is also possible that this binary
 
or one of the libraries it was linked against is corrupt, improperly built,
 
or misconfigured. This error can also be caused by malfunctioning hardware.
 
 
 
To report this bug, see https://mariadb.com/kb/en/reporting-bugs
 
 
 
We will try our best to scrape up some info that will hopefully help
 
diagnose the problem, but since we have already crashed, 
something is definitely wrong and this may fail.
 
 
 
Server version: 10.2.10-MariaDB-debug-log
 
key_buffer_size=1048576
 
read_buffer_size=131072
 
max_used_connections=0
 
max_threads=65537
 
thread_count=5
 
It is possible that mysqld could use up to 
key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 4211 K  bytes of memory
 
Hope that's ok; if not, decrease some variables in the equation.
 
 
 
Thread pointer: 0x0
 
Attempting backtrace. You can use the following information to find out
 
where mysqld died. If you see no messages after this, something went
 
terribly wrong...
 
mysqld.exe!my_parameter_handler()[my_init.c:256]
 
mysqld.exe!_invalid_parameter_noinfo()[invalid_parameter.cpp:98]
 
mysqld.exe!_write()[write.cpp:48]
 
mysqld.exe!write_buffer_nolock<char>()[_flsbuf.cpp:56]
 
mysqld.exe!__acrt_stdio_flush_and_write_narrow_nolock()[_flsbuf.cpp:157]
 
mysqld.exe!__crt_stdio_output::stream_output_adapter<char>::write_string()[corecrt_internal_stdio_output.h:163]
 
mysqld.exe!__crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > >::write_stored_string_tchar()[corecrt_internal_stdio_output.h:2644]
 
mysqld.exe!__crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > >::state_case_type()[corecrt_internal_stdio_output.h:2095]
 
mysqld.exe!__crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > >::process()[corecrt_internal_stdio_output.h:1644]
 
mysqld.exe!<lambda_0a64b6a4deda75c01876f29c44fc5eb3>::operator()()[output.cpp:46]
 
mysqld.exe!__crt_seh_guarded_call<int>::operator()<<lambda_aa279a7bcb127014629d5b1d62c7325d>,<lambda_0a64b6a4deda75c01876f29c44fc5eb3> & __ptr64,<lambda_3323e69fbefe9d1a11713e670d47cdfa> >()[internal_shared.h:199]
 
mysqld.exe!__stdio_common_vfprintf()[output.cpp:59]
 
mysqld.exe!_vfprintf_l()[stdio.h:640]
 
mysqld.exe!fprintf()[stdio.h:835]
 
mysqld.exe!print_buffer_to_file()[log.cc:8465]
 
mysqld.exe!vprint_msg_to_log()[log.cc:8497]
 
mysqld.exe!Log_to_file_event_handler::log_error()[log.cc:1023]
 
mysqld.exe!LOGGER::error_log_print()[log.cc:1131]
 
mysqld.exe!error_log_print()[log.cc:6383]
 
mysqld.exe!sql_print_information()[log.cc:8541]
 
mysqld.exe!ib::info::~info()[ut0ut.cc:824]
 
mysqld.exe!buf_load_status()[buf0dump.cc:173]
 
mysqld.exe!buf_load()[buf0dump.cc:779]
 
mysqld.exe!buf_dump_thread()[buf0dump.cc:822]
 
KERNEL32.DLL!BaseThreadInitThunk()
 
ntdll.dll!RtlUserThreadStart()
 
The manual page at http://dev.mysql.com/doc/mysql/en/crashing.html contains
 
information that should help you find out what is causing the crash.
 
Writing a core file
 
Minidump written to D:\winx64-debug\build\mysql-test\var\3\mysqld.1\data\mysqld.dmp
 
----------SERVER LOG END-------------
 
mysqltest failed but provided no output
 
The result from queries just before the failure was:
 
< snip >
 
3	////////////
 
4	------------
 
5	............
 
# Test End
 
# ---------------------------------------------------------------
 
# Test Begin: Test if recovery works if first page of user
 
# tablespace is corrupted.
 
select space from information_schema.innodb_sys_tables
 
where name = 'test/t1' into @space_id;
 
# Ensure that dirty pages of table t1 is flushed.
 
flush tables t1 for export;
 
unlock tables;
 
begin;
 
insert into t1 values (6, repeat('%', 12));
 
# Make the first page dirty for table t1
 
set global innodb_saved_page_number_debug = 0;
 
set global innodb_fil_make_page_dirty_debug = @space_id;
 
# Ensure that dirty pages of table t1 are flushed.
 
set global innodb_buf_flush_list_now = 1;
 
# Kill the server
 
 
 
 
 
 
 
 - saving 'D:/winx64-debug/build/mysql-test/var/3/log/innodb.doublewrite-4k,innodb/' to 'D:/winx64-debug/build/mysql-test/var/log/innodb.doublewrite-4k,innodb/'
 
 - found 'mysqld.dmp' (0/5)
 
 
 
Trying 'cdb' to get a backtrace
 
Output from cdb follows. Faulting thread is printed twice,with and without function parameters
 
Search for STACK_TEXT to see the stack trace of 
the faulting thread. Callstacks of other threads are printed after it.
 
 
 
Microsoft (R) Windows Debugger Version 10.0.10586.567 AMD64
 
Copyright (c) Microsoft Corporation. All rights reserved.
 
 
 
 
 
Loading Dump File [D:\winx64-debug\build\mysql-test\var\log\innodb.doublewrite-4k,innodb\mysqld.1\data\mysqld.dmp]
 
User Mini Dump File: Only registers, stack and portions of memory are available
 
 
 
 
 
Response                         Time (ms)     Location
 
OK                                             .
 
 
 
Response                         Time (ms)     Location
 
OK                                             .
 
Deferred                                       cache*C:\cdb_symbols
 
Symbol search path is: .;cache*C:\cdb_symbols
 
Executable search path is: .
 
Windows 8.1 Version 9600 MP (4 procs) Free x64
 
Product: Server, suite: TerminalServer DataCenter SingleUserTS
 
Built by: 6.3.9600.18217 (winblue_ltsb.160124-0053)
 
Machine Name:
 
Debug session time: Fri Oct 27 08:32:59.000 2017 (UTC + 0:00)
 
System Uptime: not available
 
Process Uptime: 0 days 0:00:11.000
 
........................
 
This dump file has a breakpoint exception stored in it.
 
The stored exception information can be accessed via .ecxr.
 
ntdll!ZwGetContextThread:
 
             ret
 
0:019> cdb: Reading initial command '!sym prompts off; !analyze -v; .ecxr; !for_each_frame dv /t;!uniqstack -p;q'
 
quiet mode - symbol prompts off
 
 
 
 
 
 
 
DUMP_CLASS: 2
 
 
 
DUMP_QUALIFIER: 400
 
 
 
CONTEXT:  (.ecxr)
 
rax=00007ff7b8c3ed00 rbx=0000000000000002 rcx=0000000000000000
 
rdx=0000000000000000 rsi=0000000000000080 rdi=0000000000000032
 
rip=00007ff7b8c3ed15 rsp=00000074f925da70 rbp=00000074f925df48
 
 r8=0000000000000000  r9=0000000000000000 r10=00004ebcbfa524f8
 
r11=0000000000000000 r12=00000074f925db40 r13=00007ff7bb1c9360
 
r14=0000000000000000 r15=0000000000000001
 
iopl=0         nv up ei pl nz na pe nc
 
cs=0033  ss=002b  ds=002b  es=002b  fs=0053  gs=002b             efl=00000202
 
mysqld!my_parameter_handler:
 
             int     3
 
Resetting default scope
 
 
 
FAULTING_IP: 
mysqld!my_parameter_handler+15 [d:\winx64-debug\build\src\mysys\my_init.c @ 256]
 
             int     3
 
 
 
EXCEPTION_RECORD:  (.exr -1)
 
ExceptionAddress: 00007ff7b8c3ed15 (mysqld!my_parameter_handler)
 
   ExceptionCode: 80000003 (Break instruction exception)
 
  ExceptionFlags: 00000000
 
NumberParameters: 1
 
   Parameter[0]: 0000000000000000
 
 
 
BUGCHECK_STR:  59BA86DB
 
 
 
WRONG_SYMBOLS_TIMESTAMP: 59ba86db
 
 
 
WRONG_SYMBOLS_SIZE: 1ad000
 
 
 
FAULTING_MODULE: 00007ffa13150000 ntdll
 
 
 
DEBUG_FLR_IMAGE_TIMESTAMP:  59ba86db
 
 
 
ADDITIONAL_DEBUG_TEXT:  
You can run '.symfix; .reload' to try to fix the symbol path and load symbols. ; Followup set based on attribute [Is_ChosenCrashFollowupThread] from Frame:[0] on thread:[PSEUDO_THREAD]
 
 
 
LAST_CONTROL_TRANSFER:  from 0000000000000000 to 0000000000000000
 
 
 
ANALYSIS_SESSION_HOST:  MARIADB-02
 
 
 
ANALYSIS_SESSION_TIME:  10-27-2017 08:33:02.0271
 
 
 
ANALYSIS_VERSION: 10.0.10586.567 amd64fre
 
 
 
STACK_TEXT:  
wrong_symbols!WRONG_SYMBOLS
 
 
 
 
 
STACK_COMMAND:  .ecxr ; kb ; ** Pseudo Context ** ; kb
 
 
 
THREAD_SHA1_HASH_MOD_FUNC:  8b50e467776d7660ec74f0fcf6059a449f38bc9a
 
 
 
THREAD_SHA1_HASH_MOD_FUNC_OFFSET:  386be9b62a7535c96acfda43762924bd7c0bcb71
 
 
 
THREAD_SHA1_HASH_MOD:  1c9266d4d33f329668e953be351439450e48d114
 
 
 
SYMBOL_STACK_INDEX:  0
 
 
 
FOLLOWUP_NAME:  MachineOwner
 
 
 
EXCEPTION_CODE: (NTSTATUS) 0x59ba86db - <Unable to get error code text>
 
 
 
EXCEPTION_CODE_STR:  59BA86DB
 
 
 
FAILURE_EXCEPTION_CODE:  59BA86DB
 
 
 
EXCEPTION_STR:  PRIVATE_SYMBOLS
 
 
 
PROCESS_NAME:  ntdll.wrong.symbols.dll
 
 
 
IMAGE_NAME:  ntdll.wrong.symbols.dll
 
 
 
MODULE_NAME: ntdll_wrong_symbols
 
 
 
SYMBOL_NAME:  ntdll_wrong_symbols!59BA86DB1AD000
 
 
 
BUCKET_ID:  PRIVATE_SYMBOLS_X64_6.3.9600.17415_(winblue_r4.141028-1500)_TIMESTAMP_170914-134043
 
 
 
DEFAULT_BUCKET_ID:  PRIVATE_SYMBOLS_X64_6.3.9600.17415_(winblue_r4.141028-1500)_TIMESTAMP_170914-134043
 
 
 
PRIMARY_PROBLEM_CLASS:  PRIVATE_SYMBOLS
 
 
 
BUCKET_ID_OFFSET:  0
 
 
 
BUCKET_ID_MODULE_STR:  ntdll_wrong_symbols
 
 
 
BUCKET_ID_MODVER_STR:  
 
 
BUCKET_ID_PREFIX_STR:  PRIVATE_SYMBOLS_X64_6.3.9600.17415_(winblue_r4.141028-1500)_TIMESTAMP_170914-134043
 
 
 
FAILURE_PROBLEM_CLASS:  PRIVATE_SYMBOLS_X64_6.3.9600.17415_(winblue_r4.141028-1500)_TIMESTAMP_170914-134043
 
 
 
FAILURE_IMAGE_NAME:  ntdll.wrong.symbols.dll
 
 
 
FAILURE_FUNCTION_NAME:  59BA86DB1AD000
 
 
 
BUCKET_ID_FUNCTION_STR:  59BA86DB1AD000
 
 
 
FAILURE_SYMBOL_NAME:  ntdll.wrong.symbols.dll!59BA86DB1AD000
 
 
 
FAILURE_BUCKET_ID:  PRIVATE_SYMBOLS_X64_6.3.9600.17415_(winblue_r4.141028-1500)_TIMESTAMP_170914-134043_59BA86DB_ntdll.wrong.symbols.dll!59BA86DB1AD000
 
 
 
TARGET_TIME:  2017-10-27T08:32:59.000Z
 
 
 
OSBUILD:  9600
 
 
 
OSSERVICEPACK:  17415
 
 
 
SERVICEPACK_NUMBER: 0
 
 
 
OS_REVISION: 0
 
 
 
SUITE_MASK:  400
 
 
 
PRODUCT_TYPE:  3
 
 
 
OSPLATFORM_TYPE:  x64
 
 
 
OSNAME:  Windows 8.1
 
 
 
OSEDITION:  Windows 8.1 Server TerminalServer DataCenter SingleUserTS
 
 
 
OS_LOCALE:  
 
 
USER_LCID:  0
 
 
 
OSBUILD_TIMESTAMP:  2014-10-29 02:45:30
 
 
 
BUILDDATESTAMP_STR:  141028-1500
 
 
 
BUILDLAB_STR:  winblue_r4
 
 
 
BUILDOSVER_STR:  6.3.9600.17415
 
 
 
ANALYSIS_SESSION_ELAPSED_TIME: 10a9
 
 
 
ANALYSIS_SOURCE:  UM
 
 
 
FAILURE_ID_HASH_STRING:  um:private_symbols_x64_6.3.9600.17415_(winblue_r4.141028-1500)_timestamp_170914-134043_59ba86db_ntdll.wrong.symbols.dll!59ba86db1ad000
 
 
 
FAILURE_ID_HASH:  {d62cd6d8-aa8f-46af-c234-ecd0fe2bb7ff}
 
 
 
Followup:     MachineOwner
 
---------
 
 
 
rax=00007ff7b8c3ed00 rbx=0000000000000002 rcx=0000000000000000
 
rdx=0000000000000000 rsi=0000000000000080 rdi=0000000000000032
 
rip=00007ff7b8c3ed15 rsp=00000074f925da70 rbp=00000074f925df48
 
 r8=0000000000000000  r9=0000000000000000 r10=00004ebcbfa524f8
 
r11=0000000000000000 r12=00000074f925db40 r13=00007ff7bb1c9360
 
r14=0000000000000000 r15=0000000000000001
 
iopl=0         nv up ei pl nz na pe nc
 
cs=0033  ss=002b  ds=002b  es=002b  fs=0053  gs=002b             efl=00000202
 
mysqld!my_parameter_handler:
 
             int     3
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!my_parameter_handler [d:\winx64-debug\build\src\mysys\my_init.c @ 256]
 
wchar_t * expression = 0x00000000`00000000 ""
 
wchar_t * function = 0x00000000`00000000 ""
 
wchar_t * file = 0x00000000`00000000 ""
 
unsigned int line = 0
 
unsigned int64 pReserved = 0
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!_invalid_parameter_noinfo [d:\th\minkernel\crts\ucrt\src\appcrt\misc\invalid_parameter.cpp @ 98]
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!_write [d:\th\minkernel\crts\ucrt\src\appcrt\lowio\write.cpp @ 48]
 
int fh = 0n2
 
void * buffer = 0x00000074`f925db40
 
unsigned int size = 1
 
int result = <value unavailable>
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!write_buffer_nolock<char> [d:\th\minkernel\crts\ucrt\src\appcrt\stdio\_flsbuf.cpp @ 56]
 
char c = 0n50 '2'
 
class __crt_stdio_stream stream = class __crt_stdio_stream
 
int fh = <value unavailable>
 
int chars_written = <value unavailable>
 
int chars_to_write = <value unavailable>
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
(Inline Function) --------`-------- mysqld!common_flush_and_write_nolock [d:\th\minkernel\crts\ucrt\src\appcrt\stdio\_flsbuf.cpp @ 141]
 
int fh = 0n2
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!__acrt_stdio_flush_and_write_narrow_nolock [d:\th\minkernel\crts\ucrt\src\appcrt\stdio\_flsbuf.cpp @ 157]
 
int c = 0n50
 
struct _iobuf * stream = 0x00007ff7`ba91dda0
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
(Inline Function) --------`-------- mysqld!__crt_char_traits<char>::puttc_nolock [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_traits.h @ 106]
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
(Inline Function) --------`-------- mysqld!__crt_stdio_output::stream_output_adapter<char>::write_character [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_stdio_output.h @ 135]
 
char c = <value unavailable>
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!__crt_stdio_output::stream_output_adapter<char>::write_string [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_stdio_output.h @ 163]
 
class __crt_stdio_output::stream_output_adapter<char> * this = 0x00000074`f925e158
 
char * string = <value unavailable>
 
int length = <value unavailable>
 
int * count_written = 0x00000074`f925dd18
 
int * status = 0x00000074`f6abbfd0
 
char * string_last = 0x00000074`f925df48 "???"
 
struct __crt_errno_guard reset_errno = struct __crt_errno_guard
 
char * it = 0x00000074`f925df44 "2017???"
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!__crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > >::write_stored_string_tchar [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_stdio_output.h @ 2644]
 
class __crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > > * this = 0x00000074`f925dcf0
 
char __formal = 0n0 ''
 
wchar_t * p = 0x00000000`fffffffc "--- memory read error at address 0x00000000`fffffffc ---"
 
int i = 0n0
 
int status = 0n-1195119360
 
char [6] local_buffer = char [6] "t"
 
int mbc_length = 0n-114959120
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!__crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > >::state_case_type [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_stdio_output.h @ 2095]
 
class __crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > > * this = 0x00000074`f925dcf0
 
unsigned int64 prefix_length = 0
 
bool result = <value unavailable>
 
int padding = <value unavailable>
 
bool print_integer_0x = <value unavailable>
 
bool print_floating_point_0x = <value unavailable>
 
char [3] prefix = char [3] ""
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!__crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > >::process [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_stdio_output.h @ 1644]
 
class __crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > > * this = 0x00000074`f925dcf0
 
bool result = false
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!<lambda_0a64b6a4deda75c01876f29c44fc5eb3>::operator() [d:\th\minkernel\crts\ucrt\src\appcrt\stdio\output.cpp @ 46]
 
class common_vfprintf::__l11::<lambda_0a64b6a4deda75c01876f29c44fc5eb3> * this = 0x00000074`f925e1f8
 
class _LocaleUpdate locale_update = class _LocaleUpdate
 
class __acrt_stdio_temporary_buffering_guard buffering = class __acrt_stdio_temporary_buffering_guard
 
class __crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > > processor = class __crt_stdio_output::output_processor<char,__crt_stdio_output::stream_output_adapter<char>,__crt_stdio_output::standard_base<char,__crt_stdio_output::stream_output_adapter<char> > >
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!__crt_seh_guarded_call<int>::operator()<<lambda_aa279a7bcb127014629d5b1d62c7325d>,<lambda_0a64b6a4deda75c01876f29c44fc5eb3> & __ptr64,<lambda_3323e69fbefe9d1a11713e670d47cdfa> > [d:\th\minkernel\crts\ucrt\devdiv\vcruntime\inc\internal_shared.h @ 199]
 
struct __crt_seh_guarded_call<int> * this = 0x00007ff7`b8896950
 
class __acrt_lock_stream_and_call::__l3::<lambda_aa279a7bcb127014629d5b1d62c7325d> * setup = 0xcccccccc`cccccccc
 
class common_vfprintf::__l11::<lambda_0a64b6a4deda75c01876f29c44fc5eb3> * action = 0x00000074`f925e1f8
 
class __acrt_lock_stream_and_call::__l4::<lambda_3323e69fbefe9d1a11713e670d47cdfa> * cleanup = 0x00000074`f925e1e8
 
int result = <value unavailable>
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
(Inline Function) --------`-------- mysqld!__acrt_lock_stream_and_call [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_stdio.h @ 255]
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
(Inline Function) --------`-------- mysqld!common_vfprintf [d:\th\minkernel\crts\ucrt\src\appcrt\stdio\output.cpp @ 35]
 
unsigned int64 options = 4
 
struct _iobuf * stream = 0x00007ff7`ba91dda0
 
char * format = 0x00007ff7`b90acaf0 "%d-%02d-%02d %2d:%02d:%02d %lu [%s] %.*s%.*s."
 
struct __crt_locale_pointers * locale = 0x00000000`00000000
 
char * arglist = 0x00000074`f925e2e0 "???"
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!__stdio_common_vfprintf [d:\th\minkernel\crts\ucrt\src\appcrt\stdio\output.cpp @ 59]
 
unsigned int64 options = <value unavailable>
 
struct _iobuf * stream = <value unavailable>
 
char * format = <value unavailable>
 
struct __crt_locale_pointers * locale = <value unavailable>
 
char * arglist = 0x00000074`f925e2e0 "???"
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!_vfprintf_l [c:\program files (x86)\windows kits\10\include\10.0.10240.0\ucrt\stdio.h @ 640]
 
struct _iobuf * _Stream = 0x00007ff7`ba91dda0
 
char * _Format = 0x00007ff7`b90acaf0 "%d-%02d-%02d %2d:%02d:%02d %lu [%s] %.*s%.*s."
 
struct __crt_locale_pointers * _Locale = 0x00000000`00000000
 
char * _ArgList = 0x00000074`f925e2e0 "???"
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!fprintf [c:\program files (x86)\windows kits\10\include\10.0.10240.0\ucrt\stdio.h @ 835]
 
struct _iobuf * _Stream = 0x00007ff7`ba91dda0
 
char * _Format = 0x00007ff7`b90acaf0 "%d-%02d-%02d %2d:%02d:%02d %lu [%s] %.*s%.*s."
 
char * _ArgList = 0x00000074`f925e2e0 "???"
 
int _Result = 0n-858993460
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!print_buffer_to_file [d:\winx64-debug\build\src\sql\log.cc @ 8465]
 
loglevel level = INFORMATION_LEVEL (0n2)
 
char * buffer = 0x00000074`f925e540 "InnoDB: Buffer pool(s) load completed at 171027  8:32:52"
 
unsigned int64 length = 0x38
 
int64 skr = 0n1509093172
 
int tag_length = 0n0
 
char [192] tag = char [192] "???"
 
struct tm tm_tmp = struct tm
 
struct _db_stack_frame_ _db_stack_frame_ = struct _db_stack_frame_
 
struct tm * start = 0x00000074`f925e368
 
class THD * thd = 0x00000000`00000000
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!vprint_msg_to_log [d:\winx64-debug\build\src\sql\log.cc @ 8497]
 
loglevel level = INFORMATION_LEVEL (0n2)
 
char * format = 0x00007ff7`b92a5260 "InnoDB: %s"
 
char * args = 0x00000074`f925eb08 "???"
 
char [1024] buff = char [1024] "InnoDB: Buffer pool(s) load completed at 171027  8:32:52"
 
unsigned int64 length = 0x38
 
struct _db_stack_frame_ _db_stack_frame_ = struct _db_stack_frame_
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!Log_to_file_event_handler::log_error [d:\winx64-debug\build\src\sql\log.cc @ 1023]
 
class Log_to_file_event_handler * this = 0x00000074`f453e120
 
loglevel level = INFORMATION_LEVEL (0n2)
 
char * format = 0x00007ff7`b92a5260 "InnoDB: %s"
 
char * args = 0x00000074`f925eb08 "???"
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!LOGGER::error_log_print [d:\winx64-debug\build\src\sql\log.cc @ 1131]
 
class LOGGER * this = 0x00007ff7`ba933480
 
loglevel level = INFORMATION_LEVEL (0n2)
 
char * format = 0x00007ff7`b92a5260 "InnoDB: %s"
 
char * args = 0x00000074`f925eb08 "???"
 
class Log_event_handler ** current_handler = 0x00007ff7`ba9334e8
 
bool error = false
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!error_log_print [d:\winx64-debug\build\src\sql\log.cc @ 6383]
 
loglevel level = INFORMATION_LEVEL (0n2)
 
char * format = 0x00007ff7`b92a5260 "InnoDB: %s"
 
char * args = 0x00000074`f925eb08 "???"
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!sql_print_information [d:\winx64-debug\build\src\sql\log.cc @ 8541]
 
char * format = 0x00007ff7`b92a5260 "InnoDB: %s"
 
char * args = 0x00000074`f925eb08 "???"
 
struct _db_stack_frame_ _db_stack_frame_ = struct _db_stack_frame_
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!ib::info::~info [d:\winx64-debug\build\src\storage\innobase\ut\ut0ut.cc @ 824]
 
class ib::info * this = 0x00000074`f925eba8
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!buf_load_status [d:\winx64-debug\build\src\storage\innobase\buf\buf0dump.cc @ 173]
 
status_severity severity = STATUS_INFO (0n1)
 
char * fmt = 0x00007ff7`b9a7c420 "Buffer pool(s) load completed at %s"
 
char * ap = 0x00000074`f925edd0 "???"
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!buf_load [d:\winx64-debug\build\src\storage\innobase\buf\buf0dump.cc @ 779]
 
unsigned int64 space_id = 0
 
class page_size_t page_size = class page_size_t
 
unsigned int64 i = 0x158
 
char [4000] full_filename = char [4000] "D:\winx64-debug\build\mysql-test\var\3\mysqld.1\data\ib_buffer_pool"
 
struct _iobuf * f = 0x00000074`f69448f0
 
unsigned int64 * dump = 0x00000074`f6abc380
 
unsigned int64 page_no = 7
 
unsigned int64 last_check_time = 0x0000015f`5cf6648d
 
unsigned int64 dump_n = 0x158
 
int fscanf_ret = 0n2
 
char [32] now = char [32] "171027  8:32:52"
 
unsigned int64 total_buffer_pools_pages = 0x800
 
unsigned int64 last_activity_cnt = 3
 
unsigned int64 cur_space_id = 0xfffffffe
 
struct fil_space_t * space = 0x00000074`f6a87070
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!buf_dump_thread [d:\winx64-debug\build\src\storage\innobase\buf\buf0dump.cc @ 822]
 
void * __formal = 0x00000000`00000000
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
kernel32!BaseThreadInitThunk
 
Unable to enumerate locals, HRESULT 0x80004005
 
Private symbols (symbols.pri) are required for locals.
 
Type ".hh dbgerr005" for details.
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
ntdll!RtlUserThreadStart
 
Unable to enumerate locals, Win32 error 0n318
 
Private symbols (symbols.pri) are required for locals.
 
Type ".hh dbgerr005" for details.
 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
 
mysqld!my_parameter_handler [d:\winx64-debug\build\src\mysys\my_init.c @ 256]
 
Processing 25 threads, please wait
 
 
 
.  0  Id: 13a0.528 Suspend: 0 Teb: 00007ff7`b7eee000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!ZwWaitForSingleObject
 
ntdll!RtlLockHeap
 
ntdll!RtlEnterCriticalSection
 
(Inline Function) --------`-------- mysqld!__acrt_lock_stream_and_call::__l3::<lambda_7a5ef57ff966f610505f1d28a3d40618>::operator() [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_stdio.h @ 253]
 
mysqld!__crt_seh_guarded_call<int>::operator()<<lambda_7a5ef57ff966f610505f1d28a3d40618>,<lambda_b721fa326cdb32351d23dfa67958c160> & __ptr64,<lambda_5e0fb27672408a07956fe59e48ccb2aa> >(class __acrt_lock_stream_and_call::__l3::<lambda_7a5ef57ff966f610505f1d28a3d40618> * setup = 0xcccccccc`cccccccc, class setvbuf::__l27::<lambda_b721fa326cdb32351d23dfa67958c160> * action = 0x00000074`f1aff968, class __acrt_lock_stream_and_call::__l4::<lambda_5e0fb27672408a07956fe59e48ccb2aa> * cleanup = 0x00000074`f1aff958) [d:\th\minkernel\crts\ucrt\devdiv\vcruntime\inc\internal_shared.h @ 196]
 
(Inline Function) --------`-------- mysqld!__acrt_lock_stream_and_call [d:\th\minkernel\crts\ucrt\inc\corecrt_internal_stdio.h @ 255]
 
mysqld!setvbuf(struct _iobuf * public_stream = <Value unavailable error>, char * buffer = 0x00000000`00000000 "", int type = 0n4, unsigned int64 buffer_size_in_bytes = 0) [d:\th\minkernel\crts\ucrt\src\appcrt\stdio\setvbuf.cpp @ 105]
 
mysqld!reopen_fstreams(char * filename = 0x00007ff7`ba9352c0 "--- memory read error at address 0x00007ff7`ba9352c0 ---", struct _iobuf * outstream = 0x00007ff7`ba91dd48, struct _iobuf * errstream = 0x00007ff7`ba91dda0) [d:\winx64-debug\build\src\sql\log.cc @ 8343]
 
mysqld!win_main(int argc = 0n146, char ** argv = 0x00000074`f1d313b8) [d:\winx64-debug\build\src\sql\mysqld.cc @ 5878]
 
mysqld!mysql_service(void * p = 0x00000000`00000000) [d:\winx64-debug\build\src\sql\mysqld.cc @ 6128]
 
mysqld!mysqld_main(int argc = 0n23, char ** argv = 0x00000074`f1d22160) [d:\winx64-debug\build\src\sql\mysqld.cc @ 6321]
 
mysqld!main(int argc = 0n23, char ** argv = 0x00000074`f1d22160) [d:\winx64-debug\build\src\sql\main.cc @ 26]
 
(Inline Function) --------`-------- mysqld!invoke_main [f:\dd\vctools\crt\vcstartup\src\startup\exe_common.inl @ 78]
 
mysqld!__scrt_common_main_seh(void) [f:\dd\vctools\crt\vcstartup\src\startup\exe_common.inl @ 283]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
.  1  Id: 13a0.9ec Suspend: 0 Teb: 00007ff7`b7eec000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!pthread_cond_timedwait(struct _RTL_CONDITION_VARIABLE * cond = 0x00007ff7`bb1bba88, struct _RTL_CRITICAL_SECTION * mutex = 0x00007ff7`bb1bba58, struct timespec * abstime = 0x00000074`f6d7f758) [d:\winx64-debug\build\src\mysys\my_wincond.c @ 82]
 
mysqld!inline_mysql_cond_timedwait(struct st_mysql_cond * that = 0x00007ff7`bb1bba88, struct st_mysql_mutex * mutex = 0x00007ff7`bb1bba58, struct timespec * abstime = 0x00000074`f6d7f758, char * src_file = 0x00007ff7`ba744f78 "--- memory read error at address 0x00007ff7`ba744f78 ---", unsigned int src_line = 0x124) [d:\winx64-debug\build\src\include\mysql\psi\mysql_thread.h @ 1175]
 
mysqld!timer_handler(void * arg = 0x00000000`00000000) [d:\winx64-debug\build\src\mysys\thr_timer.c @ 293]
 
mysqld!pfs_spawn_thread(void * arg = 0x00000074`f3ece518) [d:\winx64-debug\build\src\storage\perfschema\pfs.cc @ 1865]
 
mysqld!pthread_start(void * p = 0x00000074`f1e0b400) [d:\winx64-debug\build\src\mysys\my_winthread.c @ 61]
 
(Inline Function) --------`-------- mysqld!invoke_thread_procedure [d:\th\minkernel\crts\ucrt\src\appcrt\startup\thread.cpp @ 91]
 
mysqld!thread_start<unsigned int (void * parameter = 0x00007ff7`b8df88f0) [d:\th\minkernel\crts\ucrt\src\appcrt\startup\thread.cpp @ 115]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
.  2  Id: 13a0.c3c Suspend: 0 Teb: 00007ff7`b7eea000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtRemoveIoCompletion
 
KERNELBASE!GetQueuedCompletionStatus
 
mysqld!os_aio_windows_handler(unsigned int64 segment = 0, unsigned int64 pos = 0, struct fil_node_t ** m1 = 0x00000074`f803f8b8, void ** m2 = 0x00000074`f803f908, class IORequest * type = 0x00000074`f803f8d8) [d:\winx64-debug\build\src\storage\innobase\os\os0file.cc @ 6541]
 
mysqld!os_aio_handler(unsigned int64 segment = 0, struct fil_node_t ** m1 = 0x00000074`f803f8b8, void ** m2 = 0x00000074`f803f908, class IORequest * request = 0x00000074`f803f8d8) [d:\winx64-debug\build\src\storage\innobase\os\os0file.cc @ 5736]
 
mysqld!fil_aio_wait(unsigned int64 segment = 0) [d:\winx64-debug\build\src\storage\innobase\fil\fil0fil.cc @ 5296]
 
mysqld!io_handler_thread(void * arg = 0x00007ff7`ba9a9d30) [d:\winx64-debug\build\src\storage\innobase\srv\srv0start.cc @ 344]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
.  8  Id: 13a0.b98 Suspend: 0 Teb: 00007ff7`b7dba000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!os_event::timed_wait(unsigned long time_in_ms = 0x3e8) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 262]
 
mysqld!os_event::wait_time_low(unsigned int64 time_in_usec = 0xf4240, int64 reset_sig_count = 0n2) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 415]
 
mysqld!os_event_wait_time_low(struct os_event * event = 0x00000074`f670ff30, unsigned int64 time_in_usec = 0xf4240, int64 reset_sig_count = 0n2) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 519]
 
mysqld!pc_sleep_if_needed(unsigned int64 next_loop_time = 0x0000015f`5cf68023, int64 sig_count = 0n2) [d:\winx64-debug\build\src\storage\innobase\buf\buf0flu.cc @ 2716]
 
mysqld!buf_flush_page_cleaner_coordinator(void * __formal = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\buf\buf0flu.cc @ 3211]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
.  9  Id: 13a0.138c Suspend: 0 Teb: 00007ff7`b7db6000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!os_event::timed_wait(unsigned long time_in_ms = 0x3e8) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 262]
 
mysqld!os_event::wait_time_low(unsigned int64 time_in_usec = 0xf4240, int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 415]
 
mysqld!os_event_wait_time_low(struct os_event * event = 0x00000074`f693c550, unsigned int64 time_in_usec = 0xf4240, int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 519]
 
mysqld!lock_wait_timeout_thread(void * __formal = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\lock\lock0wait.cc @ 530]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 10  Id: 13a0.82c Suspend: 0 Teb: 00007ff7`b7db4000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!ZwWaitForSingleObject
 
ntdll!RtlLockHeap
 
ntdll!RtlEnterCriticalSection
 
mysqld!fflush(struct _iobuf * stream = 0x00007ff7`ba91dda0) [d:\th\minkernel\crts\ucrt\src\appcrt\stdio\fflush.cpp @ 91]
 
mysqld!srv_error_monitor_thread(void * __formal = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 1967]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 11  Id: 13a0.1248 Suspend: 0 Teb: 00007ff7`b7db2000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!os_event::timed_wait(unsigned long time_in_ms = 0x1388) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 262]
 
mysqld!os_event::wait_time_low(unsigned int64 time_in_usec = 0x4c4b40, int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 415]
 
mysqld!os_event_wait_time_low(struct os_event * event = 0x00000074`f6710530, unsigned int64 time_in_usec = 0x4c4b40, int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 519]
 
mysqld!srv_monitor_thread(void * __formal = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 1746]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 12  Id: 13a0.f14 Suspend: 0 Teb: 00007ff7`b7db8000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtDelayExecution
 
KERNELBASE!SleepEx
 
mysqld!os_thread_sleep(unsigned int64 tm = 0xf4240) [d:\winx64-debug\build\src\storage\innobase\os\os0thread.cc @ 239]
 
mysqld!srv_master_sleep(void) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 2459]
 
mysqld!srv_master_thread(void * arg = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 2505]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 13  Id: 13a0.5a4 Suspend: 0 Teb: 00007ff7`b7db0000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!os_event::timed_wait(unsigned long time_in_ms = 0x2710) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 262]
 
mysqld!os_event::wait_time_low(unsigned int64 time_in_usec = 0x989680, int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 415]
 
mysqld!os_event_wait_time_low(struct os_event * event = 0x00000074`f693e0b0, unsigned int64 time_in_usec = 0x989680, int64 reset_sig_count = 0n0) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 519]
 
mysqld!dict_stats_thread(void * __formal = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\dict\dict0stats_bg.cc @ 454]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 14  Id: 13a0.13bc Suspend: 0 Teb: 00007ff7`b7dae000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!os_event::timed_wait(unsigned long time_in_ms = 0x1388) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 262]
 
mysqld!os_event::wait_time_low(unsigned int64 time_in_usec = 0x4c4b40, int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 415]
 
mysqld!os_event_wait_time_low(struct os_event * event = 0x00000074`f6929290, unsigned int64 time_in_usec = 0x4c4b40, int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 519]
 
mysqld!ib_wqueue_timedwait(struct ib_wqueue_t * wq = 0x00000074`f66dbf70, int64 wait_in_usecs = 0n5000000) [d:\winx64-debug\build\src\storage\innobase\ut\ut0wqueue.cc @ 161]
 
mysqld!fts_optimize_thread(void * arg = 0x00000074`f66dbf70) [d:\winx64-debug\build\src\storage\innobase\fts\fts0opt.cc @ 3030]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 15  Id: 13a0.cdc Suspend: 0 Teb: 00007ff7`b7dac000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!os_event::wait(void) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 159]
 
mysqld!os_event::wait_low(int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 340]
 
mysqld!os_event_wait_low(struct os_event * event = 0x00000074`f67106b0, int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 536]
 
mysqld!srv_resume_thread(struct srv_slot_t * slot = 0x00007ff7`ba9933b8, int64 sig_count = 0n1, bool wait = true, unsigned int64 timeout_usec = 0) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 943]
 
mysqld!srv_purge_coordinator_suspend(struct srv_slot_t * slot = 0x00007ff7`ba9933b8, unsigned int64 rseg_history_len = 6) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 2798]
 
mysqld!srv_purge_coordinator_thread(void * arg = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 2890]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 16  Id: 13a0.1130 Suspend: 0 Teb: 00007ff7`b7daa000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!os_event::wait(void) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 159]
 
mysqld!os_event::wait_low(int64 reset_sig_count = 0n2) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 340]
 
mysqld!os_event_wait_low(struct os_event * event = 0x00000074`f6710590, int64 reset_sig_count = 0n0) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 536]
 
mysqld!srv_resume_thread(struct srv_slot_t * slot = 0x00007ff7`ba993428, int64 sig_count = 0n0, bool wait = true, unsigned int64 timeout_usec = 0) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 943]
 
mysqld!srv_worker_thread(void * arg = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\srv\srv0srv.cc @ 2649]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 19  Id: 13a0.11b4 Suspend: 0 Teb: 00007ff7`b7da4000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!ZwGetContextThread
 
ntdll!RtlAllocateHeap
 
ntdll!RtlAllocateHeap
 
kernel32!MakeSortNode
 
 
 
. 20  Id: 13a0.9dc Suspend: 0 Teb: 00007ff7`b7da2000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtDelayExecution
 
KERNELBASE!SleepEx
 
mysqld!os_thread_sleep(unsigned int64 tm = 0xf4240) [d:\winx64-debug\build\src\storage\innobase\os\os0thread.cc @ 239]
 
mysqld!btr_defragment_thread(void * __formal = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\btr\btr0defragment.cc @ 761]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 21  Id: 13a0.aa8 Suspend: 0 Teb: 00007ff7`b7da0000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!os_event::wait(void) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 159]
 
mysqld!os_event::wait_low(int64 reset_sig_count = 0n1) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 340]
 
mysqld!os_event_wait_low(struct os_event * event = 0x00000074`f6710710, int64 reset_sig_count = 0n0) [d:\winx64-debug\build\src\storage\innobase\os\os0event.cc @ 536]
 
mysqld!buf_resize_thread(void * __formal = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\buf\buf0buf.cc @ 3081]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 22  Id: 13a0.880 Suspend: 0 Teb: 00007ff7`b7d9e000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!pthread_cond_timedwait(struct _RTL_CONDITION_VARIABLE * cond = 0x00000074`f955f738, struct _RTL_CRITICAL_SECTION * mutex = 0x00000074`f955f6e8, struct timespec * abstime = 0x00000000`00000000) [d:\winx64-debug\build\src\mysys\my_wincond.c @ 82]
 
mysqld!pthread_cond_wait(struct _RTL_CONDITION_VARIABLE * cond = 0x00000074`f955f738, struct _RTL_CRITICAL_SECTION * mutex = 0x00000074`f955f6e8) [d:\winx64-debug\build\src\mysys\my_wincond.c @ 91]
 
mysqld!inline_mysql_cond_wait(struct st_mysql_cond * that = 0x00000074`f955f738, struct st_mysql_mutex * mutex = 0x00000074`f955f6e8, char * src_file = 0x00007ff7`b9269bd0 "D:\winx64-debug\build\src\storage\innobase\handler\ha_innodb.cc", unsigned int src_line = 0x155) [d:\winx64-debug\build\src\include\mysql\psi\mysql_thread.h @ 1149]
 
mysqld!thd_destructor_proxy(void * __formal = 0x00000000`00000000) [d:\winx64-debug\build\src\storage\innobase\handler\ha_innodb.cc @ 341]
 
mysqld!pfs_spawn_thread(void * arg = 0x00000074`f69987c8) [d:\winx64-debug\build\src\storage\perfschema\pfs.cc @ 1865]
 
mysqld!pthread_start(void * p = 0x00000074`f69b42c0) [d:\winx64-debug\build\src\mysys\my_winthread.c @ 61]
 
(Inline Function) --------`-------- mysqld!invoke_thread_procedure [d:\th\minkernel\crts\ucrt\src\appcrt\startup\thread.cpp @ 91]
 
mysqld!thread_start<unsigned int (void * parameter = 0x00007ff7`b8df88f0) [d:\th\minkernel\crts\ucrt\src\appcrt\startup\thread.cpp @ 115]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 23  Id: 13a0.13d4 Suspend: 0 Teb: 00007ff7`b7d9c000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!NtWaitForAlertByThreadId
 
ntdll!RtlSleepConditionVariableCS
 
KERNELBASE!SleepConditionVariableCS
 
mysqld!pthread_cond_timedwait(struct _RTL_CONDITION_VARIABLE * cond = 0x00007ff7`bb1ac8f0, struct _RTL_CRITICAL_SECTION * mutex = 0x00007ff7`bb1ac8c0, struct timespec * abstime = 0x00000074`fafdf7b8) [d:\winx64-debug\build\src\mysys\my_wincond.c @ 82]
 
mysqld!inline_mysql_cond_timedwait(struct st_mysql_cond * that = 0x00007ff7`bb1ac8f0, struct st_mysql_mutex * mutex = 0x00007ff7`bb1ac8c0, struct timespec * abstime = 0x00000074`fafdf7b8, char * src_file = 0x00007ff7`ba711540 "--- memory read error at address 0x00007ff7`ba711540 ---", unsigned int src_line = 0x74) [d:\winx64-debug\build\src\include\mysql\psi\mysql_thread.h @ 1175]
 
mysqld!my_service_thread_sleep(struct st_ma_service_thread_control * control = 0x00007ff7`ba6e0780, unsigned int64 sleep_time = 0x00000006`c088e200) [d:\winx64-debug\build\src\storage\maria\ma_servicethread.c @ 119]
 
mysqld!ma_checkpoint_background(void * arg = 0x00000000`0000001e) [d:\winx64-debug\build\src\storage\maria\ma_checkpoint.c @ 709]
 
mysqld!pfs_spawn_thread(void * arg = 0x00000074`f69987c8) [d:\winx64-debug\build\src\storage\perfschema\pfs.cc @ 1865]
 
mysqld!pthread_start(void * p = 0x00000074`f69b41e0) [d:\winx64-debug\build\src\mysys\my_winthread.c @ 61]
 
(Inline Function) --------`-------- mysqld!invoke_thread_procedure [d:\th\minkernel\crts\ucrt\src\appcrt\startup\thread.cpp @ 91]
 
mysqld!thread_start<unsigned int (void * parameter = 0x00007ff7`b8df88f0) [d:\th\minkernel\crts\ucrt\src\appcrt\startup\thread.cpp @ 115]
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
. 24  Id: 13a0.554 Suspend: 0 Teb: 00007ff7`b7d9a000 Unfrozen
 
      Priority: 0  Priority class: 32
 
 
 
ntdll!ZwWaitForWorkViaWorkerFactory
 
ntdll!RtlFreeUnicodeString
 
kernel32!BaseThreadInitThunk
 
ntdll!RtlUserThreadStart
 
 
 
Total threads: 25
 
Duplicate callstacks: 7 (windbg thread #s follow):
 
3, 4, 5, 6, 7, 17, 18
 
quit:



 Comments   
Comment by Alice Sherepa [ 2017-11-03 ]

on 10.1 http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/10242/steps/test_2/logs/stdio

innodb.doublewrite '32k,innodb_plugin'   w3 [ fail ]  Found warnings/errors in server log file!
 
        Test ended at 2017-11-02 22:13:57
 
line
 
171102 22:13:52 [ERROR] mysqld got signal 11 ;

http://buildbot.askmonty.org/buildbot/builders/kvm-fulltest2/builds/10242/steps/test_2/logs/mysqld.1.err.3

CURRENT_TEST: innodb.doublewrite
 
2017-11-02 22:13:18 2815422272 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: Normal shutdown
 
 
 
2017-11-02 22:13:18 2815422272 [Note] Event Scheduler: Purging the queue. 0 events
 
2017-11-02 22:13:18 2835536704 [Note] InnoDB: FTS optimize thread exiting.
 
2017-11-02 22:13:18 2815422272 [Note] InnoDB: Starting shutdown...
 
2017-11-02 22:13:20 2815422272 [Note] InnoDB: Shutdown completed; log sequence number 3151910
 
2017-11-02 22:13:20 2815422272 [Note] Debug sync points hit:                   2136
 
2017-11-02 22:13:20 2815422272 [Note] Debug sync points executed:              0
 
2017-11-02 22:13:20 2815422272 [Note] Debug sync points max active per thread: 0
 
2017-11-02 22:13:20 2815422272 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: Shutdown complete
 
 
 
2017-11-02 22:13:20 3071912256 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3010 ...
 
2017-11-02 22:13:20 3071912256 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:20 3071912256 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:20 3071912256 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:20 3071912256 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:21 3071912256 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:22 3071912256 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:22 3071912256 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:22 3071912256 [Note] InnoDB: 5.6.37 started; log sequence number 3151910
 
2017-11-02 22:13:22 2812279616 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:22 3071912256 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:22 3071912256 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:22 3071912256 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:22 3071912256 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:22 3071912256 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:23 2891276096 [Note] InnoDB: Sync to disk of '"test"."t1"' started.
 
2017-11-02 22:13:23 2891276096 [Note] InnoDB: Stopping purge
 
2017-11-02 22:13:23 2891276096 [Note] InnoDB: Writing table metadata to './test/t1.cfg'
 
2017-11-02 22:13:23 2891276096 [Note] InnoDB: Table '"test"."t1"' flushed to disk
 
2017-11-02 22:13:23 2891276096 [Note] InnoDB: Deleting the meta-data file './test/t1.cfg'
 
2017-11-02 22:13:23 2891276096 [Note] InnoDB: Resuming purge
 
2017-11-02 22:13:23 2891276096 [Note] InnoDB: Saving InnoDB page number: 0
 
2017-11-02 22:13:23 2891276096 [Note] InnoDB: Dirtying page:0 of space:11
 
2017-11-02 22:13:23 3072452928 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3067 ...
 
2017-11-02 22:13:23 3072452928 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:23 3072452928 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:23 3072452928 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3151952
 
InnoDB: Error: Current page size 32768 !=  page size on page 16384
 
2017-11-02 22:13:23 3072452928 [ERROR] InnoDB: innodb-page-size mismatch in tablespace ./test/t1.ibd (table test/t1)
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size:1024 Pages to analyze:64
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size: 1024, Possible space_id count:0
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size:2048 Pages to analyze:64
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size: 2048, Possible space_id count:0
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size:4096 Pages to analyze:48
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size: 4096, Possible space_id count:0
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size:8192 Pages to analyze:24
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size: 8192, Possible space_id count:0
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size:16384 Pages to analyze:12
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size: 16384, Possible space_id count:0
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size:32768 Pages to analyze:6
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: VALID: space:11 page_no:1 page_size:32768
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: VALID: space:11 page_no:2 page_size:32768
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: VALID: space:11 page_no:3 page_size:32768
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Page size: 32768, Possible space_id count:1
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: space_id:11, Number of pages matched: 3/3 (32768)
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Chosen space:11
 
 
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Restoring page 0 of tablespace 11
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Writing 32768 bytes into file: ./test/t1.ibd
 
2017-11-02 22:13:23 3072452928 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
 
InnoDB: 1 transaction(s) which must be rolled back or cleaned up
 
InnoDB: in total 1 row operations to undo
 
InnoDB: Trx id counter is 3328
 
2017-11-02 22:13:24 3072452928 [Note] InnoDB: Starting final batch to recover 5 pages from redo log
 
2017-11-02 22:13:25 2885892928 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-11-02 22:13:25 ac033b40  InnoDB: Rolling back trx with id 2820, 1 rows to undo
 
2017-11-02 22:13:25 3072452928 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:25 2885892928 [Note] InnoDB: Rollback of trx with id 2820 completed
 
2017-11-02 22:13:25 2885892928 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-11-02 22:13:25 3072452928 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:25 3072452928 [Note] InnoDB: 5.6.37 started; log sequence number 3156408
 
2017-11-02 22:13:25 2813324096 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:25 3072452928 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:25 3072452928 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:25 3072452928 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:25 3072452928 [Note] Recovering after a crash using tc.log
 
2017-11-02 22:13:25 3072452928 [Note] Starting crash recovery...
 
2017-11-02 22:13:25 3072452928 [Note] Crash recovery finished.
 
2017-11-02 22:13:26 3072452928 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:26 3072452928 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:26 2823786304 [Note] InnoDB: Sync to disk of '"test"."t1"' started.
 
2017-11-02 22:13:26 2823786304 [Note] InnoDB: Stopping purge
 
2017-11-02 22:13:26 2823786304 [Note] InnoDB: Writing table metadata to './test/t1.cfg'
 
2017-11-02 22:13:26 2823786304 [Note] InnoDB: Table '"test"."t1"' flushed to disk
 
2017-11-02 22:13:26 2823786304 [Note] InnoDB: Deleting the meta-data file './test/t1.cfg'
 
2017-11-02 22:13:26 2823786304 [Note] InnoDB: Resuming purge
 
2017-11-02 22:13:26 2823786304 [Note] InnoDB: Saving InnoDB page number: 0
 
2017-11-02 22:13:26 2823786304 [Note] InnoDB: Dirtying page:0 of space:11
 
2017-11-02 22:13:26 3072059712 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3146 ...
 
2017-11-02 22:13:26 3072059712 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:26 3072059712 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:27 3072059712 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3156450
 
InnoDB: Error: Current page size 32768 !=  page size on page 16384
 
2017-11-02 22:13:27 3072059712 [ERROR] InnoDB: innodb-page-size mismatch in tablespace ./test/t1.ibd (table test/t1)
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size:1024 Pages to analyze:64
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size: 1024, Possible space_id count:0
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size:2048 Pages to analyze:64
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size: 2048, Possible space_id count:0
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size:4096 Pages to analyze:48
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size: 4096, Possible space_id count:0
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size:8192 Pages to analyze:24
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size: 8192, Possible space_id count:0
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size:16384 Pages to analyze:12
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size: 16384, Possible space_id count:0
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size:32768 Pages to analyze:6
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Log sequence number at the start 0 and the end 3156564 do not match.
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: VALID: space:11 page_no:1 page_size:32768
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: VALID: space:11 page_no:2 page_size:32768
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: VALID: space:11 page_no:3 page_size:32768
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Page size: 32768, Possible space_id count:1
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: space_id:11, Number of pages matched: 3/3 (32768)
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Chosen space:11
 
 
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Restoring page 0 of tablespace 11
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Writing 32768 bytes into file: ./test/t1.ibd
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
 
InnoDB: 1 transaction(s) which must be rolled back or cleaned up
 
InnoDB: in total 1 row operations to undo
 
InnoDB: Trx id counter is 3840
 
2017-11-02 22:13:27 3072059712 [Note] InnoDB: Starting final batch to recover 1 pages from redo log
 
2017-11-02 22:13:29 2885249856 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-11-02 22:13:29 abf96b40  InnoDB: Rolling back trx with id 3332, 1 rows to undo
 
2017-11-02 22:13:29 3072059712 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:29 2885249856 [Note] InnoDB: Rollback of trx with id 3332 completed
 
2017-11-02 22:13:29 2885249856 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-11-02 22:13:29 3072059712 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:29 3072059712 [Note] InnoDB: 5.6.37 started; log sequence number 3156564
 
2017-11-02 22:13:29 2812275520 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:29 3072059712 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:29 3072059712 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:29 3072059712 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:29 3072059712 [Note] Recovering after a crash using tc.log
 
2017-11-02 22:13:29 3072059712 [Note] Starting crash recovery...
 
2017-11-02 22:13:29 3072059712 [Note] Crash recovery finished.
 
2017-11-02 22:13:29 3072059712 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:29 3072059712 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:29 2891276096 [Note] InnoDB: Sync to disk of '"test"."t1"' started.
 
2017-11-02 22:13:29 2891276096 [Note] InnoDB: Stopping purge
 
2017-11-02 22:13:29 2891276096 [Note] InnoDB: Writing table metadata to './test/t1.cfg'
 
2017-11-02 22:13:29 2891276096 [Note] InnoDB: Table '"test"."t1"' flushed to disk
 
2017-11-02 22:13:29 2891276096 [Note] InnoDB: Deleting the meta-data file './test/t1.cfg'
 
2017-11-02 22:13:29 2891276096 [Note] InnoDB: Resuming purge
 
2017-11-02 22:13:29 2891276096 [Note] InnoDB: Saving InnoDB page number: 1
 
2017-11-02 22:13:29 2891276096 [Note] InnoDB: Dirtying page:1 of space:11
 
2017-11-02 22:13:30 3072432448 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3198 ...
 
2017-11-02 22:13:30 3072432448 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:30 3072432448 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:30 3072432448 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3156606
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
 
2017-11-02 22:13:30 3072432448 [Note] InnoDB: Recovered page 11:1 from the doublewrite buffer.
 
InnoDB: 1 transaction(s) which must be rolled back or cleaned up
 
InnoDB: in total 1 row operations to undo
 
InnoDB: Trx id counter is 4352
 
2017-11-02 22:13:31 3072432448 [Note] InnoDB: Starting final batch to recover 2 pages from redo log
 
2017-11-02 22:13:32 3072432448 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:32 3072432448 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:32 2885897024 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-11-02 22:13:32 ac034b40  InnoDB: Rolling back trx with id 3844, 1 rows to undo
 
2017-11-02 22:13:32 2885897024 [Note] InnoDB: Rollback of trx with id 3844 completed
 
2017-11-02 22:13:32 2885897024 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-11-02 22:13:32 3072432448 [Note] InnoDB: 5.6.37 started; log sequence number 3157123
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:32 2813328192 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:32 3072432448 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:32 3072432448 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:32 3072432448 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:32 3072432448 [Note] Recovering after a crash using tc.log
 
2017-11-02 22:13:32 3072432448 [Note] Starting crash recovery...
 
2017-11-02 22:13:32 3072432448 [Note] Crash recovery finished.
 
2017-11-02 22:13:33 3072432448 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:33 3072432448 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:33 2815393600 [Note] InnoDB: Sync to disk of '"test"."t1"' started.
 
2017-11-02 22:13:33 2815393600 [Note] InnoDB: Stopping purge
 
2017-11-02 22:13:33 2815393600 [Note] InnoDB: Writing table metadata to './test/t1.cfg'
 
2017-11-02 22:13:33 2815393600 [Note] InnoDB: Table '"test"."t1"' flushed to disk
 
2017-11-02 22:13:33 2815393600 [Note] InnoDB: Deleting the meta-data file './test/t1.cfg'
 
2017-11-02 22:13:33 2815393600 [Note] InnoDB: Resuming purge
 
2017-11-02 22:13:33 2815393600 [Note] InnoDB: Saving InnoDB page number: 1
 
2017-11-02 22:13:33 2815393600 [Note] InnoDB: Dirtying page:1 of space:11
 
2017-11-02 22:13:33 3072555328 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3327 ...
 
2017-11-02 22:13:33 3072555328 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:33 3072555328 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:33 3072555328 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:33 3072555328 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3157165
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Log sequence number at the start 0 and the end 3157682 do not match.
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Trying to recover page 11:1 from the doublewrite buffer.
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Recovered page 11:1 from the doublewrite buffer.
 
InnoDB: 1 transaction(s) which must be rolled back or cleaned up
 
InnoDB: in total 1 row operations to undo
 
InnoDB: Trx id counter is 4864
 
2017-11-02 22:13:34 3072555328 [Note] InnoDB: Starting final batch to recover 2 pages from redo log
 
2017-11-02 22:13:35 2885897024 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-11-02 22:13:35 ac034b40  InnoDB: Rolling back trx with id 4356, 1 rows to undo
 
2017-11-02 22:13:35 3072555328 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:35 2885897024 [Note] InnoDB: Rollback of trx with id 4356 completed
 
2017-11-02 22:13:35 2885897024 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-11-02 22:13:35 3072555328 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:35 3072555328 [Note] InnoDB: 5.6.37 started; log sequence number 3157682
 
2017-11-02 22:13:35 2813324096 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:35 3072555328 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:35 3072555328 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:35 3072555328 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:35 3072555328 [Note] Recovering after a crash using tc.log
 
2017-11-02 22:13:35 3072555328 [Note] Starting crash recovery...
 
2017-11-02 22:13:35 3072555328 [Note] Crash recovery finished.
 
2017-11-02 22:13:35 3072555328 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:35 3072555328 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:36 2890616640 [Note] InnoDB: Saving InnoDB page number: 0
 
2017-11-02 22:13:36 2890616640 [Note] InnoDB: Dirtying page:0 of space:0
 
2017-11-02 22:13:36 3071957312 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3384 ...
 
2017-11-02 22:13:36 3071957312 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:36 3071957312 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:36 3071957312 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:36 3071957312 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Completed initialization of buffer pool
 
InnoDB: Error: Current page size 32768 !=  page size on page 16384
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Restoring page 0 of tablespace 0
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Writing 32768 bytes into file: ibdata1
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3157724
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
 
InnoDB: 1 transaction(s) which must be rolled back or cleaned up
 
InnoDB: in total 1 row operations to undo
 
InnoDB: Trx id counter is 5376
 
2017-11-02 22:13:37 3071957312 [Note] InnoDB: Starting final batch to recover 2 pages from redo log
 
2017-11-02 22:13:38 3071957312 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:38 3071957312 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:38 2885249856 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-11-02 22:13:38 abf96b40  InnoDB: Rolling back trx with id 4868, 1 rows to undo
 
2017-11-02 22:13:38 2885249856 [Note] InnoDB: Rollback of trx with id 4868 completed
 
2017-11-02 22:13:38 2885249856 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-11-02 22:13:38 3071957312 [Note] InnoDB: 5.6.37 started; log sequence number 3158241
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:38 2812279616 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:38 3071957312 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:38 3071957312 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:38 3071957312 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:38 3071957312 [Note] Recovering after a crash using tc.log
 
2017-11-02 22:13:38 3071957312 [Note] Starting crash recovery...
 
2017-11-02 22:13:38 3071957312 [Note] Crash recovery finished.
 
2017-11-02 22:13:38 3071957312 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:38 3071957312 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:39 2891276096 [Note] InnoDB: Saving InnoDB page number: 0
 
2017-11-02 22:13:39 2891276096 [Note] InnoDB: Dirtying page:0 of space:0
 
2017-11-02 22:13:39 3071883584 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3474 ...
 
2017-11-02 22:13:39 3071883584 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:39 3071883584 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:39 3071883584 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:39 3071883584 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Completed initialization of buffer pool
 
InnoDB: Error: Current page size 32768 !=  page size on page 16384
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Restoring page 0 of tablespace 0
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Writing 32768 bytes into file: ibdata1
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3158283
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
 
InnoDB: 1 transaction(s) which must be rolled back or cleaned up
 
InnoDB: in total 1 row operations to undo
 
InnoDB: Trx id counter is 5888
 
2017-11-02 22:13:40 3071883584 [Note] InnoDB: Starting final batch to recover 2 pages from redo log
 
2017-11-02 22:13:42 2885249856 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-11-02 22:13:42 abf96b40  InnoDB: Rolling back trx with id 5380, 1 rows to undo
 
2017-11-02 22:13:42 3071883584 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:42 2885249856 [Note] InnoDB: Rollback of trx with id 5380 completed
 
2017-11-02 22:13:42 2885249856 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-11-02 22:13:42 3071883584 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:42 3071883584 [Note] InnoDB: 5.6.37 started; log sequence number 3158800
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:42 3071883584 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:42 3071883584 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:42 3071883584 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:42 3071883584 [Note] Recovering after a crash using tc.log
 
2017-11-02 22:13:42 3071883584 [Note] Starting crash recovery...
 
2017-11-02 22:13:42 2812275520 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:42 3071883584 [Note] Crash recovery finished.
 
2017-11-02 22:13:42 3071883584 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:42 3071883584 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:42 2889871168 [Note] InnoDB: Saving InnoDB page number: 1
 
2017-11-02 22:13:42 2889871168 [Note] InnoDB: Dirtying page:1 of space:0
 
2017-11-02 22:13:43 3072416064 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3522 ...
 
2017-11-02 22:13:43 3072416064 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:43 3072416064 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:43 3072416064 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3158842
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Recovered page 0:1 from the doublewrite buffer.
 
InnoDB: 1 transaction(s) which must be rolled back or cleaned up
 
InnoDB: in total 1 row operations to undo
 
InnoDB: Trx id counter is 6400
 
2017-11-02 22:13:43 3072416064 [Note] InnoDB: Starting final batch to recover 1 pages from redo log
 
2017-11-02 22:13:45 2885892928 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-11-02 22:13:45 ac033b40  InnoDB: Rolling back trx with id 5892, 1 rows to undo
 
2017-11-02 22:13:45 3072416064 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:45 2885892928 [Note] InnoDB: Rollback of trx with id 5892 completed
 
2017-11-02 22:13:45 2885892928 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-11-02 22:13:45 3072416064 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:45 3072416064 [Note] InnoDB: 5.6.37 started; log sequence number 3159359
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:45 2813324096 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:45 3072416064 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:45 3072416064 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:45 3072416064 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:45 3072416064 [Note] Recovering after a crash using tc.log
 
2017-11-02 22:13:45 3072416064 [Note] Starting crash recovery...
 
2017-11-02 22:13:45 3072416064 [Note] Crash recovery finished.
 
2017-11-02 22:13:45 3072416064 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:45 3072416064 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:45 2823786304 [Note] InnoDB: Saving InnoDB page number: 1
 
2017-11-02 22:13:45 2823786304 [Note] InnoDB: Dirtying page:1 of space:0
 
2017-11-02 22:13:46 3072301376 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3577 ...
 
2017-11-02 22:13:46 3072301376 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:46 3072301376 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:46 3072301376 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3159401
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Restoring possible half-written data pages from the doublewrite buffer...
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Log sequence number at the start 0 and the end 3159918 do not match.
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Trying to recover page 0:1 from the doublewrite buffer.
 
2017-11-02 22:13:46 3072301376 [Note] InnoDB: Recovered page 0:1 from the doublewrite buffer.
 
InnoDB: 1 transaction(s) which must be rolled back or cleaned up
 
InnoDB: in total 1 row operations to undo
 
InnoDB: Trx id counter is 6912
 
2017-11-02 22:13:47 3072301376 [Note] InnoDB: Starting final batch to recover 1 pages from redo log
 
2017-11-02 22:13:48 2885892928 [Note] InnoDB: Starting in background the rollback of recovered transactions
 
2017-11-02 22:13:48 ac033b40  InnoDB: Rolling back trx with id 6404, 1 rows to undo
 
2017-11-02 22:13:48 2885892928 [Note] InnoDB: Rollback of trx with id 6404 completed
 
2017-11-02 22:13:48 2885892928 [Note] InnoDB: Rollback of non-prepared transactions completed
 
2017-11-02 22:13:48 3072301376 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:48 3072301376 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:48 3072301376 [Note] InnoDB: 5.6.37 started; log sequence number 3159918
 
2017-11-02 22:13:48 2813324096 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:48 3072301376 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:48 3072301376 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:48 3072301376 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:48 3072301376 [Note] Recovering after a crash using tc.log
 
2017-11-02 22:13:48 3072301376 [Note] Starting crash recovery...
 
2017-11-02 22:13:48 3072301376 [Note] Crash recovery finished.
 
2017-11-02 22:13:48 3072301376 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:49 3072301376 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:49 2823483200 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: Normal shutdown
 
 
 
2017-11-02 22:13:49 2823483200 [Note] Event Scheduler: Purging the queue. 0 events
 
2017-11-02 22:13:49 2840574784 [Note] InnoDB: FTS optimize thread exiting.
 
2017-11-02 22:13:49 2823483200 [Note] InnoDB: Starting shutdown...
 
2017-11-02 22:13:50 2823483200 [Note] InnoDB: Shutdown completed; log sequence number 3161533
 
2017-11-02 22:13:50 2823483200 [Note] Debug sync points hit:                   344
 
2017-11-02 22:13:50 2823483200 [Note] Debug sync points executed:              0
 
2017-11-02 22:13:50 2823483200 [Note] Debug sync points max active per thread: 0
 
2017-11-02 22:13:50 2823483200 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: Shutdown complete
 
 
 
2017-11-02 22:13:51 3072088384 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3655 ...
 
2017-11-02 22:13:51 3072088384 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: The first specified data file /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/3/tmp/doublewrite/ibdata1 did not exist: a new database to be created!
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Setting file /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/3/tmp/doublewrite/ibdata1 size to 1 MB
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Data file /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/3/tmp/doublewrite/ibdata2 did not exist: new to be created
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Setting file /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/3/tmp/doublewrite/ibdata2 size to 1 MB
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Setting log file /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/3/tmp/doublewrite/ib_logfile101 size to 5 MB
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Setting log file /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/3/tmp/doublewrite/ib_logfile1 size to 5 MB
 
2017-11-02 22:13:51 3072088384 [Note] InnoDB: Renaming log file /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/3/tmp/doublewrite/ib_logfile101 to /mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/3/tmp/doublewrite/ib_logfile0
 
2017-11-02 22:13:51 3072088384 [Warning] InnoDB: New log files created, LSN=74142
 
2017-11-02 22:13:51 3072088384 [ERROR] InnoDB: Cannot create doublewrite buffer: the first file in innodb_data_file_path must be at least 6M.
 
2017-11-02 22:13:51 3072088384 [ERROR] InnoDB: Database creation was aborted at /home/buildbot/buildbot/build/mariadb-10.1.29/storage/innobase/srv/srv0start.cc [2832] with error Generic error. You may need to delete the ibdata1 file before trying to start up again.
 
2017-11-02 22:13:51 3072088384 [ERROR] Plugin 'InnoDB' init function returned error.
 
2017-11-02 22:13:51 3072088384 [ERROR] Plugin 'InnoDB' registration as a STORAGE ENGINE failed.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:51 3072088384 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:51 3072088384 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:51 3072088384 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:52 3072088384 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:52 3072088384 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution
 
2017-11-02 22:13:52 2885676864 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: Normal shutdown
 
 
 
2017-11-02 22:13:52 2885676864 [Note] Event Scheduler: Purging the queue. 0 events
 
2017-11-02 22:13:52 2885676864 [Note] Debug sync points hit:                   265
 
2017-11-02 22:13:52 2885676864 [Note] Debug sync points executed:              0
 
2017-11-02 22:13:52 2885676864 [Note] Debug sync points max active per thread: 0
 
2017-11-02 22:13:52 2885676864 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: Shutdown complete
 
 
 
171102 22:13:52 [ERROR] mysqld got signal 11 ;
 
This could be because you hit a bug. It is also possible that this binary
 
or one of the libraries it was linked against is corrupt, improperly built,
 
or misconfigured. This error can also be caused by malfunctioning hardware.
 
 
 
To report this bug, see https://mariadb.com/kb/en/reporting-bugs
 
 
 
We will try our best to scrape up some info that will hopefully help
 
diagnose the problem, but since we have already crashed, 
something is definitely wrong and this may fail.
 
 
 
Server version: 10.1.29-MariaDB-debug
 
read_buffer_size=131072
 
max_used_connections=1
 
thread_count=0
 
Thread pointer: 0x0
 
Attempting backtrace. You can use the following information to find out
 
where mysqld died. If you see no messages after this, something went
 
terribly wrong...
 
2017-11-02 22:13:54 3071990080 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld (mysqld 10.1.29-MariaDB-debug) starting as process 3726 ...
 
2017-11-02 22:13:54 3071990080 [Warning] Could not increase number of max_open_files to more than 1024 (request: 4162)
 
2017-11-02 22:13:54 3071990080 [Note] Plugin 'partition' is disabled.
 
2017-11-02 22:13:54 3071990080 [Note] Plugin 'SEQUENCE' is disabled.
 
2017-11-02 22:13:54 3071990080 [Note] InnoDB:  innodb-page-size has been changed from the default value 16384 to 32768.
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: Using mutexes to ref count buffer pool pages
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB:  InnoDB: !!!!!!!! UNIV_SYNC_DEBUG switched on !!!!!!!!!
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: The InnoDB memory heap is disabled
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: GCC builtin __sync_synchronize() is used for memory barrier
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: Compressed tables use zlib 1.2.3.4
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: Using Linux native AIO
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: Using generic crc32 instructions
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: Initializing buffer pool, size = 24.0M
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: Completed initialization of buffer pool
 
2017-11-02 22:13:55 3071990080 [Note] InnoDB: Highest supported file format is Barracuda.
 
2017-11-02 22:13:56 3071990080 [Note] InnoDB: 128 rollback segment(s) are active.
 
2017-11-02 22:13:56 3071990080 [Note] InnoDB: Waiting for purge to start
 
2017-11-02 22:13:56 3071990080 [Note] InnoDB: 5.6.37 started; log sequence number 3161533
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_SYS_DATAFILES' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_SYS_TABLESTATS' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_CMP' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'XTRADB_READ_VIEW' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'XTRADB_RSEG' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_FT_DELETED' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_LOCK_WAITS' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'CHANGED_PAGE_BITMAPS' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_TABLESPACES_ENCRYPTION' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_SYS_FIELDS' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'XTRADB_INTERNAL_HASH_TABLES' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_TABLESPACES_SCRUBBING' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_CMPMEM_RESET' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_FT_INDEX_TABLE' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_FT_BEING_DELETED' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_MUTEXES' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_FT_CONFIG' is disabled.
 
2017-11-02 22:13:56 2813328192 [Note] InnoDB: Dumping buffer pool(s) not yet started
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'FEEDBACK' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_FT_INDEX_CACHE' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_FT_DEFAULT_STOPWORD' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_CMP_RESET' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_SYS_COLUMNS' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_CMP_PER_INDEX_RESET' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_SYS_TABLESPACES' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_SYS_SEMAPHORE_WAITS' is disabled.
 
2017-11-02 22:13:56 3071990080 [Note] Plugin 'INNODB_SYS_INDEXES' is disabled.
 
2017-11-02 22:13:56 3071990080 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-pam-debug'
 
2017-11-02 22:13:56 3071990080 [Warning] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: unknown option '--loose-skip-plugin-innodb-changed-pages'
 
2017-11-02 22:13:56 3071990080 [Note] Server socket created on IP: '127.0.0.1'.
 
2017-11-02 22:13:56 3071990080 [Note] /mnt/buildbot/build/mariadb-10.1.29/sql/mysqld: ready for connections.
 
Version: '10.1.29-MariaDB-debug'  socket: '/mnt/buildbot/build/mariadb-10.1.29/mysql-test/var/tmp/3/mysqld.1.sock'  port: 16000  Source distribution

Comment by Marko Mäkelä [ 2017-11-03 ]

alice, your report of a server crash at shutdown after failed InnoDB startup is a known problem that I fixed in 10.2. It is not easily fixable in 10.1 or earlier versions, because it would require very intrusive refactoring of the startup and shutdown code.

It also is unrelated to the original report, which is a crash at server startup when InnoDB is invoking sql_print_information(). This crash is theoretically possible in 10.0 and 10.1 as well, depending on what causes the problem.

In any case, I would suggest to change the bug title not to refer to innodb.doublewrite, because both failures (the startup crash and the shutdown crash) are possible also in other tests, and neither failure has anything directly to do with the InnoDB doublewrite buffer.

Comment by Vladislav Vaintroub [ 2017-11-08 ]

changed the title to reflect the actual problem, in the original crash.

Generated at Thu Feb 08 08:11:44 UTC 2024 using Jira 8.20.16#820016-sha1:9d11dbea5f4be3d4cc21f03a88dd11d8c8687422.