Kevin Moore
2018-07-14 05:31:09 UTC
I develop web pages on embedded telecommunications equipment, and we have 3
similar products, running on 3 different Power PC processors, 860, 8313,
and 1014. We use Open SSL for our HTTPS web pages. Our web pages load with
no problems on the 860 and 1014 processors, but we are sometimes having
problems with the 8313 product.
Below are both good and bad event traces on the login page of the 8313
product. Shown in RED, are where the traces start to diverge. My guess is
that we have an Ethernet or SSL issue, and I plan on looking into the
difference between the packet captures of both the good and bad cases. The
problem is that everything will be encrypted at the packet level, so this
will make the issue much harder to look into.
It looks to me like things start to go downhill at the following line in
the bad capture:
t=27494 [st= 34] URL_REQUEST_DELEGATE [dt=3]
I was hopping I could get some feedback as to what URL_REQUEST_DELEGATE
means. I have searched on this term, but I have not been able to find any
info on it yet. Any feedback would be appreciated.
Kevin
*Good capture:*
155943: URL_REQUEST
https://10.100.38.111/web/common/js/compiled_header_scripts.js
Start Time: 2018-07-13 18:34:29.490
t=3062 [st= 0] +REQUEST_ALIVE [dt=429]
--> priority = "MEDIUM"
--> url = "https://10.100.38.111/web/common/js/compiled_header_scripts.js"
t=3062 [st= 0] URL_REQUEST_DELEGATE [dt=0]
t=3062 [st= 0] +URL_REQUEST_START_JOB [dt=331]
--> load_flags = 16386 (BYPASS_CACHE | MAYBE_USER_GESTURE)
--> method = "GET"
--> url = "https://10.100.38.111/web/common/js/compiled_header_scripts.js"
t=3062 [st= 0] URL_REQUEST_DELEGATE [dt=0]
t=3062 [st= 0] HTTP_CACHE_GET_BACKEND [dt=0]
t=3062 [st= 0] HTTP_CACHE_DOOM_ENTRY [dt=1]
--> net_error = -2 (ERR_FAILED)
t=3063 [st= 1] HTTP_CACHE_CREATE_ENTRY [dt=1]
t=3064 [st= 2] HTTP_CACHE_ADD_TO_ENTRY [dt=1]
t=3065 [st= 3] +HTTP_STREAM_REQUEST [dt=287]
t=3065 [st= 3] HTTP_STREAM_JOB_CONTROLLER_BOUND
--> source_dependency = 155954 (HTTP_STREAM_JOB_CONTROLLER) <chrome://net-internals/#events&s=155954>
t=3352 [st=290] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 155956 (HTTP_STREAM_JOB) <chrome://net-internals/#events&s=155956>
t=3352 [st=290] -HTTP_STREAM_REQUESTt=3352 [st=290] +HTTP_TRANSACTION_SEND_REQUEST [dt=0]
t=3352 [st=290] HTTP_TRANSACTION_SEND_REQUEST_HEADERS
...
*Bad capture:*
155810: URL_REQUESThttps://10.100.38.111/web/common/css/login.css
Start Time: 2018-07-13 18:31:23.723
t=27460 [st= 0] +REQUEST_ALIVE [dt=537]
--> priority = "HIGHEST"
--> url = "https://10.100.38.111/web/common/css/login.css"
t=27460 [st= 0] URL_REQUEST_DELEGATE [dt=0]
t=27460 [st= 0] +URL_REQUEST_START_JOB [dt=536]
--> load_flags = 16386 (BYPASS_CACHE | MAYBE_USER_GESTURE)
--> method = "GET"
--> url = "https://10.100.38.111/web/common/css/login.css"
t=27460 [st= 0] URL_REQUEST_DELEGATE [dt=0]
t=27460 [st= 0] HTTP_CACHE_GET_BACKEND [dt=0]
t=27460 [st= 0] HTTP_CACHE_DOOM_ENTRY [dt=1]
--> net_error = -2 (ERR_FAILED)
t=27461 [st= 1] HTTP_CACHE_CREATE_ENTRY [dt=1]
t=27462 [st= 2] HTTP_CACHE_ADD_TO_ENTRY [dt=1]
t=27463 [st= 3] +HTTP_STREAM_REQUEST [dt=31]
t=27463 [st= 3] HTTP_STREAM_JOB_CONTROLLER_BOUND
--> source_dependency = 155830 (HTTP_STREAM_JOB_CONTROLLER) <chrome://net-internals/#events&s=155830>
t=27494 [st= 34] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 155831 (HTTP_STREAM_JOB) <chrome://net-internals/#events&s=155831>
t=27494 [st= 34] -HTTP_STREAM_REQUESTt=27494 [st= 34] URL_REQUEST_DELEGATE [dt=3]
t=27497 [st= 37] +HTTP_STREAM_REQUEST [dt=499]
t=27497 [st= 37] HTTP_STREAM_JOB_CONTROLLER_BOUND
--> source_dependency = 155850 (HTTP_STREAM_JOB_CONTROLLER) <chrome://net-internals/#events&s=155850>
t=27533 [st= 73] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 155851 (HTTP_STREAM_JOB) <chrome://net-internals/#events&s=155851>
t=27533 [st= 73] SSL_VERSION_INTERFERENCE_PROBE
--> net_error = -101 (ERR_CONNECTION_RESET)
t=27533 [st= 73] +HTTP_STREAM_REQUEST [dt=1]
t=27533 [st= 73] HTTP_STREAM_JOB_CONTROLLER_BOUND
--> source_dependency = 155860 (HTTP_STREAM_JOB_CONTROLLER) <chrome://net-internals/#events&s=155860>
t=27534 [st= 74] -HTTP_STREAM_REQUEST
t=27996 [st=536] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 155861 (HTTP_STREAM_JOB) <chrome://net-internals/#events&s=155861>
t=27996 [st=536] -HTTP_STREAM_REQUEST
t=27996 [st=536] -URL_REQUEST_START_JOB
--> net_error = -175 (ERR_SSL_VERSION_INTERFERENCE)
t=27996 [st=536] URL_REQUEST_DELEGATE [dt=1]
t=27997 [st=537] -REQUEST_ALIVE
--> net_error = -175 (ERR_SSL_VERSION_INTERFERENCE)
similar products, running on 3 different Power PC processors, 860, 8313,
and 1014. We use Open SSL for our HTTPS web pages. Our web pages load with
no problems on the 860 and 1014 processors, but we are sometimes having
problems with the 8313 product.
Below are both good and bad event traces on the login page of the 8313
product. Shown in RED, are where the traces start to diverge. My guess is
that we have an Ethernet or SSL issue, and I plan on looking into the
difference between the packet captures of both the good and bad cases. The
problem is that everything will be encrypted at the packet level, so this
will make the issue much harder to look into.
It looks to me like things start to go downhill at the following line in
the bad capture:
t=27494 [st= 34] URL_REQUEST_DELEGATE [dt=3]
I was hopping I could get some feedback as to what URL_REQUEST_DELEGATE
means. I have searched on this term, but I have not been able to find any
info on it yet. Any feedback would be appreciated.
Kevin
*Good capture:*
155943: URL_REQUEST
https://10.100.38.111/web/common/js/compiled_header_scripts.js
Start Time: 2018-07-13 18:34:29.490
t=3062 [st= 0] +REQUEST_ALIVE [dt=429]
--> priority = "MEDIUM"
--> url = "https://10.100.38.111/web/common/js/compiled_header_scripts.js"
t=3062 [st= 0] URL_REQUEST_DELEGATE [dt=0]
t=3062 [st= 0] +URL_REQUEST_START_JOB [dt=331]
--> load_flags = 16386 (BYPASS_CACHE | MAYBE_USER_GESTURE)
--> method = "GET"
--> url = "https://10.100.38.111/web/common/js/compiled_header_scripts.js"
t=3062 [st= 0] URL_REQUEST_DELEGATE [dt=0]
t=3062 [st= 0] HTTP_CACHE_GET_BACKEND [dt=0]
t=3062 [st= 0] HTTP_CACHE_DOOM_ENTRY [dt=1]
--> net_error = -2 (ERR_FAILED)
t=3063 [st= 1] HTTP_CACHE_CREATE_ENTRY [dt=1]
t=3064 [st= 2] HTTP_CACHE_ADD_TO_ENTRY [dt=1]
t=3065 [st= 3] +HTTP_STREAM_REQUEST [dt=287]
t=3065 [st= 3] HTTP_STREAM_JOB_CONTROLLER_BOUND
--> source_dependency = 155954 (HTTP_STREAM_JOB_CONTROLLER) <chrome://net-internals/#events&s=155954>
t=3352 [st=290] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 155956 (HTTP_STREAM_JOB) <chrome://net-internals/#events&s=155956>
t=3352 [st=290] -HTTP_STREAM_REQUESTt=3352 [st=290] +HTTP_TRANSACTION_SEND_REQUEST [dt=0]
t=3352 [st=290] HTTP_TRANSACTION_SEND_REQUEST_HEADERS
...
*Bad capture:*
155810: URL_REQUESThttps://10.100.38.111/web/common/css/login.css
Start Time: 2018-07-13 18:31:23.723
t=27460 [st= 0] +REQUEST_ALIVE [dt=537]
--> priority = "HIGHEST"
--> url = "https://10.100.38.111/web/common/css/login.css"
t=27460 [st= 0] URL_REQUEST_DELEGATE [dt=0]
t=27460 [st= 0] +URL_REQUEST_START_JOB [dt=536]
--> load_flags = 16386 (BYPASS_CACHE | MAYBE_USER_GESTURE)
--> method = "GET"
--> url = "https://10.100.38.111/web/common/css/login.css"
t=27460 [st= 0] URL_REQUEST_DELEGATE [dt=0]
t=27460 [st= 0] HTTP_CACHE_GET_BACKEND [dt=0]
t=27460 [st= 0] HTTP_CACHE_DOOM_ENTRY [dt=1]
--> net_error = -2 (ERR_FAILED)
t=27461 [st= 1] HTTP_CACHE_CREATE_ENTRY [dt=1]
t=27462 [st= 2] HTTP_CACHE_ADD_TO_ENTRY [dt=1]
t=27463 [st= 3] +HTTP_STREAM_REQUEST [dt=31]
t=27463 [st= 3] HTTP_STREAM_JOB_CONTROLLER_BOUND
--> source_dependency = 155830 (HTTP_STREAM_JOB_CONTROLLER) <chrome://net-internals/#events&s=155830>
t=27494 [st= 34] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 155831 (HTTP_STREAM_JOB) <chrome://net-internals/#events&s=155831>
t=27494 [st= 34] -HTTP_STREAM_REQUESTt=27494 [st= 34] URL_REQUEST_DELEGATE [dt=3]
t=27497 [st= 37] +HTTP_STREAM_REQUEST [dt=499]
t=27497 [st= 37] HTTP_STREAM_JOB_CONTROLLER_BOUND
--> source_dependency = 155850 (HTTP_STREAM_JOB_CONTROLLER) <chrome://net-internals/#events&s=155850>
t=27533 [st= 73] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 155851 (HTTP_STREAM_JOB) <chrome://net-internals/#events&s=155851>
t=27533 [st= 73] SSL_VERSION_INTERFERENCE_PROBE
--> net_error = -101 (ERR_CONNECTION_RESET)
t=27533 [st= 73] +HTTP_STREAM_REQUEST [dt=1]
t=27533 [st= 73] HTTP_STREAM_JOB_CONTROLLER_BOUND
--> source_dependency = 155860 (HTTP_STREAM_JOB_CONTROLLER) <chrome://net-internals/#events&s=155860>
t=27534 [st= 74] -HTTP_STREAM_REQUEST
t=27996 [st=536] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 155861 (HTTP_STREAM_JOB) <chrome://net-internals/#events&s=155861>
t=27996 [st=536] -HTTP_STREAM_REQUEST
t=27996 [st=536] -URL_REQUEST_START_JOB
--> net_error = -175 (ERR_SSL_VERSION_INTERFERENCE)
t=27996 [st=536] URL_REQUEST_DELEGATE [dt=1]
t=27997 [st=537] -REQUEST_ALIVE
--> net_error = -175 (ERR_SSL_VERSION_INTERFERENCE)
--
--
Chromium Discussion mailing list: chromium-***@chromium.org
View archives, change email options, or unsubscribe:
http://groups.google.com/a/chromium.org/group/chromium-discuss
---
You received this message because you are subscribed to the Google Groups "Chromium-discuss" group.
To unsubscribe from this group and stop receiving emails from it, send an email to chromium-discuss+***@chromium.org.
--
Chromium Discussion mailing list: chromium-***@chromium.org
View archives, change email options, or unsubscribe:
http://groups.google.com/a/chromium.org/group/chromium-discuss
---
You received this message because you are subscribed to the Google Groups "Chromium-discuss" group.
To unsubscribe from this group and stop receiving emails from it, send an email to chromium-discuss+***@chromium.org.