Giter Club home page Giter Club logo

Comments (16)

yschimke avatar yschimke commented on August 25, 2024

Can you turn on logging with https://square.github.io/okhttp/features/events/

And provide that output?

from okhttp.

speekha avatar speekha commented on August 25, 2024

Here's the logs leading up to the exception. Hope it helps.

2024-07-11 16:01:30.624 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:30] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:01:30.630 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:30] Q10000 run again after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:01:30.630 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:30] Q10000 finished run in   9 ms: OkHttp ConnectionPool 
2024-07-11 16:01:30.630 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:30] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:01:30.630 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:30] Q10000 run again after 938 ms: OkHttp ConnectionPool 
2024-07-11 16:01:30.630 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:30] Q10000 finished run in 212 µs: OkHttp ConnectionPool 
2024-07-11 16:01:31.571 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:31] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:01:31.572 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:31] Q10000 run again after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:01:31.573 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:31] Q10000 finished run in   2 ms: OkHttp ConnectionPool 
2024-07-11 16:01:31.573 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:31] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:01:31.573 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:31] Q10000 run again after   4 s : OkHttp ConnectionPool 
2024-07-11 16:01:31.573 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:31] Q10000 finished run in 191 µs: OkHttp ConnectionPool 
2024-07-11 16:01:35.109 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:35] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:01:35.110 11418-14990 System.err      W  OkHttp Extra [2024-07-11 16:01:35] Q10000 finished run in   2 ms: OkHttp ConnectionPool 
2024-07-11 16:23:58.278 11418-15506 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.278 11418-15507 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 already scheduled     : OkHttp ConnectionPool 
2024-07-11 16:23:58.280 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:23:58.280 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:23:58.281 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 finished run in 430 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.440 11418-15511 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.440 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:23:58.440 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:23:58.440 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 finished run in 285 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.592 11418-15506 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.593 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:23:58.593 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:23:58.594 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 finished run in 841 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.716 11418-15511 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.716 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:23:58.716 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:23:58.717 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 finished run in 316 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.783 11418-15506 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:23:58.783 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:23:58.783 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:23:58.783 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:23:58] Q10000 finished run in 295 µs: OkHttp ConnectionPool 
2024-07-11 16:28:58.602 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:28:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:28:58.624 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:28:58] Q10000 run again after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:28:58.624 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:28:58] Q10000 finished run in  30 ms: OkHttp ConnectionPool 
2024-07-11 16:28:58.625 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:28:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:28:58.627 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:28:58] Q10000 run again after 157 ms: OkHttp ConnectionPool 
2024-07-11 16:28:58.628 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:28:58] Q10000 finished run in   2 ms: OkHttp ConnectionPool 
2024-07-11 16:28:58.785 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:28:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:28:58.787 11418-15510 System.err      W  OkHttp Extra [2024-07-11 16:28:58] Q10000 finished run in   2 ms: OkHttp ConnectionPool 
2024-07-11 16:53:47.000 11418-15715 System.err      W  OkHttp Extra [2024-07-11 16:53:47] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:47.001 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:47] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:47.001 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:47] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:53:47.001 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:47] Q10000 finished run in 620 µs: OkHttp ConnectionPool 
2024-07-11 16:53:47.253 11418-15715 System.err      W  OkHttp Extra [2024-07-11 16:53:47] Q10000 canceled              : OkHttp ConnectionPool 
2024-07-11 16:53:56.493 11418-15756 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:56.493 11418-15715 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 already scheduled     : OkHttp ConnectionPool 
2024-07-11 16:53:56.494 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:56.494 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:53:56.495 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 finished run in 539 µs: OkHttp ConnectionPool 
2024-07-11 16:53:56.705 11418-15757 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:56.706 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:56.706 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:53:56.706 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 finished run in   1 ms: OkHttp ConnectionPool 
2024-07-11 16:53:56.828 11418-15715 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:56.828 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:56.829 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:53:56.829 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:56] Q10000 finished run in 822 µs: OkHttp ConnectionPool 
2024-07-11 16:53:57.050 11418-15757 System.err      W  OkHttp Extra [2024-07-11 16:53:57] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:57.050 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:57] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:57.050 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:57] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:53:57.050 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:57] Q10000 finished run in 454 µs: OkHttp ConnectionPool 
2024-07-11 16:53:57.123 11418-15715 System.err      W  OkHttp Extra [2024-07-11 16:53:57] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:57.123 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:57] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:57.123 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:57] Q10000 run again after 300 s : OkHttp ConnectionPool 
2024-07-11 16:53:57.123 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:57] Q10000 finished run in 226 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.423 11418-15715 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.423 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:58.423 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 run again after 298 s : OkHttp ConnectionPool 
2024-07-11 16:53:58.424 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 finished run in 294 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.443 11418-15757 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.446 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:58.446 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 run again after 298 s : OkHttp ConnectionPool 
2024-07-11 16:53:58.446 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 finished run in   3 ms: OkHttp ConnectionPool 
2024-07-11 16:53:58.608 11418-15757 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.608 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:58.609 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 run again after 298 s : OkHttp ConnectionPool 
2024-07-11 16:53:58.609 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 finished run in 317 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.642 11418-15757 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.642 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:58.643 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 run again after 298 s : OkHttp ConnectionPool 
2024-07-11 16:53:58.643 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 finished run in 790 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.690 11418-15715 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.691 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:58.691 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 run again after 298 s : OkHttp ConnectionPool 
2024-07-11 16:53:58.692 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 finished run in   1 ms: OkHttp ConnectionPool 
2024-07-11 16:53:58.751 11418-15756 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-11 16:53:58.752 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 starting              : OkHttp ConnectionPool 
2024-07-11 16:53:58.753 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 run again after 298 s : OkHttp ConnectionPool 
2024-07-11 16:53:58.753 11418-15721 System.err      W  OkHttp Extra [2024-07-11 16:53:58] Q10000 finished run in   1 ms: OkHttp ConnectionPool 

from okhttp.

yschimke avatar yschimke commented on August 25, 2024

Need the event logging that I linked to. Or a logging network interceptor

from okhttp.

speekha avatar speekha commented on August 25, 2024

Sorry. Misundestood the logs you wanted. Here's the extra logs :

2024-07-12 17:00:16.543 26646-27016 System.err      W  OkHttp Extra [2024-07-12 17:00:16] Q10000 scheduled after   0 µs: OkHttp ConnectionPool 
2024-07-12 17:00:16.543 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:00:16] Q10000 starting              : OkHttp ConnectionPool 
2024-07-12 17:00:16.548 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:00:16] Q10000 run again after 294 s : OkHttp ConnectionPool 
2024-07-12 17:00:16.549 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:00:16] Q10000 finished run in   5 ms: OkHttp ConnectionPool 
2024-07-12 17:00:16.549 26646-27016 System.out      I  0063 0.037 connectionAcquired
2024-07-12 17:00:16.549 26646-27016 System.out      I  0063 0.037 requestHeadersStart
2024-07-12 17:00:16.549 26646-27016 System.out      I  0063 0.037 requestHeadersEnd
2024-07-12 17:00:16.549 26646-27016 System.out      I  0063 0.037 requestBodyStart
2024-07-12 17:00:16.549 26646-27016 System.out      I  0063 0.037 requestBodyEnd
2024-07-12 17:00:18.022 26646-27016 System.out      I  0063 1.510 responseHeadersStart
2024-07-12 17:00:18.023 26646-27016 System.out      I  0063 1.511 responseHeadersEnd
2024-07-12 17:00:18.025 26646-27016 System.out      I  0063 1.513 responseBodyStart
2024-07-12 17:00:18.026 26646-27016 System.out      I  0063 1.514 responseBodyEnd
2024-07-12 17:00:18.026 26646-27016 System.out      I  0063 1.514 connectionReleased
2024-07-12 17:00:18.026 26646-27016 System.out      I  0063 1.515 callEnd
2024-07-12 17:00:18.032 26646-27016 System.out      I  0063 1.520 canceled
2024-07-12 17:00:20.659 26646-27115 System.out      I  0064 https://www….
2024-07-12 17:00:20.660 26646-27115 System.out      I  0064 0.000 callStart
2024-07-12 17:00:20.665 26646-27016 System.out      I  0064 0.005 connectionAcquired
2024-07-12 17:00:20.665 26646-27016 System.out      I  0064 0.005 requestHeadersStart
2024-07-12 17:00:20.665 26646-27016 System.out      I  0064 0.006 requestHeadersEnd
2024-07-12 17:00:20.666 26646-27016 System.out      I  0064 0.006 requestBodyStart
2024-07-12 17:00:20.666 26646-27016 System.out      I  0064 0.006 requestBodyEnd
2024-07-12 17:00:20.668 26646-27016 System.out      I  0064 0.008 responseFailed
2024-07-12 17:00:20.670 26646-27016 System.out      I  0064 0.011 connectionReleased
2024-07-12 17:00:20.670 26646-27016 System.out      I  0064 0.011 callFailed
2024-07-12 17:05:10.697 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:05:10] Q10000 starting              : OkHttp ConnectionPool 
2024-07-12 17:05:10.713 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:05:10] Q10000 run again after   0 µs: OkHttp ConnectionPool 
2024-07-12 17:05:10.714 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:05:10] Q10000 finished run in  57 ms: OkHttp ConnectionPool 
2024-07-12 17:05:10.718 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:05:10] Q10000 starting              : OkHttp ConnectionPool 
2024-07-12 17:05:10.720 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:05:10] Q10000 run again after   2 s : OkHttp ConnectionPool 
2024-07-12 17:05:10.721 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:05:10] Q10000 finished run in   3 ms: OkHttp ConnectionPool 
2024-07-12 17:05:12.638 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:05:12] Q10000 starting              : OkHttp ConnectionPool 
2024-07-12 17:05:12.641 26646-26912 System.err      W  OkHttp Extra [2024-07-12 17:05:12] Q10000 finished run in   4 ms: OkHttp ConnectionPool 

The log says response failed at 17:00:20.668, even though the request was received and the server answered.

from okhttp.

yx-Yaoxaing avatar yx-Yaoxaing commented on August 25, 2024

Has this problem been solved? I have also reproduced it。thanks
image

from okhttp.

speekha avatar speekha commented on August 25, 2024

I haven't had any news since I posted the logs.

from okhttp.

yx-Yaoxaing avatar yx-Yaoxaing commented on August 25, 2024

自从我发布日志以来,还没有收到任何消息。

thanks!!!

from okhttp.

Endeavour233 avatar Endeavour233 commented on August 25, 2024

und: limit=0 content=

自从我发布日志以来,还没有收到任何消息。

thanks!!!

Has this problem been solved? I have also reproduced it。thanks image

Excuse me, can you reproduce the issue consistently?

from okhttp.

Related Issues (20)

Recommend Projects

  • React photo React

    A declarative, efficient, and flexible JavaScript library for building user interfaces.

  • Vue.js photo Vue.js

    🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.

  • Typescript photo Typescript

    TypeScript is a superset of JavaScript that compiles to clean JavaScript output.

  • TensorFlow photo TensorFlow

    An Open Source Machine Learning Framework for Everyone

  • Django photo Django

    The Web framework for perfectionists with deadlines.

  • D3 photo D3

    Bring data to life with SVG, Canvas and HTML. 📊📈🎉

Recommend Topics

  • javascript

    JavaScript (JS) is a lightweight interpreted programming language with first-class functions.

  • web

    Some thing interesting about web. New door for the world.

  • server

    A server is a program made to process requests and deliver data to clients.

  • Machine learning

    Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.

  • Game

    Some thing interesting about game, make everyone happy.

Recommend Org

  • Facebook photo Facebook

    We are working to build community through open source technology. NB: members must have two-factor auth.

  • Microsoft photo Microsoft

    Open source projects and samples from Microsoft.

  • Google photo Google

    Google ❤️ Open Source for everyone.

  • D3 photo D3

    Data-Driven Documents codes.