-
-
Save agarajh/57e20c55098aaad3d595 to your computer and use it in GitHub Desktop.
Push Notifications are not being resent after I/O problems are resolved.
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
2013-11-12 11:11:31,173 | drivexone-push | INFO | ContextLoader | |
|Root WebApplicationContext: initialization started | |
2013-11-12 11:11:49,883 | drivexone-push | DEBUG | PlatformDependent | |
|-Dio.netty.noPreferDirect: false | |
2013-11-12 11:11:49,948 | drivexone-push | DEBUG | NioEventLoop | |
|-Dio.netty.noKeySetOptimization: false | |
2013-11-12 11:11:49,949 | drivexone-push | DEBUG | NioEventLoop | |
|-Dio.netty.selectorAutoRebuildThreshold: 512 | |
2013-11-12 11:11:49,966 | drivexone-push | TRACE | NioEventLoop | |
|Instrumented an optimized java.util.Set into: sun.nio.ch.WindowsSelectorImpl@48e3424f | |
2013-11-12 11:11:50,014 | drivexone-push | TRACE | NioEventLoop | |
|Instrumented an optimized java.util.Set into: sun.nio.ch.WindowsSelectorImpl@152ff879 | |
2013-11-12 11:11:50,015 | drivexone-push | TRACE | NioEventLoop | |
|Instrumented an optimized java.util.Set into: sun.nio.ch.WindowsSelectorImpl@61dacd | |
2013-11-12 11:11:50,020 | drivexone-push | TRACE | NioEventLoop | |
|Instrumented an optimized java.util.Set into: sun.nio.ch.WindowsSelectorImpl@5220dbfe | |
2013-11-12 11:11:50,023 | drivexone-push | INFO | ApplePushManager | |
|DEBUGGING | |
2013-11-12 11:11:50,029 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 beginning connection process. | |
2013-11-12 11:11:50,046 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-3 beginning connection process. | |
2013-11-12 11:11:50,046 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 beginning connection process. | |
2013-11-12 11:11:50,532 | drivexone-push | ERROR | ApnsClientThread | |
|ApnsClientThread-1 failed to connect to APNs gateway. | |
java.nio.channels.UnresolvedAddressException: null | |
at sun.nio.ch.Net.checkAddress(Net.java:85) ~[na:1.7.0_21] | |
at sun.nio.ch.SocketChannelImpl.connect(SocketChannelImpl.java:597) ~[na:1.7.0_21] | |
at io.netty.channel.socket.nio.NioSocketChannel.doConnect(NioSocketChannel.java:195) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.nio.AbstractNioChannel$AbstractNioUnsafe.connect(AbstractNioChannel.java:172) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelPipeline$HeadHandler.connect(DefaultChannelPipeline.java:1008) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.invokeConnect(DefaultChannelHandlerContext.java:491) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.connect(DefaultChannelHandlerContext.java:476) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.handler.ssl.SslHandler.connect(SslHandler.java:370) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.invokeConnect(DefaultChannelHandlerContext.java:491) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.connect(DefaultChannelHandlerContext.java:476) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.ChannelOutboundHandlerAdapter.connect(ChannelOutboundHandlerAdapter.java:47) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.invokeConnect(DefaultChannelHandlerContext.java:491) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.connect(DefaultChannelHandlerContext.java:476) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.connect(DefaultChannelHandlerContext.java:461) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelPipeline.connect(DefaultChannelPipeline.java:847) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.AbstractChannel.connect(AbstractChannel.java:198) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.bootstrap.Bootstrap$2.run(Bootstrap.java:165) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:354) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:366) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:101) ~[netty-all-4.0.7.Final.jar:na] | |
at java.lang.Thread.run(Thread.java:722) ~[na:1.7.0_21] | |
2013-11-12 11:11:51,733 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 beginning connection process. | |
2013-11-12 11:12:01,234 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-3 connected. | |
2013-11-12 11:12:01,234 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-3 waiting for TLS handshake. | |
2013-11-12 11:12:01,235 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 connected. | |
2013-11-12 11:12:01,235 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 waiting for TLS handshake. | |
2013-11-12 11:12:01,246 | drivexone-push | DEBUG | ResourceLeakDetector | |
|-Dio.netty.noResourceLeakDetection: false | |
2013-11-12 11:12:01,252 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 connected. | |
2013-11-12 11:12:01,252 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 waiting for TLS handshake. | |
2013-11-12 11:12:01,760 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 successfully completed TLS handshake. | |
2013-11-12 11:12:01,761 | drivexone-push | TRACE | ApnsClientThread | |
|ApnsClientThread-2 sending SendableApnsPushNotification [sequenceNumber=0, token=3f3ad78b00c5e7f740dd06fa5357333e0d3140d640b4b08c068d4927f0790f91, payload={"aps":{"alert":{"loc-args":["MILE_CRUNCHETE3"],"loc-key":"VVC_BADGE"}}}, deliveryInvalidation=null] | |
2013-11-12 11:12:01,784 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 successfully completed TLS handshake. | |
2013-11-12 11:12:01,823 | drivexone-push | TRACE | ApnsClientThread | |
|ApnsClientThread-2 successfully wrote notification 0 | |
2013-11-12 11:12:01,924 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-3 successfully completed TLS handshake. | |
2013-11-12 11:12:02,007 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 waiting for connection to close. | |
2013-11-12 11:12:02,008 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 beginning connection process. | |
2013-11-12 11:12:02,028 | drivexone-push | INFO | PushNotificationController | |
|SimpleApnsPushNotification [token=3f3ad78b00c5e7f740dd06fa5357333e0d3140d640b4b08c068d4927f0790f91, payload={"aps":{"alert":{"loc-args":["MILE_CRUNCHETE3"],"loc-key":"VVC_BADGE"}}}, expiration=null] was rejected with rejection reason:INVALID_TOKEN | |
2013-11-12 11:12:02,028 | drivexone-push | INFO | PushNotificationController | |
|Calling endpoint to delete the token from the internal database | |
2013-11-12 11:12:02,029 | drivexone-push | INFO | RestfulClientManager | |
|The old Registration Id will be deleted from the internal database | |
2013-11-12 11:12:02,177 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 connected. | |
2013-11-12 11:12:02,177 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 waiting for TLS handshake. | |
2013-11-12 11:12:02,690 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-2 successfully completed TLS handshake. | |
2013-11-12 11:12:28,300 | drivexone-push | TRACE | DispatcherServlet | |
|Bound request context to thread: org.apache.catalina.connector.RequestFacade@24d6fbe7 | |
2013-11-12 11:12:28,301 | drivexone-push | DEBUG | DispatcherServlet | |
|DispatcherServlet with name 'appServlet' processing POST request for [/vvc-push/push] | |
2013-11-12 11:12:28,303 | drivexone-push | TRACE | DispatcherServlet | |
|Testing handler map [org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping@2393ad40] in DispatcherServlet with name 'appServlet' | |
2013-11-12 11:12:28,303 | drivexone-push | DEBUG | RequestMappingHandlerMapping | |
|Looking up handler method for path /push | |
2013-11-12 11:12:28,304 | drivexone-push | TRACE | RequestMappingHandlerMapping | |
|Found 1 matching mapping(s) for [/push] : [{[/push],methods=[POST],params=[],headers=[],consumes=[application/json;charset=utf-8],produces=[application/json;charset=utf-8],custom=[]}] | |
2013-11-12 11:12:28,305 | drivexone-push | DEBUG | RequestMappingHandlerMapping | |
|Returning handler method [public org.springframework.http.ResponseEntity<java.lang.String> com.vodafone.vvc.push.controllers.PushNotificationController.sendPushNotification(com.vodafone.vvc.push.resources.PushNotificationInputDataResource) throws org.codehaus.jackson.JsonProcessingException,java.io.IOException] | |
2013-11-12 11:12:28,305 | drivexone-push | DEBUG | DefaultListableBeanFactory | |
|Returning cached instance of singleton bean 'pushNotificationController' | |
2013-11-12 11:12:28,305 | drivexone-push | TRACE | DispatcherServlet | |
|Testing handler adapter [org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter@7c1570c3] | |
2013-11-12 11:12:28,308 | drivexone-push | DEBUG | RequestResponseBodyMethodProcessor | |
|Reading [com.vodafone.vvc.push.resources.PushNotificationInputDataResource] as "application/json" using [org.springframework.http.converter.json.MappingJacksonHttpMessageConverter@22a89f5c] | |
2013-11-12 11:12:28,310 | drivexone-push | TRACE | ServletInvocableHandlerMethod | |
|Invoking [sendPushNotification] method with arguments [com.vodafone.vvc.push.resources.PushNotificationInputDataResource@6b680257] | |
2013-11-12 11:12:28,327 | drivexone-push | INFO | PushNotificationController | |
|Push Notification will be sent to the APNS Official Provider | |
2013-11-12 11:12:28,328 | drivexone-push | TRACE | ServletInvocableHandlerMethod | |
|Method [sendPushNotification] returned [<201 Created,Request has been received and is being processed,{}>] | |
2013-11-12 11:12:28,331 | drivexone-push | DEBUG | HttpEntityMethodProcessor | |
|Written [Request has been received and is being processed] as "application/json;charset=utf-8" using [org.springframework.http.converter.StringHttpMessageConverter@1faed341] | |
2013-11-12 11:12:28,331 | drivexone-push | DEBUG | DispatcherServlet | |
|Null ModelAndView returned to DispatcherServlet with name 'appServlet': assuming HandlerAdapter completed request handling | |
2013-11-12 11:12:28,331 | drivexone-push | TRACE | DispatcherServlet | |
|Cleared thread-bound request context: org.apache.catalina.connector.RequestFacade@24d6fbe7 | |
2013-11-12 11:12:28,332 | drivexone-push | DEBUG | DispatcherServlet | |
|Successfully completed request | |
2013-11-12 11:12:28,332 | drivexone-push | TRACE | XmlWebApplicationContext | |
|Publishing event in WebApplicationContext for namespace 'appServlet-servlet': ServletRequestHandledEvent: url=[/vvc-push/push]; client=[127.0.0.1]; method=[POST]; servlet=[appServlet]; session=[null]; user=[null]; time=[32ms]; status=[OK] | |
2013-11-12 11:12:28,332 | drivexone-push | TRACE | XmlWebApplicationContext | |
|Publishing event in Root WebApplicationContext: ServletRequestHandledEvent: url=[/vvc-push/push]; client=[127.0.0.1]; method=[POST]; servlet=[appServlet]; session=[null]; user=[null]; time=[32ms]; status=[OK] | |
2013-11-12 11:12:28,337 | drivexone-push | INFO | ApplePushNotification | |
|The payload is being sent to APNS | |
2013-11-12 11:12:28,338 | drivexone-push | TRACE | ApnsClientThread | |
|ApnsClientThread-1 sending SendableApnsPushNotification [sequenceNumber=0, token=3f3ad78b00c5e7f740dd06fa5357333e0d3140d640b4b08c068d4927f0790f90, payload={"aps":{"alert":{"loc-args":["MILE_CRUNCHETE3"],"loc-key":"VVC_BADGE"}}}, deliveryInvalidation=null] | |
2013-11-12 11:12:28,434 | drivexone-push | TRACE | ApnsClientThread | |
|ApnsClientThread-1 successfully wrote notification 0 | |
2013-11-12 11:12:51,161 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 waiting for connection to close. | |
2013-11-12 11:12:51,162 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 beginning connection process. | |
2013-11-12 11:12:51,183 | drivexone-push | ERROR | ApnsClientThread | |
|ApnsClientThread-1 failed to connect to APNs gateway. | |
java.nio.channels.UnresolvedAddressException: null | |
at sun.nio.ch.Net.checkAddress(Net.java:85) ~[na:1.7.0_21] | |
at sun.nio.ch.SocketChannelImpl.connect(SocketChannelImpl.java:597) ~[na:1.7.0_21] | |
at io.netty.channel.socket.nio.NioSocketChannel.doConnect(NioSocketChannel.java:195) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.nio.AbstractNioChannel$AbstractNioUnsafe.connect(AbstractNioChannel.java:172) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelPipeline$HeadHandler.connect(DefaultChannelPipeline.java:1008) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.invokeConnect(DefaultChannelHandlerContext.java:491) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.connect(DefaultChannelHandlerContext.java:476) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.handler.ssl.SslHandler.connect(SslHandler.java:370) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.invokeConnect(DefaultChannelHandlerContext.java:491) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.connect(DefaultChannelHandlerContext.java:476) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.ChannelOutboundHandlerAdapter.connect(ChannelOutboundHandlerAdapter.java:47) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.invokeConnect(DefaultChannelHandlerContext.java:491) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.connect(DefaultChannelHandlerContext.java:476) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelHandlerContext.connect(DefaultChannelHandlerContext.java:461) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.DefaultChannelPipeline.connect(DefaultChannelPipeline.java:847) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.AbstractChannel.connect(AbstractChannel.java:198) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.bootstrap.Bootstrap$2.run(Bootstrap.java:165) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:354) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:366) ~[netty-all-4.0.7.Final.jar:na] | |
at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:101) ~[netty-all-4.0.7.Final.jar:na] | |
at java.lang.Thread.run(Thread.java:722) ~[na:1.7.0_21] | |
2013-11-12 11:12:51,184 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 beginning connection process. | |
2013-11-12 11:13:02,481 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 connected. | |
2013-11-12 11:13:02,481 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 waiting for TLS handshake. | |
2013-11-12 11:13:02,977 | drivexone-push | DEBUG | ApnsClientThread | |
|ApnsClientThread-1 successfully completed TLS handshake. |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment