04/07/2020 11:16:34,174 [nioEventLoopGroup-3-1] INFO  ProtocolProcessor 379  - The connect ACK has been sent. CId=3d1f81680b3e4fc71593832587598  04/07/2020 11:16:34,174 [nioEventLoopGroup-3-1] INFO  ProtocolProcessor 252  - The CONNECT message has been processed. CId=3d1f81680b3e4fc71593832587598, username=62c20c3e4b6545f6a7ee350cd9213a88  04/07/2020 11:16:34,256 [nioEventLoopGroup-3-1] INFO  ProtocolProcessor 469  - Processing PUBLISH message. CId=3d1f81680b3e4fc71593832587598, topic=MP, messageId=6, qos=AT_LEAST_ONCE  04/07/2020 11:16:34,257 [nioEventLoopGroup-3-1] INFO  Qos1PublishHandler 154  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, topic=MP  04/07/2020 11:16:34,257 [pool-2-thread-7] INFO  IMHandler 157  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, clientId=3d1f81680b3e4fc71593832587598, topic=MP  04/07/2020 11:16:34,257 [pool-2-thread-7] INFO  IMHandler 29  - User 62c20c3e4b6545f6a7ee350cd9213a88 pull message with count(0), payload size(4)  04/07/2020 11:16:34,257 [pool-2-thread-7] INFO  ConnectionDescriptorStore 53  - Sending PUBACK message CId=<3d1f81680b3e4fc71593832587598>, messageId=6, errorCode=ERROR_CODE_SUCCESS  04/07/2020 11:16:36,670 [nioEventLoopGroup-5-2] INFO  Qos1PublishHandler 154  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, topic=GETTOKEN  04/07/2020 11:16:36,670 [pool-2-thread-2] INFO  IMHandler 157  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, clientId=3d1f81680b3e4fc71593832587598, topic=GETTOKEN  04/07/2020 11:16:36,676 [pool-2-thread-2] INFO  DatabaseStore 1490  - clearMultiEndpoint 62c20c3e4b6545f6a7ee350cd9213a88, 3d1f81680b3e4fc71593832587598  04/07/2020 11:16:36,677 [pool-2-thread-2] INFO  DatabaseStore 1528  - Update rows 0  04/07/2020 11:16:37,291 [nioEventLoopGroup-3-1] INFO  ProtocolProcessor 469  - Processing PUBLISH message. CId=3d1f81680b3e4fc71593832587598, topic=FP, messageId=7, qos=AT_LEAST_ONCE  04/07/2020 11:16:37,292 [nioEventLoopGroup-3-1] INFO  Qos1PublishHandler 154  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, topic=FP  04/07/2020 11:16:37,292 [pool-2-thread-8] INFO  IMHandler 157  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, clientId=3d1f81680b3e4fc71593832587598, topic=FP  04/07/2020 11:16:37,293 [pool-2-thread-8] ERROR DatabaseStore 37  - Exception: Unknown column '_extra' in 'field list'  04/07/2020 11:16:37,293 [pool-2-thread-8] ERROR DatabaseStore 38  -   com.mysql.cj.jdbc.exceptions.SQLError.createSQLException(SQLError.java:120)  com.mysql.cj.jdbc.exceptions.SQLError.createSQLException(SQLError.java:97)  com.mysql.cj.jdbc.exceptions.SQLExceptionsMapping.translateException(SQLExceptionsMapping.java:122)  com.mysql.cj.jdbc.ClientPreparedStatement.executeInternal(ClientPreparedStatement.java:953)  com.mysql.cj.jdbc.ClientPreparedStatement.executeQuery(ClientPreparedStatement.java:1003)  com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:431)  io.moquette.persistence.DatabaseStore.getPersistFriends(DatabaseStore.java:2534)  io.moquette.persistence.MemoryMessagesStore.loadFriend(MemoryMessagesStore.java:1999)  io.moquette.persistence.MemoryMessagesStore.getFriendList(MemoryMessagesStore.java:2031)  io.moquette.imhandler.FriendPullHandler.action(FriendPullHandler.java:25)  io.moquette.imhandler.FriendPullHandler.action(FriendPullHandler.java:21)  io.moquette.imhandler.IMHandler.lambda$doHandler$0(IMHandler.java:192)  cn.wildfirechat.server.ThreadPoolExecutorWrapper.lambda$execute$0(ThreadPoolExecutorWrapper.java:37)  java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)  java.util.concurrent.FutureTask.run(FutureTask.java:266)  java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)  java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)  java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)  java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)  java.lang.Thread.run(Thread.java:748)  04/07/2020 11:16:37,293 [pool-2-thread-8] INFO  ConnectionDescriptorStore 53  - Sending PUBACK message CId=<3d1f81680b3e4fc71593832587598>, messageId=7, errorCode=ERROR_CODE_SUCCESS  04/07/2020 11:16:37,377 [nioEventLoopGroup-5-4] INFO  Qos1PublishHandler 154  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, topic=FP  04/07/2020 11:16:37,377 [pool-2-thread-3] INFO  IMHandler 157  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, clientId=3d1f81680b3e4fc71593832587598, topic=FP  04/07/2020 11:16:37,379 [pool-2-thread-3] ERROR DatabaseStore 37  - Exception: Unknown column '_extra' in 'field list'  04/07/2020 11:16:37,379 [pool-2-thread-3] ERROR DatabaseStore 38  -   com.mysql.cj.jdbc.exceptions.SQLError.createSQLException(SQLError.java:120)  com.mysql.cj.jdbc.exceptions.SQLError.createSQLException(SQLError.java:97)  com.mysql.cj.jdbc.exceptions.SQLExceptionsMapping.translateException(SQLExceptionsMapping.java:122)  com.mysql.cj.jdbc.ClientPreparedStatement.executeInternal(ClientPreparedStatement.java:953)  com.mysql.cj.jdbc.ClientPreparedStatement.executeQuery(ClientPreparedStatement.java:1003)  com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:431)  io.moquette.persistence.DatabaseStore.getPersistFriends(DatabaseStore.java:2534)  io.moquette.persistence.MemoryMessagesStore.loadFriend(MemoryMessagesStore.java:1999)  io.moquette.persistence.MemoryMessagesStore.getFriendList(MemoryMessagesStore.java:2031)  io.moquette.imhandler.FriendPullHandler.action(FriendPullHandler.java:25)  io.moquette.imhandler.FriendPullHandler.action(FriendPullHandler.java:21)  io.moquette.imhandler.IMHandler.lambda$doHandler$0(IMHandler.java:192)  cn.wildfirechat.server.ThreadPoolExecutorWrapper.lambda$execute$0(ThreadPoolExecutorWrapper.java:37)  java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)  java.util.concurrent.FutureTask.run(FutureTask.java:266)  java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)  java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)  java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)  java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)  java.lang.Thread.run(Thread.java:748)  04/07/2020 11:16:37,441 [nioEventLoopGroup-3-1] INFO  ProtocolProcessor 469  - Processing PUBLISH message. CId=3d1f81680b3e4fc71593832587598, topic=UPUI, messageId=9, qos=AT_LEAST_ONCE  04/07/2020 11:16:37,442 [nioEventLoopGroup-3-1] INFO  Qos1PublishHandler 154  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, topic=UPUI  04/07/2020 11:16:37,442 [pool-2-thread-5] INFO  IMHandler 157  - imHandler fromUser=62c20c3e4b6545f6a7ee350cd9213a88, clientId=3d1f81680b3e4fc71593832587598, topic=UPUI  04/07/2020 11:16:37,443 [pool-2-thread-5] INFO  ConnectionDescriptorStore 53  - Sending PUBACK message CId=<3d1f81680b3e4fc71593832587598>, messageId=9, errorCode=ERROR_CODE_SUCCESS  04/07/2020 11:16:53,087 [nioEventLoopGroup-5-6] WARN  DefaultChannelPipeline 151  - An exceptionCaught() event was fired, and it reached at the tail of the pipeline. It usually means the last handler in the pipeline did not handle the exception.  java.lang.StringIndexOutOfBoundsException: String index out of range: 0  at java.lang.String.charAt(String.java:658)  at com.xiaoleilu.loServer.action.FileAction.getFileByPath(FileAction.java:113)  at com.xiaoleilu.loServer.action.FileAction.action(FileAction.java:49)  at com.xiaoleilu.loServer.action.Action.doAction(Action.java:65)  at com.xiaoleilu.loServer.handler.ActionHandler.doAction(ActionHandler.java:142)  at com.xiaoleilu.loServer.handler.ActionHandler.channelRead0(ActionHandler.java:52)  at com.xiaoleilu.loServer.handler.ActionHandler.channelRead0(ActionHandler.java:31)  at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:362)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:348)  at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:340)  at io.netty.handler.codec.MessageToMessageDecoder.channelRead(MessageToMessageDecoder.java:102)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:362)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:348)  at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:340)  at io.netty.channel.ChannelInboundHandlerAdapter.channelRead(ChannelInboundHandlerAdapter.java:86)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:362)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:348)  at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:340)  at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:310)  at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:284)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:362)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:348)  at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:340)  at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1334)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:362)  at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:348)  at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:926)  at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:134)  at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:644)  at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:579)  at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:496)  at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:458)  at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:858)  at io.netty.util.concurrent.DefaultThreadFactory$DefaultRunnableDecorator.run(DefaultThreadFactory.java:138)  at java.lang.Thread.run(Thread.java:748)