记一个TransactionTemplate调用的bug

在我们的项目里,使用rabbitmq作为消息队列,缓存发往数据库的更新信息。
中午观察rabbitmq队列的时候,发现队列中总有26个unack的信息。我们数据库的更新数据并不是很频繁,平均每秒1-2条,因此积压26个unack的数据一定有问题。再观察consumer数,发现比我们正常的30个连接正好多了26个,可以判断有26个连接因为message无法ack被阻塞了。
打开更新数据库的模块日志,发现如下的错误log:

org.springframework.transaction.TransactionSystemException: Could not commit JDBC transaction; nested exception is com.mysql.jdbc.exceptions.jdbc4.MySQLNonTransientConnectionException: Communications link failure during commit(). Transaction resolution unknown.
        at org.springframework.jdbc.datasource.DataSourceTransactionManager.doCommit(DataSourceTransactionManager.java:275)
        at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:761)
        at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:730)
        at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:150)
        at com.yidian.commerce.update.server.biz.BaseProcessBuilder.updateDbWithTransaction(BaseProcessBuilder.java:47)
        at com.yidian.commerce.update.server.biz.BaseProcessBuilder.access$000(BaseProcessBuilder.java:20)
        at com.yidian.commerce.update.server.biz.BaseProcessBuilder$1.process(BaseProcessBuilder.java:31)
        at com.yidian.commerce.common.utils.rabbitmq.MQAccessBuilder$2.consume(MQAccessBuilder.java:155)
        at com.yidian.commerce.common.utils.rabbitmq.ThreadPoolConsumer$1.run(ThreadPoolConsumer.java:102)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)

从异常来看,是事务commit提交时网络超时导致的。这种网络异常按理说是应该在程序中被捕捉的。
回到程序更新数据库的代码,如下:

    DetailRes updateDbWithTransaction(final T dbUpdateModel, final TransactionTemplate transactionTemplate) {
        return transactionTemplate.execute(new TransactionCallback<DetailRes>() {
                @Override
                public DetailRes doInTransaction(TransactionStatus status) {
                    try {
                        updateDb(dbUpdateModel);
                        return new DetailRes(true, "");
                    } catch (DataIntegrityViolationException e) {
                        log.info("idempotent rollback transaction: " + status);
                        //instructionId重复
                        status.setRollbackOnly();
                        return new DetailRes(true, "");
                    } catch (Exception e) {
                        e.printStackTrace();
                        status.setRollbackOnly();
                        log.info("rollback transaction: " + status);

                        return new DetailRes(false, e.toString());
                    }
                }
            });
    }

我们在doInTransaction中对异常做了补货,按理说是不应该抛出这样的异常的,我们继续看transactionTemplate.execute的代码,如下:

    public <T> T execute(TransactionCallback<T> action) throws TransactionException {
        if (this.transactionManager instanceof CallbackPreferringPlatformTransactionManager) {
            return ((CallbackPreferringPlatformTransactionManager) this.transactionManager).execute(this, action);
        }
        else {
            TransactionStatus status = this.transactionManager.getTransaction(this);
            T result;
            try {
                result = action.doInTransaction(status);
            }
            catch (RuntimeException ex) {
                // Transactional code threw application exception -> rollback
                rollbackOnException(status, ex);
                throw ex;
            }
            catch (Error err) {
                // Transactional code threw error -> rollback
                rollbackOnException(status, err);
                throw err;
            }
            catch (Throwable ex) {
                // Transactional code threw unexpected exception -> rollback
                rollbackOnException(status, ex);
                throw new UndeclaredThrowableException(ex, "TransactionCallback threw undeclared checked exception");
            }
            this.transactionManager.commit(status);
            return result;
        }
    }

可以发现this.transactionManager.commit(status);这句并没有包含在try,catch中,也就是抛出异常的根源所在。
鉴于此,我们修改updateDbWithTransaction代码,将整个的execute模块也包裹在try,catch中,最终的代码如下:

    DetailRes updateDbWithTransaction(final T dbUpdateModel, final TransactionTemplate transactionTemplate) {
        DetailRes detailRes;
        try {
            detailRes = transactionTemplate.execute(new TransactionCallback<DetailRes>() {
                @Override
                public DetailRes doInTransaction(TransactionStatus status) {
                    try {
                        updateDb(dbUpdateModel);
                        return new DetailRes(true, "");
                    } catch (DataIntegrityViolationException e) {
                        log.info("idempotent rollback transaction: " + status);
                        //instructionId重复
                        status.setRollbackOnly();
                        return new DetailRes(true, "");
                    } catch (Exception e) {
                        e.printStackTrace();
                        status.setRollbackOnly();
                        log.info("rollback transaction: " + status);

                        return new DetailRes(false, e.toString());
                    }
                }
            });
        } catch (Exception e) {
            e.printStackTrace();
            detailRes = new DetailRes(false, "updateDbWithTransaction failed: " + e);
        }

        return detailRes;
    }

同时,为了杜绝这种处理层抛出异常,阻塞rabbitmq连接的问题。我们将rabbitmqAccess的process模块也包裹在try,catch中,如下:

DetailRes detailRes;

try {
    detailRes = messageProcess.process(messageBean);
} catch (Exception e) {
    detailRes = new DetailRes(false, "process exception: " + e);
}
最后编辑于
©著作权归作者所有,转载或内容合作请联系作者
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 159,835评论 4 364
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 67,598评论 1 295
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 109,569评论 0 244
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 44,159评论 0 213
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 52,533评论 3 287
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 40,710评论 1 222
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 31,923评论 2 313
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 30,674评论 0 203
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 34,421评论 1 246
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 30,622评论 2 245
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 32,115评论 1 260
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 28,428评论 2 254
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 33,114评论 3 238
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 26,097评论 0 8
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 26,875评论 0 197
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 35,753评论 2 276
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 35,649评论 2 271

推荐阅读更多精彩内容