search

CleverTap / apns-http2

A Java library for sending notifications via APNS using Apple's HTTP/2 API.
https://clevertap.com
BSD 3-Clause "New" or "Revised" License
216 stars 109 forks source link

code response OK ,but the device cannot receive the apns message. #3

Closed medzeus2 closed 8 years ago

medzeus2 commented 8 years ago

this is my code

` FileInputStream cert = null; try { cert = new FileInputStream("E:/lApns.p12"); final ApnsClient client = new ApnsClientBuilder().withProductionGateway().inSynchronousMode() .withCertificate(cert).withPassword("xxxxxxx").build(); client.start(); Notification notify = new Notification.Builder( "a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887").alertBody("welcome").build();

        NotificationResponse resp = client.push(notify);

        System.out.println(resp);
    } catch (Exception e) {

        e.printStackTrace();
    } finally {
        if (cert != null) {
            try {
                cert.close();
            } catch (IOException e) {
            }
        }
    }

`

this is my log. Any idea?

2016-04-27 16:44:02,282 DEBUG (org.eclipse.jetty.io.WriteFlusher:381) - flushed incomplete [HeapByteBuffer@6dac8179[p=0,l=24,c=24,r=24]={<<<PRI HTTP/2.0\r\n\r\nSM\r\n\r\n>>>},DirectByteBuffer@4ae9a6fe[p=0,l=15,c=1024,r=15]={<<<\x00\x00\x06\x04\x00\x00\x00\x00\x00\x00\x04\x00\x00\xFf\xFf>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}] 2016-04-27 16:44:02,282 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{PENDING}:COMPLETING-->PENDING 2016-04-27 16:44:02,282 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:376) - onIncompleteFlush SslConnection@58341d8d{NEED_UNWRAP,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,P,2/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,6/0,SslConnection}{io=1/1,kio=1,kro=1}] 2016-04-27 16:44:02,282 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:574) - ran org.eclipse.jetty.io.ssl.SslConnection$1@193ad4f 2016-04-27 16:44:02,282 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:165) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produced null 2016-04-27 16:44:02,282 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:228) - EPR Idle/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produce exit 2016-04-27 16:44:02,283 DEBUG (org.eclipse.jetty.io.WriteFlusher:360) - completeWrite: WriteFlusher@21ab53dd{PENDING} 2016-04-27 16:44:02,283 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{COMPLETING}:PENDING-->COMPLETING 2016-04-27 16:44:02,289 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NEED_UNWRAP,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,3/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,7/0,SslConnection}{io=1/1,kio=1,kro=1}] flush b[24]=505249202A20485454502F322E300D0A0D0A534D0D0A0D0A 2016-04-27 16:44:02,290 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NEED_UNWRAP,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,10/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,14/0,SslConnection}{io=1/1,kio=1,kro=1}] flush b[15]=00000604000000000000040000FFFF 2016-04-27 16:44:02,290 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:765) - SslConnection@58341d8d{NEED_UNWRAP,eio=-1/0,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,10/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,14/0,SslConnection}{io=1/1,kio=1,kro=1}] wrap Status = OK HandshakeStatus = NEED_UNWRAP bytesConsumed = 0 bytesProduced = 0 2016-04-27 16:44:02,290 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:803) - SslConnection@58341d8d{NEED_UNWRAP,eio=-1/0,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,10/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,14/0,SslConnection}{io=1/1,kio=1,kro=1}] wrap OK b[0]= 2016-04-27 16:44:02,290 DEBUG (org.eclipse.jetty.io.WriteFlusher:423) - Flushed=false 0/24+1 WriteFlusher@21ab53dd{COMPLETING} 2016-04-27 16:44:02,290 DEBUG (org.eclipse.jetty.io.WriteFlusher:448) - !fully flushed WriteFlusher@21ab53dd{COMPLETING} 2016-04-27 16:44:02,290 DEBUG (org.eclipse.jetty.io.WriteFlusher:381) - flushed incomplete [HeapByteBuffer@6dac8179[p=0,l=24,c=24,r=24]={<<<PRI HTTP/2.0\r\n\r\nSM\r\n\r\n>>>},DirectByteBuffer@4ae9a6fe[p=0,l=15,c=1024,r=15]={<<<\x00\x00\x06\x04\x00\x00\x00\x00\x00\x00\x04\x00\x00\xFf\xFf>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}] 2016-04-27 16:44:02,290 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{PENDING}:COMPLETING-->PENDING 2016-04-27 16:44:02,290 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:376) - onIncompleteFlush SslConnection@58341d8d{NEED_UNWRAP,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,P,10/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,14/0,SslConnection}{io=1/1,kio=1,kro=1}] 2016-04-27 16:44:02,291 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:210) - onFillable exit DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,P,11/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,15/0,SslConnection}{io=1/1,kio=1,kro=1} 2016-04-27 16:44:02,291 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:215) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 ran SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,15/0,SslConnection}{io=1/1,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,291 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:228) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produce exit 2016-04-27 16:44:02,291 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:574) - ran EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,415 DEBUG (org.eclipse.jetty.io.ManagedSelector:234) - Selector loop woken up from select, 1/1 selected 2016-04-27 16:44:02,415 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:159) - onSelected 1->0 r=true w=false for SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,139/0,SslConnection}{io=1/0,kio=1,kro=1} 2016-04-27 16:44:02,415 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:186) - task SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,139/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,415 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:165) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produced SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,139/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,415 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:206) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 dispatch 2016-04-27 16:44:02,415 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:373) - queue EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:212) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 run SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,139/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:571) - run EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:125) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 run 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:154) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produce enter 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:160) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 producing 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:214) - Key interests updated 1 -> 0 on SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,140/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.io.ManagedSelector:231) - Selector loop waiting on select 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.io.FillInterest:93) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NEED_UNWRAP,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,P,136/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,140/0,SslConnection}{io=0/0,kio=0,kro=1}]}} fillable AC.ReadCB@58341d8d{SslConnection@58341d8d{NEED_UNWRAP,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,P,136/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,140/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,416 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:189) - onFillable enter DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,P,136/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,140/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,417 DEBUG (org.eclipse.jetty.io.FillInterest:93) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,P,136/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,140/0,SslConnection}{io=0/0,kio=0,kro=1}]}} fillable AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,P,136/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,140/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,417 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:96) - HTTP2 onFillable HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,P,137/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,141/0,SslConnection}{io=0/0,kio=0,kro=1}] 2016-04-27 16:44:02,417 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:76) - EPR Idle/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 execute 2016-04-27 16:44:02,417 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:154) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produce enter 2016-04-27 16:44:02,417 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:160) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 producing 2016-04-27 16:44:02,417 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:151) - Dequeued task null 2016-04-27 16:44:02,417 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:147) - filled 113 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,141/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,417 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NEED_UNWRAP,eio=107/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,P,137/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}] net=113 unwrap Status = OK HandshakeStatus = NEED_UNWRAP bytesConsumed = 6 bytesProduced = 0 2016-04-27 16:44:02,418 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NEED_UNWRAP,eio=107/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,P,137/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,418 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=62/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,P,138/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] net=113 unwrap Status = OK HandshakeStatus = FINISHED bytesConsumed = 45 bytesProduced = 0 2016-04-27 16:44:02,418 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=62/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,P,138/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,418 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:596) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=62/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,P,138/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] client handshook TLSv1.2/TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256 2016-04-27 16:44:02,419 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=33} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,P,139/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,2/0,SslConnection}{io=0/0,kio=0,kro=1}] net=113 unwrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 62 bytesProduced = 33 2016-04-27 16:44:02,419 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=33} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,P,139/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,2/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,419 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:373) - queue org.eclipse.jetty.io.ssl.SslConnection$1@193ad4f 2016-04-27 16:44:02,419 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:180) - Filled 33 bytes 2016-04-27 16:44:02,420 DEBUG (org.eclipse.jetty.http2.parser.Parser:137) - Parsed SETTINGS frame header from java.nio.HeapByteBuffer[pos=9 lim=33 cap=16384] 2016-04-27 16:44:02,420 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:571) - run org.eclipse.jetty.io.ssl.SslConnection$1@193ad4f 2016-04-27 16:44:02,420 DEBUG (org.eclipse.jetty.http2.parser.SettingsBodyParser:118) - setting 1=4096 2016-04-27 16:44:02,420 DEBUG (org.eclipse.jetty.http2.parser.SettingsBodyParser:118) - setting 3=500 2016-04-27 16:44:02,420 DEBUG (org.eclipse.jetty.http2.parser.SettingsBodyParser:118) - setting 5=16384 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.parser.SettingsBodyParser:118) - setting 6=8000 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.HTTP2Session:242) - Received SettingsFrame@295d7e5e,reply=false:{1=4096, 3=500, 5=16384, 6=8000} 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.HTTP2Session:257) - Update HPACK header table size to 4096 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.HTTP2Session:276) - Update max local concurrent streams to 500 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.HTTP2Session:289) - Update max frame size to 16384 2016-04-27 16:44:02,421 WARN (org.eclipse.jetty.http2.HTTP2Session:302) - NOT IMPLEMENTED max header list size to 8000 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.HTTP2Session:618) - Sending SettingsFrame@4e26cdee,reply=true:{} 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:106) - Appended SettingsFrame@4e26cdee,reply=true:{}, frames=1 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.parser.Parser:186) - Parsed SETTINGS frame body from java.nio.HeapByteBuffer[pos=33 lim=33 cap=16384] 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:170) - Dequeued task null 2016-04-27 16:44:02,420 DEBUG (org.eclipse.jetty.io.WriteFlusher:360) - completeWrite: WriteFlusher@21ab53dd{PENDING} 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{COMPLETING}:PENDING-->COMPLETING 2016-04-27 16:44:02,421 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:147) - filled 0 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,4/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,422 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,C,142/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,5/0,SslConnection}{io=0/0,kio=0,kro=1}] net=0 unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 0 bytesProduced = 0 2016-04-27 16:44:02,422 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,C,142/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,5/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,422 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:180) - Filled 0 bytes 2016-04-27 16:44:02,422 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,C,142/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,5/0,SslConnection}{io=0/0,kio=0,kro=1}] flush b[24]=505249202A20485454502F322E300D0A0D0A534D0D0A0D0A 2016-04-27 16:44:02,422 DEBUG (org.eclipse.jetty.io.AbstractConnection:141) - fillInterested HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,C,142/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,5/0,SslConnection}{io=0/0,kio=0,kro=1}] 2016-04-27 16:44:02,422 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,C,142/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,5/0,SslConnection}{io=0/0,kio=0,kro=1}] flush b[15]=00000604000000000000040000FFFF 2016-04-27 16:44:02,423 DEBUG (org.eclipse.jetty.io.FillInterest:63) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,0/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,5/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,423 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:765) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/68,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 39 bytesProduced = 68 2016-04-27 16:44:02,423 DEBUG (org.eclipse.jetty.io.FillInterest:77) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,423 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:803) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/68,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}] wrap OK b[68]=170303003F0000000000000001E7DBF8396CF7130BFBA3DCE8...DDB1CDC25CA135 2016-04-27 16:44:02,423 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:193) - flushed 68 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,424 DEBUG (org.eclipse.jetty.io.AbstractConnection:141) - fillInterested SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,2/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}] 2016-04-27 16:44:02,424 DEBUG (org.eclipse.jetty.io.FillInterest:63) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,2/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,2/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,425 DEBUG (org.eclipse.jetty.io.WriteFlusher:423) - Flushed=true 24/24+1 WriteFlusher@21ab53dd{COMPLETING} 2016-04-27 16:44:02,425 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{IDLE}:COMPLETING-->IDLE 2016-04-27 16:44:02,426 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:268) - Written 2 frames for [PrefaceFrame@68ac2624, SettingsFrame@24509427,reply=false:{4=65535}] 2016-04-27 16:44:02,426 DEBUG (org.eclipse.jetty.io.FillInterest:77) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,C,2/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,2/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,4/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,2/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,426 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:248) - changeInterests p=false 0->1 for SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,2/0,SslConnection}{io=0/1,kio=0,kro=1} 2016-04-27 16:44:02,426 DEBUG (org.eclipse.jetty.io.ManagedSelector:116) - Queued change SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,2/0,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey on org.eclipse.jetty.io.ManagedSelector@33f88ab id=0 keys=1 selected=0 2016-04-27 16:44:02,426 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:165) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produced null 2016-04-27 16:44:02,426 DEBUG (org.eclipse.jetty.io.ManagedSelector:234) - Selector loop woken up from select, 0/1 selected 2016-04-27 16:44:02,427 DEBUG (org.eclipse.jetty.io.ManagedSelector:214) - Running change SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,3/0,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey 2016-04-27 16:44:02,427 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:214) - Key interests updated 0 -> 1 on SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,3/0,SslConnection}{io=1/1,kio=1,kro=1} 2016-04-27 16:44:02,427 DEBUG (org.eclipse.jetty.io.ManagedSelector:231) - Selector loop waiting on select 2016-04-27 16:44:02,427 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:228) - EPR Idle/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produce exit 2016-04-27 16:44:02,428 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:210) - onFillable exit DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,5/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,3/0,SslConnection}{io=1/1,kio=1,kro=1} 2016-04-27 16:44:02,428 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:215) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 ran SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,4/0,SslConnection}{io=1/1,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,428 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:228) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produce exit 2016-04-27 16:44:02,428 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:574) - ran EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,428 DEBUG (org.eclipse.jetty.client.HttpDestination:122) - Processing 1/500 HttpExchange@61b7f85a req=PENDING/null@null res=PENDING/null@null on HttpConnectionOverHTTP2@5a5d00ec[HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=1,sendWindow=65535,recvWindow=65535,streams=0,NOT_CLOSED}] 2016-04-27 16:44:02,432 DEBUG (org.eclipse.jetty.client.HttpChannel:69) - HttpExchange@61b7f85a req=PENDING/null@null res=PENDING/null@null associated true to HttpChannelOverHTTP2@1fd693ba(exchange=HttpExchange@61b7f85a req=PENDING/null@null res=PENDING/null@null) 2016-04-27 16:44:02,432 DEBUG (org.eclipse.jetty.client.HttpSender:219) - Request begin HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a 2016-04-27 16:44:02,433 DEBUG (org.eclipse.jetty.client.HttpSender:237) - Request headers HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a Accept-Encoding: gzip User-Agent: Jetty/9.3.7.v20160115 content-length: 36 Host: api.push.apple.com Content-Type: text/plain;charset=UTF-8 2016-04-27 16:44:02,435 DEBUG (org.eclipse.jetty.http2.HTTP2Session:646) - Created local HTTP2Stream@4e92edce#1{sendWindow=65535,recvWindow=65535,reset=false,NOT_CLOSED} 2016-04-27 16:44:02,435 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:106) - Appended HeadersFrame@3789e8cb#1{end=false}, frames=2 2016-04-27 16:44:02,435 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:137) - Flushing HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=2,sendWindow=65535,recvWindow=65535,streams=1,NOT_CLOSED} 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:214) - Gathered for write SettingsFrame@4e26cdee,reply=true:{} 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:214) - Gathered for write HeadersFrame@3789e8cb#1{end=false} 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.HTTP2Session:1057) - Generated SettingsFrame@4e26cdee,reply=true:{} 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:127) - CtxTbl[5c295614] encoding 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode IdxFieldS1:':scheme: https' to '87' 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode IdxFieldS1:':method: POST' to '83' 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:273) - HdrTbl[5c295614] added {D,0,:authority: api.push.apple.com:443,6d8ded70} 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:337) - HdrTbl[5c295614] entries=1, size=64, max=4096 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode LitIdxNS1HuffVIdx:':authority: api.push.apple.com:443' to '41901d665eBb513aE3AeBa0aB90f4dC69a67' 2016-04-27 16:44:02,436 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:273) - HdrTbl[5c295614] added {D,1,:path: /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887,32cabd3d} 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:337) - HdrTbl[5c295614] entries=2, size=175, max=4096 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode LitIdxNS1HuffVIdx:':path: /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887' to '44B56196242f7310Ac0c01900e3c594607C6F8Db8e4134D8590b6e342138Db2eC61788513f1cAd0dF037236265C0C71bA17c6dC6F3CeFf' 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:273) - HdrTbl[5c295614] added {D,2,Accept-Encoding: gzip,4a7dc41f} 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:337) - HdrTbl[5c295614] entries=3, size=226, max=4096 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode LitIdxNS1HuffVIdx:'Accept-Encoding: gzip' to '50839bD9Ab' 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:273) - HdrTbl[5c295614] added {D,3,User-Agent: Jetty/9.3.7.v20160115,42c44ee7} 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:337) - HdrTbl[5c295614] entries=4, size=289, max=4096 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode LitIdxNS1HuffVIdx:'User-Agent: Jetty/9.3.7.v20160115' to '7a8fCa54A7D30fAeCaEeAfDc400b80085b' 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode LitIdxNS2HuffV!Idx:'content-length: 36' to '0f0d8265Cf' 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:273) - HdrTbl[5c295614] added {D,4,Host: api.push.apple.com,4770b7b8} 2016-04-27 16:44:02,437 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:337) - HdrTbl[5c295614] entries=5, size=343, max=4096 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode LitIdxNS1HuffVIdx:'Host: api.push.apple.com' to '668d1d665eBb513aE3AeBa0aB90f4f' 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:273) - HdrTbl[5c295614] added {D,5,Content-Type: text/plain;charset=UTF-8,301706c} 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:337) - HdrTbl[5c295614] entries=6, size=411, max=4096 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:310) - encode LitIdxNS1HuffVIdx:'Content-Type: text/plain;charset=UTF-8' to '5f92497cA58aE819AaFb24E3B1054c1c37E159Ef' 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.http2.hpack.HpackEncoder:164) - CtxTbl[5c295614] encoded 137 octets 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.http2.HTTP2Session:1057) - Generated HeadersFrame@3789e8cb#1{end=false} 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:252) - Writing 3 buffers (155 bytes) for 2 frames [SettingsFrame@4e26cdee,reply=true:{}, HeadersFrame@3789e8cb#1{end=false}] 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.io.WriteFlusher:306) - write: WriteFlusher@21ab53dd{IDLE} [DirectByteBuffer@4ae9a6fe[p=0,l=9,c=1024,r=9]={<<\x00\x00\x00\x04\x01\x00\x00\x00\x00>>>\x00\x04\x00\x00\xFf\xFf\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},DirectByteBuffer@4819c63d[p=0,l=9,c=1024,r=9]={<<<\x00\x00\x89\x01\x04\x00\x00\x00\x01>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@a9675f1[p=0,l=137,c=16384,r=137]={<<<\x87\x83A\x90\x1df^\xBbQ:\xE3\xAe\xBa\n\xB9\x0fM...\x8a\xE8\x19\xAa\xFb$\xE3\xB1\x05L\x1c7\xE1Y\xEf>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}] 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{WRITING}:IDLE-->WRITING 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,16/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,14/0,SslConnection}{io=1/1,kio=1,kro=1}] flush b[9]=000000040100000000 2016-04-27 16:44:02,438 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,16/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,14/0,SslConnection}{io=1/1,kio=1,kro=1}] flush b[9]=000089010400000001 2016-04-27 16:44:02,439 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,17/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,15/0,SslConnection}{io=1/1,kio=1,kro=1}] flush b[137]=878341901D665EBB513AE3AEBA0AB90F4DC69A6744B5619624...054C1C37E159EF 2016-04-27 16:44:02,439 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:765) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/184,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,17/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,15/0,SslConnection}{io=1/1,kio=1,kro=1}] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 155 bytesProduced = 184 2016-04-27 16:44:02,439 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:803) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/184,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,17/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,15/0,SslConnection}{io=1/1,kio=1,kro=1}] wrap OK b[184]=17030300B300000000000000020C9AA8AA0C3755F91C0A7B47...FD611C1E84C1FA 2016-04-27 16:44:02,440 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:193) - flushed 184 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,16/0,SslConnection}{io=1/1,kio=1,kro=1} 2016-04-27 16:44:02,440 DEBUG (org.eclipse.jetty.io.WriteFlusher:423) - Flushed=true 9/9+2 WriteFlusher@21ab53dd{WRITING} 2016-04-27 16:44:02,440 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{IDLE}:WRITING-->IDLE 2016-04-27 16:44:02,440 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:268) - Written 2 frames for [SettingsFrame@4e26cdee,reply=true:{}, HeadersFrame@3789e8cb#1{end=false}] 2016-04-27 16:44:02,440 DEBUG (org.eclipse.jetty.http2.HTTP2Stream:295) - Update close for HTTP2Stream@4e92edce#1{sendWindow=65535,recvWindow=65535,reset=false,NOT_CLOSED} close=false local=true 2016-04-27 16:44:02,440 DEBUG (org.eclipse.jetty.client.HttpContent:155) - Advanced content to last chunk java.nio.HeapByteBuffer[pos=0 lim=36 cap=36] 2016-04-27 16:44:02,440 DEBUG (org.eclipse.jetty.http2.HTTP2Session:618) - Sending DataFrame@387bd658#1{length:36,end=true} 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:106) - Appended DataFrame@387bd658#1{length:36,end=true}, frames=1 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:137) - Flushing HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=1,sendWindow=65535,recvWindow=65535,streams=1,NOT_CLOSED} 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:214) - Gathered for write DataFrame@387bd658#1{length:36,end=true} 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.http2.HTTP2Session:1193) - Generated DataFrame@387bd658#1{length:36,end=true}, length/window=36/65535 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.http2.FlowControlStrategy:167) - Sending, session send window 65535 -> 65499 for HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=0,sendWindow=65499,recvWindow=65535,streams=1,NOT_CLOSED} 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.http2.FlowControlStrategy:174) - Sending, stream send window 65535 -> 65499 for HTTP2Stream@4e92edce#1{sendWindow=65499,recvWindow=65535,reset=false,NOT_CLOSED} 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:252) - Writing 2 buffers (45 bytes) for 1 frames [DataFrame@387bd658#1{length:36,end=true}] 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.io.WriteFlusher:306) - write: WriteFlusher@21ab53dd{IDLE} [DirectByteBuffer@4ae9a6fe[p=0,l=9,c=1024,r=9]={<<\x00\x00$\x00\x01\x00\x00\x00\x01>>>\x00\x04\x00\x00\xFf\xFf\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@1fb155b[p=0,l=36,c=36,r=36]={<<<{"aps":{"alert":{...y":"welcome"}}}>>}] 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{WRITING}:IDLE-->WRITING 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,19/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,1/0,SslConnection}{io=1/1,kio=1,kro=1}] flush b[9]=000024000100000001 2016-04-27 16:44:02,441 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:734) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,19/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,1/0,SslConnection}{io=1/1,kio=1,kro=1}] flush b[36]=7B22617073223A7B22616C657274223A7B22626F6479223A22...6F6D65227D7D7D 2016-04-27 16:44:02,442 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:765) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/74,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,20/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,2/0,SslConnection}{io=1/1,kio=1,kro=1}] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 45 bytesProduced = 74 2016-04-27 16:44:02,442 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:803) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/74,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,W,20/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,2/0,SslConnection}{io=1/1,kio=1,kro=1}] wrap OK b[74]=1703030045000000000000000346759F8FC615A891ABC50EC6...E6F852C53AB6E2 2016-04-27 16:44:02,442 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:193) - flushed 74 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,2/0,SslConnection}{io=1/1,kio=1,kro=1} 2016-04-27 16:44:02,442 DEBUG (org.eclipse.jetty.io.WriteFlusher:423) - Flushed=true 9/9+1 WriteFlusher@21ab53dd{WRITING} 2016-04-27 16:44:02,442 DEBUG (org.eclipse.jetty.io.WriteFlusher:117) - update WriteFlusher@21ab53dd{IDLE}:WRITING-->IDLE 2016-04-27 16:44:02,442 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:268) - Written 1 frames for [DataFrame@387bd658#1{length:0,end=true}] 2016-04-27 16:44:02,442 DEBUG (org.eclipse.jetty.http2.HTTP2Stream:295) - Update close for HTTP2Stream@4e92edce#1{sendWindow=65499,recvWindow=65535,reset=false,NOT_CLOSED} close=true local=true 2016-04-27 16:44:02,443 DEBUG (org.eclipse.jetty.client.HttpSender:255) - Request committed HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a 2016-04-27 16:44:02,443 DEBUG (org.eclipse.jetty.client.HttpSender:279) - Request content HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a HeapByteBuffer@3ba7db3e[p=0,l=36,c=36,r=36]={<<<{"aps":{"alert":{...y":"welcome"}}}>>>} 2016-04-27 16:44:02,443 DEBUG (org.eclipse.jetty.client.HttpContent:165) - Advanced content past last chunk 2016-04-27 16:44:02,443 DEBUG (org.eclipse.jetty.client.HttpSender:816) - Content present false, last true, consumed true for HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a 2016-04-27 16:44:02,443 DEBUG (org.eclipse.jetty.client.HttpSender:316) - Request success HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a 2016-04-27 16:44:02,443 DEBUG (org.eclipse.jetty.client.HttpExchange:193) - Terminated request for HttpExchange@61b7f85a req=TERMINATED/null@null res=PENDING/null@null, result: null 2016-04-27 16:44:02,444 DEBUG (org.eclipse.jetty.client.HttpSender:363) - Terminating request HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a 2016-04-27 16:44:02,444 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:137) - Flushing HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=0,sendWindow=65499,recvWindow=65535,streams=1,NOT_CLOSED} 2016-04-27 16:44:02,444 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:233) - Flushed HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=0,sendWindow=65499,recvWindow=65535,streams=1,NOT_CLOSED} 2016-04-27 16:44:02,444 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:137) - Flushing HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=0,sendWindow=65499,recvWindow=65535,streams=1,NOT_CLOSED} 2016-04-27 16:44:02,444 DEBUG (org.eclipse.jetty.http2.HTTP2Flusher:233) - Flushed HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=0,sendWindow=65499,recvWindow=65535,streams=1,NOT_CLOSED} 2016-04-27 16:44:02,444 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:574) - ran org.eclipse.jetty.io.ssl.SslConnection$1@193ad4f 2016-04-27 16:44:02,595 DEBUG (org.eclipse.jetty.io.ManagedSelector:234) - Selector loop woken up from select, 1/1 selected 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:159) - onSelected 1->0 r=true w=false for SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,154/0,SslConnection}{io=1/0,kio=1,kro=1} 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:186) - task SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,154/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:165) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produced SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,154/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:206) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 dispatch 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:373) - queue EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:212) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 run SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,154/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.io.FillInterest:93) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,174/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,154/0,SslConnection}{io=1/0,kio=1,kro=1}]}} fillable AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,174/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,154/0,SslConnection}{io=1/0,kio=1,kro=1}]} 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:189) - onFillable enter DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,174/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,154/0,SslConnection}{io=1/0,kio=1,kro=1} 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.io.FillInterest:93) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,174/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,154/0,SslConnection}{io=1/0,kio=1,kro=1}]}} fillable AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,175/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,155/0,SslConnection}{io=1/0,kio=1,kro=1}]} 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:96) - HTTP2 onFillable HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,175/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,155/0,SslConnection}{io=1/0,kio=1,kro=1}] 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:76) - EPR Idle/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 execute 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:154) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produce enter 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:160) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 producing 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:151) - Dequeued task null 2016-04-27 16:44:02,596 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:571) - run EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:147) - filled 38 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,155/0,SslConnection}{io=1/0,kio=1,kro=1} 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:125) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 run 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:154) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produce enter 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:160) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 producing 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:214) - Key interests updated 1 -> 0 on SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,0/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.io.ManagedSelector:231) - Selector loop waiting on select 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=9} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,175/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}] net=38 unwrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 38 bytesProduced = 9 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=9} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,175/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,597 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:180) - Filled 9 bytes 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.http2.parser.Parser:137) - Parsed SETTINGS frame header from java.nio.HeapByteBuffer[pos=9 lim=9 cap=16384] 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.http2.HTTP2Session:242) - Received SettingsFrame@5a99afa9,reply=true:{} 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.http2.parser.Parser:186) - Parsed SETTINGS frame body from java.nio.HeapByteBuffer[pos=9 lim=9 cap=16384] 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:170) - Dequeued task null 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:147) - filled 0 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,176/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] net=0 unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 0 bytesProduced = 0 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,176/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:180) - Filled 0 bytes 2016-04-27 16:44:02,598 DEBUG (org.eclipse.jetty.io.AbstractConnection:141) - fillInterested HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,176/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] 2016-04-27 16:44:02,599 DEBUG (org.eclipse.jetty.io.FillInterest:63) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,0/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,0/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,599 DEBUG (org.eclipse.jetty.io.FillInterest:77) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,2/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,2/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,599 DEBUG (org.eclipse.jetty.io.AbstractConnection:141) - fillInterested SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,2/0,SslConnection}{io=0/0,kio=0,kro=1}] 2016-04-27 16:44:02,599 DEBUG (org.eclipse.jetty.io.FillInterest:63) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,599 DEBUG (org.eclipse.jetty.io.FillInterest:77) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,599 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:248) - changeInterests p=false 0->1 for SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/1,kio=0,kro=1} 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.io.ManagedSelector:116) - Queued change SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,1/0,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey on org.eclipse.jetty.io.ManagedSelector@33f88ab id=0 keys=1 selected=0 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:165) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produced null 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:228) - EPR Idle/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produce exit 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:210) - onFillable exit DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,2/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,1/0,SslConnection}{io=0/1,kio=0,kro=1} 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:215) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 ran SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,1/0,SslConnection}{io=0/1,kio=0,kro=1}:runFillable 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:228) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produce exit 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:574) - ran EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.io.ManagedSelector:234) - Selector loop woken up from select, 0/1 selected 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.io.ManagedSelector:214) - Running change SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,1/0,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:214) - Key interests updated 0 -> 1 on SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,1/0,SslConnection}{io=1/1,kio=1,kro=1} 2016-04-27 16:44:02,600 DEBUG (org.eclipse.jetty.io.ManagedSelector:231) - Selector loop waiting on select 2016-04-27 16:44:02,616 DEBUG (org.eclipse.jetty.io.ManagedSelector:234) - Selector loop woken up from select, 1/1 selected 2016-04-27 16:44:02,616 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:159) - onSelected 1->0 r=true w=false for SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,17/0,SslConnection}{io=1/0,kio=1,kro=1} 2016-04-27 16:44:02,616 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:186) - task SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,17/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:165) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produced SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,18/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:206) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 dispatch 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:373) - queue EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:212) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 run SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,18/0,SslConnection}{io=1/0,kio=1,kro=1}:runFillable 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:571) - run EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:125) - EPR Pend/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 run 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:154) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produce enter 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.io.FillInterest:93) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,19/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,18/0,SslConnection}{io=1/0,kio=1,kro=1}]}} fillable AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,19/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,18/0,SslConnection}{io=1/0,kio=1,kro=1}]} 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:160) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 producing 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:189) - onFillable enter DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,19/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,18/0,SslConnection}{io=1/0,kio=1,kro=1} 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:214) - Key interests updated 1 -> 0 on SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,18/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.io.ManagedSelector:231) - Selector loop waiting on select 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.io.FillInterest:93) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,19/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,18/0,SslConnection}{io=0/0,kio=0,kro=1}]}} fillable AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,19/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,18/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:96) - HTTP2 onFillable HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,19/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,18/0,SslConnection}{io=0/0,kio=0,kro=1}] 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:76) - EPR Idle/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 execute 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:154) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produce enter 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:160) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 producing 2016-04-27 16:44:02,617 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:151) - Dequeued task null 2016-04-27 16:44:02,618 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:147) - filled 104 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,18/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,618 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=66/-1,di=9} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,20/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}] net=104 unwrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 38 bytesProduced = 9 2016-04-27 16:44:02,618 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=66/-1,di=9} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,20/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,618 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:180) - Filled 9 bytes 2016-04-27 16:44:02,618 DEBUG (org.eclipse.jetty.http2.parser.Parser:137) - Parsed HEADERS frame header from java.nio.HeapByteBuffer[pos=9 lim=9 cap=16384] 2016-04-27 16:44:02,618 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:170) - Dequeued task null 2016-04-27 16:44:02,618 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:147) - filled 0 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,0/0,SslConnection}{io=0/0,kio=0,kro=1} 2016-04-27 16:44:02,619 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=37} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,21/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] net=0 unwrap Status = OK HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 66 bytesProduced = 37 2016-04-27 16:44:02,619 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=37} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,21/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,1/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,619 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:180) - Filled 37 bytes 2016-04-27 16:44:02,619 DEBUG (org.eclipse.jetty.http2.hpack.HpackDecoder:72) - CtxTbl[7b5d3b8f] decoding 37 octets 2016-04-27 16:44:02,619 DEBUG (org.eclipse.jetty.http2.hpack.HpackDecoder:85) - decode 8840851d752163499cC176Fb57DfC0Fa... 2016-04-27 16:44:02,619 DEBUG (org.eclipse.jetty.http2.hpack.HpackDecoder:103) - decode IdxStatic {S,8,:status: 200(evaluated),6e51b3a3} 2016-04-27 16:44:02,620 DEBUG (org.eclipse.jetty.http2.hpack.HpackDecoder:85) - decode 40851d752163499cC176Fb57DfC0FaC2... 2016-04-27 16:44:02,620 DEBUG (org.eclipse.jetty.http2.hpack.HpackDecoder:239) - decoded 'apns-id: EBD4D9E9-21C2-15ED-70F7-377AAA3D578D' by HuffName/HuffVal/Idx 2016-04-27 16:44:02,620 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:273) - HdrTbl[7b5d3b8f] added {D,0,apns-id: EBD4D9E9-21C2-15ED-70F7-377AAA3D578D,6d51264e} 2016-04-27 16:44:02,620 DEBUG (org.eclipse.jetty.http2.hpack.HpackContext:337) - HdrTbl[7b5d3b8f] entries=1, size=75, max=4096 2016-04-27 16:44:02,620 DEBUG (org.eclipse.jetty.http2.parser.BodyParser:179) - Parsed HEADERS frame hpack from java.nio.HeapByteBuffer[pos=37 lim=37 cap=16384] 2016-04-27 16:44:02,620 DEBUG (org.eclipse.jetty.http2.client.HTTP2ClientSession:48) - Received HeadersFrame@e7e4cec#1{end=true} 2016-04-27 16:44:02,620 DEBUG (org.eclipse.jetty.http2.HTTP2Stream:295) - Update close for HTTP2Stream@4e92edce#1{sendWindow=65499,recvWindow=65535,reset=false,LOCALLY_CLOSED} close=true local=false 2016-04-27 16:44:02,620 DEBUG (org.eclipse.jetty.http2.HTTP2Session:713) - Removed local HTTP2Stream@4e92edce#1{sendWindow=65499,recvWindow=65535,reset=false,CLOSED} 2016-04-27 16:44:02,621 DEBUG (org.eclipse.jetty.client.HttpReceiver:129) - Response begin HttpResponse[HTTP/2.0 200 null]@620d0a64 2016-04-27 16:44:02,621 DEBUG (org.eclipse.jetty.client.HttpReceiver:255) - Response headers HttpResponse[HTTP/2.0 200 null]@620d0a64 apns-id: EBD4D9E9-21C2-15ED-70F7-377AAA3D578D 2016-04-27 16:44:02,622 DEBUG (org.eclipse.jetty.client.HttpReceiver:388) - Response success HttpResponse[HTTP/2.0 200 null]@620d0a64 2016-04-27 16:44:02,622 DEBUG (org.eclipse.jetty.client.HttpExchange:210) - Terminated response for HttpExchange@61b7f85a req=TERMINATED/null@null res=TERMINATED/null@null, result: Result[HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a > HttpResponse[HTTP/2.0 200 null]@620d0a64] null 2016-04-27 16:44:02,622 DEBUG (org.eclipse.jetty.client.HttpReceiver:443) - Response complete HttpResponse[HTTP/2.0 200 null]@620d0a64 2016-04-27 16:44:02,622 DEBUG (org.eclipse.jetty.client.HttpChannel:89) - HttpExchange@61b7f85a req=TERMINATED/null@null res=TERMINATED/null@null disassociated true from HttpChannelOverHTTP2@1fd693ba(exchange=null) 2016-04-27 16:44:02,622 DEBUG (org.eclipse.jetty.client.HttpDestination:122) - Processing 1/500 null on HttpConnectionOverHTTP2@5a5d00ec[HTTP2ClientSession@2f21086a{l:/192.168.10.80:19289 <-> r:api.push.apple.com/17.110.227.88:443,queueSize=0,sendWindow=65499,recvWindow=65535,streams=0,NOT_CLOSED}] 2016-04-27 16:44:02,623 DEBUG (org.eclipse.jetty.client.HttpReceiver:451) - Request/Response succeeded: Result[HttpRequest[POST /3/device/a01d068efa09a9a5bd245131564226537b18ce29bf4a905d52361bb719a5b887 HTTP/1.1]@65466a6a > HttpResponse[HTTP/2.0 200 null]@620d0a64] null 2016-04-27 16:44:02,623 DEBUG (org.eclipse.jetty.http2.parser.Parser:186) - Parsed HEADERS frame body from java.nio.HeapByteBuffer[pos=37 lim=37 cap=16384] 2016-04-27 16:44:02,623 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:170) - Dequeued task null 2016-04-27 16:44:02,623 DEBUG (org.eclipse.jetty.io.ChannelEndPoint:147) - filled 0 SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,-,-,5/0,SslConnection}{io=0/0,kio=0,kro=1} NotificationResponse{error=null, httpStatusCode=200, responseBody='null', cause=null} 2016-04-27 16:44:02,624 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:534) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,26/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}] net=0 unwrap Status = BUFFER_UNDERFLOW HandshakeStatus = NOT_HANDSHAKING bytesConsumed = 0 bytesProduced = 0 2016-04-27 16:44:02,624 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:535) - SslConnection@58341d8d{NOT_HANDSHAKING,eio=0/-1,di=0} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,26/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}] filled b[0]= 2016-04-27 16:44:02,624 DEBUG (org.eclipse.jetty.http2.HTTP2Connection:180) - Filled 0 bytes 2016-04-27 16:44:02,624 DEBUG (org.eclipse.jetty.io.AbstractConnection:141) - fillInterested HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,-,-,26/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}] 2016-04-27 16:44:02,624 DEBUG (org.eclipse.jetty.io.FillInterest:63) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,0/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,0/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,624 DEBUG (org.eclipse.jetty.io.FillInterest:77) - FillInterest@ad2b270{true,AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,0/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@5f569563{HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,0/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,6/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,625 DEBUG (org.eclipse.jetty.io.AbstractConnection:141) - fillInterested SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,-,-,7/0,SslConnection}{io=0/0,kio=0,kro=1}] 2016-04-27 16:44:02,625 DEBUG (org.eclipse.jetty.io.FillInterest:63) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,625 DEBUG (org.eclipse.jetty.io.FillInterest:77) - FillInterest@16379fb0{true,AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]}} register AC.ReadCB@58341d8d{SslConnection@58341d8d{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HTTP2ClientConnection@5f569563[DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,1/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/0,kio=0,kro=1}]} 2016-04-27 16:44:02,625 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:248) - changeInterests p=false 0->1 for SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/1,kio=0,kro=1} 2016-04-27 16:44:02,625 DEBUG (org.eclipse.jetty.io.ManagedSelector:116) - Queued change SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,0/0,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey on org.eclipse.jetty.io.ManagedSelector@33f88ab id=0 keys=1 selected=0 2016-04-27 16:44:02,625 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:165) - EPR Prod/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produced null 2016-04-27 16:44:02,625 DEBUG (org.eclipse.jetty.io.ManagedSelector:234) - Selector loop woken up from select, 0/1 selected 2016-04-27 16:44:02,625 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:228) - EPR Idle/org.eclipse.jetty.http2.HTTP2Connection$HTTP2Producer@10154ce5 produce exit 2016-04-27 16:44:02,626 DEBUG (org.eclipse.jetty.io.ssl.SslConnection:210) - onFillable exit DecryptedEndPoint@79f09be0{api.push.apple.com/17.110.227.88:443->19289,Open,in,out,FI,-,2/0,HTTP2ClientConnection}->SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<-19289,Open,in,out,FI,-,1/0,SslConnection}{io=0/1,kio=0,kro=1} 2016-04-27 16:44:02,626 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:215) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 ran SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,1/0,SslConnection}{io=0/1,kio=0,kro=1}:runFillable 2016-04-27 16:44:02,626 DEBUG (org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume:228) - EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 produce exit 2016-04-27 16:44:02,626 DEBUG (org.eclipse.jetty.util.thread.QueuedThreadPool:574) - ran EPR Prod/org.eclipse.jetty.io.ManagedSelector$SelectorProducer@e267462 2016-04-27 16:44:02,626 DEBUG (org.eclipse.jetty.io.ManagedSelector:214) - Running change SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,1/0,SslConnection}{io=0/1,kio=0,kro=1}:runUpdateKey 2016-04-27 16:44:02,626 DEBUG (org.eclipse.jetty.io.SelectChannelEndPoint:214) - Key interests updated 0 -> 1 on SelectChannelEndPoint@629c85ae{api.push.apple.com/17.110.227.88:443<->19289,Open,in,out,FI,-,1/0,SslConnection}{io=1/1,kio=1,kro=1} 2016-04-27 16:44:02,626 DEBUG (org.eclipse.jetty.io.ManagedSelector:231) - Selector loop waiting on select

judepereira commented 8 years ago

Can you try using the okHttp client?

medzeus2 commented 8 years ago

When I use OKHTTP, it returns as follow. NotificationResponse{error=null, httpStatusCode=200, responseBody='null', cause=null} But the device also no response.

judepereira commented 8 years ago

The message seems to reach APNs well. There's got to be something with your device like disabled notifications from the settings, or something.

medzeus2 commented 8 years ago

OK, Thanks. It need to request new Certification with http2.The old one cannot be userd.