Closed Bug 1613972 Opened 4 years ago Closed 3 years ago

Intermittent mozproxy File "mitmproxy/proxy/server.py", line 121, in handle

Categories

(Testing :: Mozbase, defect, P5)

Version 3
defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1677298

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

Filed by: dvarga [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=287938976&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NTeRNQncSXKxvKVEB3vuFg/runs/0/artifacts/public/logs/live_backing.log


[task 2020-02-07T15:09:46.056Z] 15:09:46     INFO - switched to tab
[task 2020-02-07T15:09:46.064Z] 15:09:46     INFO - loading https://pinterest.com/
[task 2020-02-07T15:09:53.294Z] 15:09:53     INFO - loaded!
[task 2020-02-07T15:10:08.429Z] 15:10:08     INFO - switching to tab
[task 2020-02-07T15:10:08.431Z] 15:10:08     INFO - switched to tab
[task 2020-02-07T15:10:08.437Z] 15:10:08     INFO - loading https://twitter.com/BarackObama
[task 2020-02-07T15:10:09.625Z] 15:10:09    ERROR - mozproxy Traceback (most recent call last):
[task 2020-02-07T15:10:09.629Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/server.py", line 121, in handle
[task 2020-02-07T15:10:09.630Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/modes/http_proxy.py", line 9, in __call__
[task 2020-02-07T15:10:09.630Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/tls.py", line 286, in __call__
[task 2020-02-07T15:10:09.635Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/http1.py", line 83, in __call__
[task 2020-02-07T15:10:09.635Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/http.py", line 188, in __call__
[task 2020-02-07T15:10:09.636Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/http.py", line 260, in _process_flow
[task 2020-02-07T15:10:09.636Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/http.py", line 206, in handle_regular_connect
[task 2020-02-07T15:10:09.636Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/tls.py", line 281, in __call__
[task 2020-02-07T15:10:09.636Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/tls.py", line 369, in _establish_tls_with_client
[task 2020-02-07T15:10:09.637Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/tls.py", line 501, in _find_cert
[task 2020-02-07T15:10:09.637Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/certs.py", line 326, in get_cert
[task 2020-02-07T15:10:09.637Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/certs.py", line 156, in expire
[task 2020-02-07T15:10:09.637Z] 15:10:09    ERROR - mozproxy RuntimeError: dictionary changed size during iteration
[task 2020-02-07T15:10:09.637Z] 15:10:09    ERROR - mozproxy 
[task 2020-02-07T15:10:09.637Z] 15:10:09    ERROR - mozproxy mitmproxy has crashed!
[task 2020-02-07T15:10:09.638Z] 15:10:09    ERROR - mozproxy Please lodge a bug report at: https://github.com/mitmproxy/mitmproxy
[task 2020-02-07T15:10:09.639Z] 15:10:09    ERROR - mozproxy 127.0.0.1:45706: Traceback (most recent call last):
[task 2020-02-07T15:10:09.639Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/server.py", line 121, in handle
[task 2020-02-07T15:10:09.640Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/modes/http_proxy.py", line 9, in __call__
[task 2020-02-07T15:10:09.640Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/tls.py", line 286, in __call__
[task 2020-02-07T15:10:09.641Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/http1.py", line 83, in __call__
[task 2020-02-07T15:10:09.641Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/http.py", line 188, in __call__
[task 2020-02-07T15:10:09.642Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/http.py", line 260, in _process_flow
[task 2020-02-07T15:10:09.643Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/http.py", line 206, in handle_regular_connect
[task 2020-02-07T15:10:09.645Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/tls.py", line 281, in __call__
[task 2020-02-07T15:10:09.646Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/tls.py", line 369, in _establish_tls_with_client
[task 2020-02-07T15:10:09.647Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/proxy/protocol/tls.py", line 501, in _find_cert
[task 2020-02-07T15:10:09.647Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/certs.py", line 326, in get_cert
[task 2020-02-07T15:10:09.648Z] 15:10:09    ERROR - mozproxy   File "mitmproxy/certs.py", line 156, in expire
[task 2020-02-07T15:10:09.648Z] 15:10:09    ERROR - mozproxy RuntimeError: dictionary changed size during iteration
[task 2020-02-07T15:10:09.649Z] 15:10:09    ERROR - mozproxy 
[task 2020-02-07T15:10:13.956Z] 15:10:13     INFO - loaded!
[task 2020-02-07T15:10:29.152Z] 15:10:29     INFO - switching to tab
[task 2020-02-07T15:10:29.153Z] 15:10:29     INFO - switched to tab
[task 2020-02-07T15:10:29.153Z] 15:10:29     INFO - loading https://www.amazon.com/s?k=laptop&ref=nb_sb_noss_1

This is all for AWSY tests and happens with mitmproxy 4.0.4. The code is here:
https://github.com/mitmproxy/mitmproxy/blob/v4.0.4/mitmproxy/proxy/server.py#L121

Are there any plans to upgrade to version 5.0.1?

Flags: needinfo?(fstrugariu)

Yes we should move to 5.0.1 as soon as possibile.
Bug 1614565 - [Mozproxy] Add mitmproxy 5.0.1 capability to mozproxy

Flags: needinfo?(fstrugariu)

Maybe the upgrade will help, or at least will move the line in server.py. We should keep an eye on it.

Depends on: 1614565

AWSY tests are still using mitmproxy 4.0.4:

[task 2020-03-15T20:08:00.506Z] 20:08:00     INFO - mozproxy mozproxy_dir used for mitmproxy downloads and exe files: Z:\task_1584302545\build\tests\html\testing\mozproxy
[task 2020-03-15T20:08:00.506Z] 20:08:00     INFO - mozproxy Playback tool: mitmproxy
[task 2020-03-15T20:08:00.506Z] 20:08:00     INFO - mozproxy Playback tool version: 4.0.4

Florin, can we get it updated to the new 5.x release, preferable on a new to file bug? Thanks.

Flags: needinfo?(fstrugariu)

@Henrick Thewe where some issues with mitmproxy last week but they should be fixed.

We will move to mitm 5.0.2 after is tested and everything works as expected...

Flags: needinfo?(fstrugariu)
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.