之前测试消费超时重试,可以看到对应的现象,这几天再测试,发现不能触发了。
代码如下:
@Slf4j
@Service
@RocketMQMessageListener(topic = "topic2502-8",
consumerGroup = "group25028",
maxReconsumeTimes = 1, // 最大重试次数
consumeTimeout = 1 // 消费超时时间1分钟,默认15分钟
)
public class Consumer8 implements RocketMQListener<String> {
@Override
public void onMessage(String s) {
log.info("receive message: " + s);
try {
Thread.sleep(70000);
} catch (InterruptedException e) {
throw new RuntimeException(e);
}
log.info("end");
}
}
不得已,只能查看源码,ProcessQueue中有个cleanExpireMsg()方法,字面意思看,是清理过期方法,咱设置的consumeTimeout=1,于是每分钟会触发一次。

该方法下有这样一段代码:

if (!this.msgTreeMap.isEmpty()) {
// 获取消息开始执行的时间戳
String consumeStartTimeStamp = MessageAccessor.getConsumeStartTimeStamp((Message)this.msgTreeMap.firstEntry().getValue());
// 根据当前时间的时间戳-开始执行时间戳 是否大于 1分钟(本例消费超时设置的1分钟)
// 如果大于,从msgTreeMap中取消息数据
if (StringUtils.isNotEmpty(consumeStartTimeStamp) && System.currentTimeMillis() - Long.parseLong(consumeStartTimeStamp) > pushConsumer.getConsumeTimeout() * 60L * 1000L) {
msg = (MessageExt)this.msgTreeMap.firstEntry().getValue();
}
}
后面还有一段代码,按照延迟级别是3的等级重新发送消息。

从源码我们可以看到,我们自定义的消费者代码中,执行逻辑时间设置的70s,cleanExpireMsg()方法每60s执行一次,有可能第一次执行时,方法内计算的(当前时间的时间戳 - consumeStartTimeStamp)的值小于60s,于是没有执行重发消息的操作。
当70s后,逻辑结束,消息进行了其他处理。再次触发cleanExpireMsg()时,msgTreeMap中没有数据,后续获取消息和重发的逻辑不会继续执行。
于是修改消费者代码,增加逻辑执行时间,再次测试,可以看到重试的执行效果。
@Slf4j
@Service
@RocketMQMessageListener(topic = "topic2502-8",
consumerGroup = "group25028",
maxReconsumeTimes = 1, // 最大重试次数
consumeTimeout = 1 // 消费超时时间1分钟,默认15分钟
)
public class Consumer8 implements RocketMQListener<String> {
@Override
public void onMessage(String s) {
log.info("receive message: " + s);
try {
Thread.sleep(140000);
} catch (InterruptedException e) {
throw new RuntimeException(e);
}
log.info("end");
}
}
1698

被折叠的 条评论
为什么被折叠?



