Details
-
Bug
-
Status: Closed (View Workflow)
-
Major
-
Resolution: Won't Fix
-
10.2.9
-
None
Description
|
{co2017-10-03 10:09:43 140697453811456 [Warning] Aborted connection 86605 to db: 'pmacontrol' user: 'root' host: '127.0.0.1' (Got timeout reading communication packets) |
/home/buildbot/buildbot/build/mariadb-10.2.9/storage/tokudb/PerconaFT/ft/ule.cc:1295 leafentry_memsize: Assertion `false' failed (errno=0) |
: Success
|
Backtrace: (Note: toku_do_assert=0x0x7ff6c97cd430)
|
/usr/lib/mysql/plugin/ha_tokudb.so(_Z19db_env_do_backtraceP8_IO_FILE+0x2e)[0x7ff6c97cccae] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0x10ede3)[0x7ff6c97ccde3] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0x10f18e)[0x7ff6c97cd18e] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z17leafentry_memsizeP9leafentry+0x67)[0x7ff6c97e1d67] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z26toku_ftnode_leaf_rebalanceP6ftnodej+0x522)[0x7ff6c97872a2] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z31toku_serialize_ftnode_to_memoryP6ftnodePP16ftnode_disk_dataj23toku_compression_methodbbPmS5_PPc+0xf05)[0x7ff6c9798b85] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z24toku_serialize_ftnode_toi10blocknum_sP6ftnodePP16ftnode_disk_databP2ftb+0x5b)[0x7ff6c979903b] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z26toku_ftnode_flush_callbackP9cachefilei10blocknum_sPvPS2_S2_11pair_attr_sPS4_bbbb+0x190)[0x7ff6c97bed20] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0xa6c19)[0x7ff6c9764c19] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0xa6ddc)[0x7ff6c9764ddc] |
/usr/lib/mysql/plugin/ha_tokudb.so(_ZN7evictor10evict_pairEP6ctpairb+0x200)[0x7ff6c97c4750] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0xa8148)[0x7ff6c9766148] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0xbc76c)[0x7ff6c977a76c] |
/lib/x86_64-linux-gnu/libpthread.so.0(+0x76ba)[0x7ff6e25a46ba] |
/lib/x86_64-linux-gnu/libc.so.6(clone+0x6d)[0x7ff6e1c4f3dd] |
Engine status:
|
BUILD_ID = 0 |
Env panic code: 18446744073709551615 |
Env panic string: /home/buildbot/buildbot/build/mariadb-10.2.9/storage/tokudb/PerconaFT/ft/ule.cc:1295 leafentry_memsize: Assertion `false' failed (errno=0) |
|
time of environment creation: Thu Sep 21 15:54:55 2017 |
time of engine startup: Mon Oct 2 10:54:57 2017 |
time now: Tue Oct 3 10:17:39 2017 |
db opens: 695974 |
db closes: 694294 |
num open dbs now: 1680 |
max open dbs: 2244 |
period, in ms, that recovery log is automatically fsynced: 0 |
dictionary inserts: 129755 |
dictionary inserts fail: 0 |
dictionary deletes: 0 |
dictionary deletes fail: 0 |
dictionary updates: 0 |
dictionary updates fail: 0 |
dictionary broadcast updates: 0 |
dictionary broadcast updates fail: 0 |
dictionary multi inserts: 99298090 |
dictionary multi inserts fail: 0 |
dictionary multi deletes: 0 |
dictionary multi deletes fail: 0 |
dictionary updates multi: 0 |
dictionary updates multi fail: 0 |
le: max committed xr: 1 |
le: max provisional xr: 1 |
le: expanded: 0 |
le: max memsize: 708 |
le: size of leafentries before garbage collection (during message application): 2619919647 |
le: size of leafentries after garbage collection (during message application): 943001584 |
le: size of leafentries before garbage collection (outside message application): 0 |
le: size of leafentries after garbage collection (outside message application): 0 |
checkpoint: period: 60 |
checkpoint: footprint: 40 |
checkpoint: last checkpoint began: Tue Oct 3 10:17:38 2017 |
checkpoint: last complete checkpoint began: Tue Oct 3 10:16:38 2017 |
checkpoint: last complete checkpoint ended: Tue Oct 3 10:17:23 2017 |
checkpoint: time spent during checkpoint (begin and end phases): 19214 |
checkpoint: time spent during last checkpoint (begin and end phases): 45 |
checkpoint: last complete checkpoint LSN: 94106941 |
checkpoint: checkpoints taken : 1400 |
checkpoint: checkpoints failed: 0 |
checkpoint: waiters now: 0 |
checkpoint: waiters max: 0 |
checkpoint: non-checkpoint client wait on mo lock: 139 |
checkpoint: non-checkpoint client wait on cs lock: 0 |
checkpoint: checkpoint begin time: 20667101 |
checkpoint: long checkpoint begin time: 0 |
checkpoint: long checkpoint begin count: 0 |
checkpoint: checkpoint end time: 19126891362 |
checkpoint: long checkpoint end time: 1750336741 |
checkpoint: long checkpoint end count: 26 |
cachetable: miss: 794921 |
cachetable: miss time: 9885784113 |
cachetable: prefetches: 0 |
cachetable: size current: 2285137761 |
cachetable: size limit: 2362232012 |
cachetable: size writing: 94149001 |
cachetable: size nonleaf: 54151194 |
cachetable: size leaf: 2227659055 |
cachetable: size rollback: 159440 |
cachetable: size cachepressure: 60194754 |
cachetable: size currently cloned data for checkpoint: 3168072 |
cachetable: evictions: 793034 |
cachetable: cleaner executions: 115711 |
cachetable: cleaner period: 1 |
cachetable: cleaner iterations: 5 |
cachetable: number of waits on cache pressure: 331 |
cachetable: time waiting on cache pressure: 1488213799 |
cachetable: number of long waits on cache pressure: 331 |
cachetable: long time waiting on cache pressure: 1488213799 |
cachetable: client pool: number of threads in pool: 4 |
cachetable: client pool: number of currently active threads in pool: 0 |
cachetable: client pool: number of currently queued work items: 0 |
cachetable: client pool: largest number of queued work items: 2 |
cachetable: client pool: total number of work items processed: 3010 |
cachetable: client pool: total execution time of processing work items: 2039 |
cachetable: cachetable pool: number of threads in pool: 8 |
cachetable: cachetable pool: number of currently active threads in pool: 8 |
cachetable: cachetable pool: number of currently queued work items: 11 |
cachetable: cachetable pool: largest number of queued work items: 325 |
cachetable: cachetable pool: total number of work items processed: 582417 |
cachetable: cachetable pool: total execution time of processing work items: 117775624 |
cachetable: checkpoint pool: number of threads in pool: 1 |
cachetable: checkpoint pool: number of currently active threads in pool: 0 |
cachetable: checkpoint pool: number of currently queued work items: 0 |
cachetable: checkpoint pool: largest number of queued work items: 43 |
cachetable: checkpoint pool: total number of work items processed: 48690 |
cachetable: checkpoint pool: total execution time of processing work items: 243212 |
locktree: memory size: 120264 |
locktree: memory size limit: 268435456 |
locktree: number of times lock escalation ran: 0 |
locktree: time spent running escalation (seconds): 0.000000 |
locktree: latest post-escalation memory size: 0 |
locktree: number of locktrees open now: 1682 |
locktree: number of pending lock requests: 0 |
locktree: number of locktrees eligible for the STO: 10 |
locktree: number of times a locktree ended the STO early: 704 |
locktree: time spent ending the STO early (seconds): 0.010853 |
locktree: number of wait locks: 0 |
locktree: time waiting for locks: 0 |
locktree: number of long wait locks: 0 |
locktree: long time waiting for locks: 0 |
locktree: number of lock timeouts: 0 |
locktree: number of waits on lock escalation: 0 |
locktree: time waiting on lock escalation: 0 |
locktree: number of long waits on lock escalation: 0 |
locktree: long time waiting on lock escalation: 0 |
ft: dictionary updates: 0 |
ft: dictionary broadcast updates: 0 |
ft: descriptor set: 0 |
ft: messages ignored by leaf due to msn: 2508532 |
ft: total search retries due to TRY_AGAIN: 4033414 |
ft: searches requiring more tries than the height of the tree: 0 |
ft: searches requiring more tries than the height of the tree plus three: 0 |
ft: leaf nodes flushed to disk (not for checkpoint): 451920 |
ft: leaf nodes flushed to disk (not for checkpoint) (bytes): 210827311104 |
ft: leaf nodes flushed to disk (not for checkpoint) (uncompressed bytes): 870471920993 |
ft: leaf nodes flushed to disk (not for checkpoint) (seconds): 1422.027075 |
ft: nonleaf nodes flushed to disk (not for checkpoint): 33329 |
ft: nonleaf nodes flushed to disk (not for checkpoint) (bytes): 4028425728 |
ft: nonleaf nodes flushed to disk (not for checkpoint) (uncompressed bytes): 19736065759 |
ft: nonleaf nodes flushed to disk (not for checkpoint) (seconds): 63.015751 |
ft: leaf nodes flushed to disk (for checkpoint): 343491 |
ft: leaf nodes flushed to disk (for checkpoint) (bytes): 85472520192 |
ft: leaf nodes flushed to disk (for checkpoint) (uncompressed bytes): 349135475509 |
ft: leaf nodes flushed to disk (for checkpoint) (seconds): 216.904457 |
ft: nonleaf nodes flushed to disk (for checkpoint): 136661 |
ft: nonleaf nodes flushed to disk (for checkpoint) (bytes): 1298801152 |
ft: nonleaf nodes flushed to disk (for checkpoint) (uncompressed bytes): 6035772873 |
ft: nonleaf nodes flushed to disk (for checkpoint) (seconds): 27.098541 |
ft: uncompressed / compressed bytes written (leaf): UNKNOWN STATUS TYPE: 6 |
ft: uncompressed / compressed bytes written (nonleaf): UNKNOWN STATUS TYPE: 6 |
ft: uncompressed / compressed bytes written (overall): UNKNOWN STATUS TYPE: 6 |
ft: nonleaf node partial evictions: 763 |
ft: nonleaf node partial evictions (bytes): 4782283 |
ft: leaf node partial evictions: 6639438 |
ft: leaf node partial evictions (bytes): 690646658667 |
ft: leaf node full evictions: 693515 |
ft: leaf node full evictions (bytes): 1522900773184 |
ft: nonleaf node full evictions: 99521 |
ft: nonleaf node full evictions (bytes): 41981460638 |
ft: leaf nodes created: 992 |
ft: nonleaf nodes created: 244 |
ft: leaf nodes destroyed: 0 |
ft: nonleaf nodes destroyed: 0 |
ft: bytes of messages injected at root (all trees): 705629254 |
ft: bytes of messages flushed from h1 nodes to leaves: 646156624 |
ft: bytes of messages currently in trees (estimate): 59472630 |
ft: messages injected at root: 16655630 |
ft: broadcast messages injected at root: 0 |
ft: basements decompressed as a target of a query: 509 |
ft: basements decompressed for prelocked range: 0 |
ft: basements decompressed for prefetch: 0 |
ft: basements decompressed for write: 787259 |
ft: buffers decompressed as a target of a query: 44958 |
ft: buffers decompressed for prelocked range: 0 |
ft: buffers decompressed for prefetch: 0 |
ft: buffers decompressed for write: 117387 |
ft: pivots fetched for query: 220132 |
ft: pivots fetched for query (bytes): 4385743872 |
ft: pivots fetched for query (seconds): 13.004150 |
ft: pivots fetched for prefetch: 0 |
ft: pivots fetched for prefetch (bytes): 0 |
ft: pivots fetched for prefetch (seconds): 0.000000 |
ft: pivots fetched for write: 399328 |
ft: pivots fetched for write (bytes): 12168103424 |
ft: pivots fetched for write (seconds): 115.709433 |
ft: basements fetched as a target of a query: 4098932 |
ft: basements fetched as a target of a query (bytes): 60538810880 |
ft: basements fetched as a target of a query (seconds): 69.913516 |
ft: basements fetched for prelocked range: 0 |
ft: basements fetched for prelocked range (bytes): 0 |
ft: basements fetched for prelocked range (seconds): 0.000000 |
ft: basements fetched for prefetch: 0 |
ft: basements fetched for prefetch (bytes): 0 |
ft: basements fetched for prefetch (seconds): 0.000000 |
ft: basements fetched for write: 18026803 |
ft: basements fetched for write (bytes): 292461522944 |
ft: basements fetched for write (seconds): 288.292649 |
ft: buffers fetched as a target of a query: 0 |
ft: buffers fetched as a target of a query (bytes): 0 |
ft: buffers fetched as a target of a query (seconds): 0.000000 |
ft: buffers fetched for prelocked range: 0 |
ft: buffers fetched for prelocked range (bytes): 0 |
ft: buffers fetched for prelocked range (seconds): 0.000000 |
ft: buffers fetched for prefetch: 0 |
ft: buffers fetched for prefetch (bytes): 0 |
ft: buffers fetched for prefetch (seconds): 0.000000 |
ft: buffers fetched for write: 121785 |
ft: buffers fetched for write (bytes): 2549355520 |
ft: buffers fetched for write (seconds): 2.969267 |
ft: leaf compression to memory (seconds): 77570.407047 |
ft: leaf serialization to memory (seconds): 3247.217712 |
ft: leaf decompression to memory (seconds): 11218.107886 |
ft: leaf deserialization to memory (seconds): 1802.653140 |
ft: nonleaf compression to memory (seconds): 1654.316714 |
ft: nonleaf serialization to memory (seconds): 140.540604 |
ft: nonleaf decompression to memory (seconds): 145.489175 |
ft: nonleaf deserialization to memory (seconds): 304.036422 |
ft: promotion: roots split: 244 |
ft: promotion: leaf roots injected into: 16047522 |
ft: promotion: h1 roots injected into: 16655336 |
ft: promotion: injections at depth 0: 294 |
ft: promotion: injections at depth 1: 27039443 |
ft: promotion: injections at depth 2: 0 |
ft: promotion: injections at depth 3: 0 |
ft: promotion: injections lower than depth 3: 0 |
ft: promotion: stopped because of a nonempty buffer: 0 |
ft: promotion: stopped at height 1: 294 |
ft: promotion: stopped because the child was locked or not at all in memory: 0 |
ft: promotion: stopped because the child was not fully in memory: 0 |
ft: promotion: stopped anyway, after locking the child: 0 |
ft: basement nodes deserialized with fixed-keysize: 22907059 |
ft: basement nodes deserialized with variable-keysize: 109600 |
ft: promotion: succeeded in using the rightmost leaf shortcut: 39834854 |
ft: promotion: tried the rightmost leaf shorcut but failed (out-of-bounds): 65969 |
ft: promotion: tried the rightmost leaf shorcut but failed (child reactive): 53803 |
ft: cursor skipped deleted leaf entries: 0 |
ft flusher: total nodes potentially flushed by cleaner thread: 35649 |
ft flusher: height-one nodes flushed by cleaner thread: 35649 |
ft flusher: height-greater-than-one nodes flushed by cleaner thread: 0 |
ft flusher: nodes cleaned which had empty buffers: 187 |
ft flusher: nodes dirtied by cleaner thread: 53774 |
ft flusher: max bytes in a buffer flushed by cleaner thread: 2745000 |
ft flusher: min bytes in a buffer flushed by cleaner thread: 43 |
ft flusher: total bytes in buffers flushed by cleaner thread: 615866959 |
ft flusher: max workdone in a buffer flushed by cleaner thread: 812592 |
ft flusher: min workdone in a buffer flushed by cleaner thread: 0 |
ft flusher: total workdone in buffers flushed by cleaner thread: 393872235 |
ft flusher: times cleaner thread tries to merge a leaf: 0 |
ft flusher: cleaner thread leaf merges in progress: 0 |
ft flusher: cleaner thread leaf merges successful: 0 |
ft flusher: nodes dirtied by cleaner thread leaf merges: 0 |
ft flusher: total number of flushes done by flusher threads or cleaner threads: 38472 |
ft flusher: number of in memory flushes: 38472 |
ft flusher: number of flushes that read something off disk: 0 |
ft flusher: number of flushes that triggered another flush in child: 0 |
ft flusher: number of flushes that triggered 1 cascading flush: 0 |
ft flusher: number of flushes that triggered 2 cascading flushes: 0 |
ft flusher: number of flushes that triggered 3 cascading flushes: 0 |
ft flusher: number of flushes that triggered 4 cascading flushes: 0 |
ft flusher: number of flushes that triggered 5 cascading flushes: 0 |
ft flusher: number of flushes that triggered over 5 cascading flushes: 0 |
ft flusher: leaf node splits: 992 |
ft flusher: nonleaf node splits: 0 |
ft flusher: leaf node merges: 0 |
ft flusher: nonleaf node merges: 0 |
ft flusher: leaf node balances: 0 |
hot: operations ever started: 0 |
hot: operations successfully completed: 0 |
hot: operations aborted: 0 |
hot: max number of flushes from root ever required to optimize a tree: 0 |
txn: begin: 1487436 |
txn: begin read only: 0 |
txn: successful commits: 1487434 |
txn: aborts: 0 |
logger: next LSN: 94150486 |
logger: writes: 194942 |
logger: writes (bytes): 2339679551 |
logger: writes (uncompressed bytes): 2339679551 |
logger: writes (seconds): 33.515215 |
logger: number of long logger write operations: 0 |
indexer: number of indexers successfully created: 0 |
indexer: number of calls to toku_indexer_create_indexer() that failed: 0 |
indexer: number of calls to indexer->build() succeeded: 0 |
indexer: number of calls to indexer->build() failed: 0 |
indexer: number of calls to indexer->close() that succeeded: 0 |
indexer: number of calls to indexer->close() that failed: 0 |
indexer: number of calls to indexer->abort(): 0 |
indexer: number of indexers currently in existence: 0 |
indexer: max number of indexers that ever existed simultaneously: 0 |
loader: number of loaders successfully created: 0 |
loader: number of calls to toku_loader_create_loader() that failed: 0 |
loader: number of calls to loader->put() succeeded: 0 |
loader: number of calls to loader->put() failed: 0 |
loader: number of calls to loader->close() that succeeded: 0 |
loader: number of calls to loader->close() that failed: 0 |
loader: number of calls to loader->abort(): 0 |
loader: number of loaders currently in existence: 0 |
loader: max number of loaders that ever existed simultaneously: 0 |
memory: number of malloc operations: 0 |
memory: number of free operations: 0 |
memory: number of realloc operations: 0 |
memory: number of malloc operations that failed: 0 |
memory: number of realloc operations that failed: 116 |
memory: number of bytes requested: 0 |
memory: number of bytes used (requested + overhead): 0 |
memory: number of bytes freed: 0 |
memory: largest attempted allocation size: 0 |
memory: size of the last failed allocation attempt: 0 |
memory: estimated maximum memory footprint: 0 |
memory: mallocator version: 3.6.0-0-g46c0af68bd248b04df75e4f92d5fb804c3d75340 |
memory: mmap threshold: 4194304 |
filesystem: ENOSPC redzone state: 0 |
filesystem: threads currently blocked by full disk: 0 |
filesystem: number of operations rejected by enospc prevention (red zone): 0 |
filesystem: most recent disk full: Thu Jan 1 01:00:00 1970 |
filesystem: number of write operations that returned ENOSPC: 0 |
filesystem: fsync time: 14156820171 |
filesystem: fsync count: 1995117 |
filesystem: long fsync time: 183958200 |
filesystem: long fsync count: 136 |
context: tree traversals blocked by a full fetch: 0 |
context: tree traversals blocked by a partial fetch: 22 |
context: tree traversals blocked by a full eviction: 196 |
context: tree traversals blocked by a partial eviction: 141 |
context: tree traversals blocked by a message injection: 11 |
context: tree traversals blocked by a message application: 0 |
context: tree traversals blocked by a flush: 7 |
context: tree traversals blocked by a the cleaner thread: 5 |
context: tree traversals blocked by something uninstrumented: 59 |
context: promotion blocked by a full fetch (should never happen): 0 |
context: promotion blocked by a partial fetch (should never happen): 0 |
context: promotion blocked by a full eviction (should never happen): 174 |
context: promotion blocked by a partial eviction (should never happen): 108 |
context: promotion blocked by a message injection: 2 |
context: promotion blocked by a message application: 0 |
context: promotion blocked by a flush: 0 |
context: promotion blocked by the cleaner thread: 26 |
context: promotion blocked by something uninstrumented: 47 |
context: something uninstrumented blocked by something uninstrumented: 5 |
|
Memory usage:
|
Arena 0: |
system bytes = 768806912 |
in use bytes = 121382432 |
Arena 1: |
system bytes = 258048 |
in use bytes = 231808 |
Arena 2: |
system bytes = 221184 |
in use bytes = 193920 |
Arena 3: |
system bytes = 245760 |
in use bytes = 218704 |
Arena 4: |
system bytes = 6533120 |
in use bytes = 632784 |
Arena 5: |
system bytes = 439033856 |
in use bytes = 130988272 |
Arena 6: |
system bytes = 299008 |
in use bytes = 229856 |
Arena 7: |
system bytes = 449957888 |
in use bytes = 1689808 |
Arena 8: |
system bytes = 381480960 |
in use bytes = 1189360 |
Arena 9: |
system bytes = 381857792 |
in use bytes = 1272800 |
Arena 10: |
system bytes = 454225920 |
in use bytes = 255170880 |
Arena 11: |
system bytes = 65470464 |
in use bytes = 398480 |
Arena 12: |
system bytes = 198656000 |
in use bytes = 127922544 |
Arena 13: |
system bytes = 181026816 |
in use bytes = 169352208 |
Arena 14: |
system bytes = 131108864 |
in use bytes = 92427744 |
Arena 15: |
system bytes = 166125568 |
in use bytes = 112532944 |
Arena 16: |
system bytes = 139440128 |
in use bytes = 56296624 |
Arena 17: |
system bytes = 418557952 |
in use bytes = 287787472 |
Arena 18: |
system bytes = 553078784 |
in use bytes = 1952176 |
Arena 19: |
system bytes = 154816512 |
in use bytes = 84107456 |
Arena 20: |
system bytes = 32391168 |
in use bytes = 10240176 |
Arena 21: |
system bytes = 974577664 |
in use bytes = 25867872 |
Arena 22: |
system bytes = 22007808 |
in use bytes = 7680976 |
Arena 23: |
system bytes = 52895744 |
in use bytes = 11061088 |
Arena 24: |
system bytes = 106205184 |
in use bytes = 95035616 |
Arena 25: |
system bytes = 51339264 |
in use bytes = 9325168 |
Arena 26: |
system bytes = 69746688 |
in use bytes = 13922160 |
Arena 27: |
system bytes = 49127424 |
in use bytes = 8474928 |
Arena 28: |
system bytes = 57708544 |
in use bytes = 11203328 |
Arena 29: |
system bytes = 73355264 |
in use bytes = 11609808 |
Arena 30: |
system bytes = 266240 |
in use bytes = 195984 |
Arena 31: |
system bytes = 221184 |
in use bytes = 193440 |
Total (incl. mmap):
|
system bytes = 3676958720 |
in use bytes = 3241671120 |
max mmap regions = 16857 |
max mmap bytes = 2748510208 |
171003 10:17:40 [ERROR] mysqld got signal 6 ; |
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.9-MariaDB-10.2.9+maria~xenial |
key_buffer_size=134217728 |
read_buffer_size=2097152 |
max_used_connections=13 |
max_threads=302 |
thread_count=96 |
It is possible that mysqld could use up to
|
key_buffer_size + (read_buffer_size + sort_buffer_size)*max_threads = 1992930 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...
|
stack_bottom = 0x0 thread_stack 0x49000 |
/usr/sbin/mysqld(my_print_stacktrace+0x2e)[0x5584ebc427ee] |
/usr/sbin/mysqld(handle_fatal_signal+0x305)[0x5584eb6db535] |
/lib/x86_64-linux-gnu/libpthread.so.0(+0x11390)[0x7ff6e25ae390] |
/lib/x86_64-linux-gnu/libc.so.6(gsignal+0x38)[0x7ff6e1b7d428] |
/lib/x86_64-linux-gnu/libc.so.6(abort+0x16a)[0x7ff6e1b7f02a] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0x10ede8)[0x7ff6c97ccde8] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0x10f18e)[0x7ff6c97cd18e] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z17leafentry_memsizeP9leafentry+0x67)[0x7ff6c97e1d67] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z26toku_ftnode_leaf_rebalanceP6ftnodej+0x522)[0x7ff6c97872a2] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z31toku_serialize_ftnode_to_memoryP6ftnodePP16ftnode_disk_dataj23toku_compression_methodbbPmS5_PPc+0xf05)[0x7ff6c9798b85] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z24toku_serialize_ftnode_toi10blocknum_sP6ftnodePP16ftnode_disk_databP2ftb+0x5b)[0x7ff6c979903b] |
/usr/lib/mysql/plugin/ha_tokudb.so(_Z26toku_ftnode_flush_callbackP9cachefilei10blocknum_sPvPS2_S2_11pair_attr_sPS4_bbbb+0x190)[0x7ff6c97bed20] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0xa6c19)[0x7ff6c9764c19] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0xa6ddc)[0x7ff6c9764ddc] |
/usr/lib/mysql/plugin/ha_tokudb.so(_ZN7evictor10evict_pairEP6ctpairb+0x200)[0x7ff6c97c4750] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0xa8148)[0x7ff6c9766148] |
/usr/lib/mysql/plugin/ha_tokudb.so(+0xbc76c)[0x7ff6c977a76c] |
/lib/x86_64-linux-gnu/libpthread.so.0(+0x76ba)[0x7ff6e25a46ba] |
/lib/x86_64-linux-gnu/libc.so.6(clone+0x6d)[0x7ff6e1c4f3dd] |
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.
|
Tue Oct 3 10:17:47 2017 PerconaFT recovery starting in env /var/lib/mysql/ |
Tue Oct 3 10:17:47 2017 PerconaFT recovery scanning backward from 94150229 |
Tue Oct 3 10:17:47 2017 PerconaFT recovery bw_begin_checkpoint at 94146924 timestamp 1507018658165636 (bw_newer) |
Tue Oct 3 10:17:47 2017 PerconaFT recovery bw_end_checkpoint at 94138125 timestamp 1507018639805034 xid 94106941 (bw_newer) |
Tue Oct 3 10:17:47 2017 PerconaFT recovery bw_begin_checkpoint at 94106941 timestamp 1507018598954654 (bw_between) |
Tue Oct 3 10:17:47 2017 PerconaFT recovery turning around at begin checkpoint 94106941 time 40850380 |
Tue Oct 3 10:17:47 2017 PerconaFT recovery starts scanning forward to 94150229 from 94106941 left 43288 (fw_between) |
Tue Oct 3 10:18:02 2017 PerconaFT recovery scanning forward to 94150229 at 94144941 left 5288 (fw_newer) |
Tue Oct 3 10:18:07 2017 PerconaFT recovery has 2 live transactions |
recover_abort_live_txn 3814099 |
recover_abort_live_txn 3814103 |
Tue Oct 3 10:18:07 2017 PerconaFT recovery closing 1704 dictionaries |
Tue Oct 3 10:18:52 2017 PerconaFT recovery starting in env /var/lib/mysql/ |
Tue Oct 3 10:18:52 2017 PerconaFT recovery scanning backward from 94150229 |
Tue Oct 3 10:18:52 2017 PerconaFT recovery bw_begin_checkpoint at 94146924 timestamp 1507018658165636 (bw_newer) |
Tue Oct 3 10:18:52 2017 PerconaFT recovery bw_end_checkpoint at 94138125 timestamp 1507018639805034 xid 94106941 (bw_newer) |
Tue Oct 3 10:18:52 2017 PerconaFT recovery bw_begin_checkpoint at 94106941 timestamp 1507018598954654 (bw_between) |
Tue Oct 3 10:18:52 2017 PerconaFT recovery turning around at begin checkpoint 94106941 time 40850380 |
Tue Oct 3 10:18:52 2017 PerconaFT recovery starts scanning forward to 94150229 from 94106941 left 43288 (fw_between) |
Tue Oct 3 10:18:55 2017 PerconaFT recovery has 2 live transactions |
recover_abort_live_txn 3814099 |
recover_abort_live_txn 3814103 |
Tue Oct 3 10:18:55 2017 PerconaFT recovery closing 1704 dictionaries |
Tue Oct 3 10:19:16 2017 PerconaFT recovery making a checkpoint |
Tue Oct 3 10:19:16 2017 PerconaFT recovery done |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Uses event mutexes |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Compressed tables use zlib 1.2.8 |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Using Linux native AIO |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Number of pools: 1 |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Using SSE2 crc32 instructions |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Initializing buffer pool, total size = 4G, instances = 8, chunk size = 128M |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Completed initialization of buffer pool |
2017-10-03 10:19:16 140658634069760 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority(). |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Highest supported file format is Barracuda. |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Starting crash recovery from checkpoint LSN=3028509464 |
2017-10-03 10:19:16 140665683355840 [Note] InnoDB: Starting final batch to recover 51 pages from redo log. |
2017-10-03 10:19:17 140665683355840 [Note] InnoDB: Last binlog file '/var/log/mysql/mariadb-bin.000007', position 822 |
2017-10-03 10:19:17 140665683355840 [Note] InnoDB: 128 out of 128 rollback segments are active. |
2017-10-03 10:19:17 140665683355840 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1" |
2017-10-03 10:19:17 140665683355840 [Note] InnoDB: Creating shared tablespace for temporary tables |
2017-10-03 10:19:17 140665683355840 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ... |
2017-10-03 10:19:17 140665683355840 [Note] InnoDB: File './ibtmp1' size is now 12 MB. |
2017-10-03 10:19:17 140665683355840 [Note] InnoDB: Waiting for purge to start |
2017-10-03 10:19:17 140665683355840 [Note] InnoDB: 5.7.19 started; log sequence number 3028802676 |
2017-10-03 10:19:17 140658492827392 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool |
2017-10-03 10:19:17 140665683355840 [Note] RocksDB: 2 column families found |
2017-10-03 10:19:17 140665683355840 [Note] RocksDB: Column Families at start: |
2017-10-03 10:19:17 140665683355840 [Note] cf=default |
2017-10-03 10:19:17 140665683355840 [Note] write_buffer_size=67108864 |
2017-10-03 10:19:17 140665683355840 [Note] target_file_size_base=67108864 |
2017-10-03 10:19:17 140665683355840 [Note] cf=__system__ |
2017-10-03 10:19:17 140665683355840 [Note] write_buffer_size=67108864 |
2017-10-03 10:19:17 140665683355840 [Note] target_file_size_base=67108864 |
2017-10-03 10:19:17 140658492827392 [Note] InnoDB: Buffer pool(s) load completed at 171003 10:19:17 |
2017-10-03 10:19:18 140665683355840 [Note] RocksDB: Table_store: loaded DDL data for 0 tables |
2017-10-03 10:19:18 140665683355840 [Note] RocksDB: global statistics using get_sched_indexer_t indexer |
2017-10-03 10:19:18 140665683355840 [Note] MyRocks storage engine plugin has been successfully initialized. |
2017-10-03 10:19:18 140665683355840 [Note] CONNECT: Version 1.06.0004 September 03, 2017 |
2017-10-03 10:19:18 140665683355840 [Note] Plugin 'FEEDBACK' is disabled. |
2017-10-03 10:19:18 140665683355840 [Note] Recovering after a crash using tc.log |
2017-10-03 10:19:18 140665683355840 [Note] Starting crash recovery... |
2017-10-03 10:19:18 140665683355840 [Note] Crash recovery finished. |
2017-10-03 10:19:18 140665683355840 [Note] Server socket created on IP: '127.0.0.1'. |
2017-10-03 10:19:18 140665683355840 [Note] Reading of all Master_info entries succeded |
2017-10-03 10:19:18 140665683355840 [Note] Added new Master_info '' to hash table |
2017-10-03 10:19:18 140665683355840 [Note] /usr/sbin/mysqld: ready for connections. |
Version: '10.2.9-MariaDB-10.2.9+maria~xenial' socket: '/var/run/mysqld/mysqld.sock' port: 3306 mariadb.org binary distribution |
2017-10-03 10:19:27 140664912402176 [ERROR] Invalid (old?) table or database name '.rocksdb' |
2017-10-03 10:22:47 140664671274752 [Note] /usr/sbin/mysqld (unknown): Normal shutdown |
|
2017-10-03 10:22:47 140664671274752 [Note] Event Scheduler: Purging the queue. 0 events |
2017-10-03 10:22:47 140658787120896 [Note] InnoDB: FTS optimize thread exiting. |
2017-10-03 10:22:48 140664671274752 [Note] InnoDB: Starting shutdown... |
2017-10-03 10:22:48 140658492827392 [Note] InnoDB: Dumping buffer pool(s) to /var/lib/mysql/ib_buffer_pool |
2017-10-03 10:22:48 140658492827392 [Note] InnoDB: Buffer pool(s) dump completed at 171003 10:22:48 |
2017-10-03 10:22:49 140664671274752 [Note] InnoDB: Shutdown completed; log sequence number 3028805287 |
2017-10-03 10:22:49 140664671274752 [Note] InnoDB: Removed temporary tablespace data file: "ibtmp1" |
2017-10-03 10:22:50 140664671274752 [Note] /usr/sbin/mysqld: Shutdown complete |
|
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Mutexes and rw_locks use GCC atomic builtins |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Uses event mutexes |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Compressed tables use zlib 1.2.8 |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Using Linux native AIO |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Number of pools: 1 |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Using SSE2 crc32 instructions |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Initializing buffer pool, total size = 4G, instances = 8, chunk size = 128M |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Completed initialization of buffer pool |
2017-10-03 10:22:51 140663488759552 [Note] InnoDB: If the mysqld execution user is authorized, page cleaner thread priority can be changed. See the man page of setpriority(). |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Highest supported file format is Barracuda. |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: 128 out of 128 rollback segments are active. |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Creating shared tablespace for temporary tables |
2017-10-03 10:22:51 140669193488576 [Note] InnoDB: Setting file './ibtmp1' size to 12 MB. Physically writing the file full; Please wait ... |
2017-10-03 10:22:52 140669193488576 [Note] InnoDB: File './ibtmp1' size is now 12 MB. |
2017-10-03 10:22:52 140669193488576 [Note] InnoDB: 5.7.19 started; log sequence number 3028805287 |
2017-10-03 10:22:52 140663348893440 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool |
2017-10-03 10:22:52 140669193488576 [Note] RocksDB: 2 column families found |
2017-10-03 10:22:52 140669193488576 [Note] RocksDB: Column Families at start: |
2017-10-03 10:22:52 140669193488576 [Note] cf=default |
2017-10-03 10:22:52 140669193488576 [Note] write_buffer_size=67108864 |
2017-10-03 10:22:52 140669193488576 [Note] target_file_size_base=67108864 |
2017-10-03 10:22:52 140669193488576 [Note] cf=__system__ |
2017-10-03 10:22:52 140669193488576 [Note] write_buffer_size=67108864 |
2017-10-03 10:22:52 140669193488576 [Note] target_file_size_base=67108864 |
2017-10-03 10:22:52 140669193488576 [Note] RocksDB: Table_store: loaded DDL data for 0 tables |
2017-10-03 10:22:52 140669193488576 [Note] RocksDB: global statistics using get_sched_indexer_t indexer |
2017-10-03 10:22:52 140669193488576 [Note] MyRocks storage engine plugin has been successfully initialized. |
2017-10-03 10:22:52 140669193488576 [Note] CONNECT: Version 1.06.0004 September 03, 2017 |
2017-10-03 10:22:52 140669193488576 [Note] Plugin 'FEEDBACK' is disabled. |
2017-10-03 10:22:52 140669193488576 [Note] Server socket created on IP: '127.0.0.1'. |
2017-10-03 10:22:52 140669193488576 [Note] Reading of all Master_info entries succeded |
2017-10-03 10:22:52 140669193488576 [Note] Added new Master_info '' to hash table |
2017-10-03 10:22:52 140669193488576 [Note] /usr/sbin/mysqld: ready for connections. |
Version: '10.2.9-MariaDB-10.2.9+maria~xenial' socket: '/var/run/mysqld/mysqld.sock' port: 3306 mariadb.org binary distribution |
2017-10-03 10:22:52 140663348893440 [Note] InnoDB: Buffer pool(s) load completed at 171003 10:22:52 |
2017-10-03 10:26:41 140668435670784 [ERROR] Invalid (old?) table or database name '.rocksdb' |
Attachments
Issue Links
- duplicates
-
MDEV-14018 problem of lock on concurent insert (from spider i guees)
- Confirmed