1916979 - Intermittent testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_timeout TEST-UNEXPECTED-FAIL

Status: RESOLVED INCOMPLETE

(Testing :: Mozbase, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: tszentpeteri [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=473036220&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NLTbYMA0Q0CXAmolTk9dlw/runs/0/artifacts/public/logs/live_backing.log

---

[task 2024-09-05T11:32:03.664Z] 
[task 2024-09-05T11:32:03.664Z] Tests Completed: 100%|██████████| 87/87 [01:06<00:00,  9.36s/Test]
[task 2024-09-05T11:32:03.664Z]                                                                   
[task 2024-09-05T11:32:03.664Z] /opt/worker/tasks/task_172553276771738/checkouts/gecko/testing/mozbase/mozprocess/tests/test_process_reader.py
[task 2024-09-05T11:32:03.664Z] ============================= test session starts ==============================
[task 2024-09-05T11:32:03.664Z] platform darwin -- Python 3.8.10, pytest-7.0.1, pluggy-0.13.1 -- /Users/cltbld/.mozbuild/srcdirs/gecko-eb8a38f30bf4/_virtualenvs/python-test/bin/python
[task 2024-09-05T11:32:03.665Z] rootdir: /opt/worker/tasks/task_172553276771738/checkouts/gecko, configfile: config/mozunit/mozunit/pytest.ini
[task 2024-09-05T11:32:03.665Z] plugins: mock-3.12.0
[task 2024-09-05T11:32:03.665Z] collecting ... collected 9 items
[task 2024-09-05T11:32:03.665Z] 
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_finished_callback PASSED
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_mixed_stdout_stderr PASSED
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_output_timeout PASSED
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_read_with_strange_eol PASSED
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_read_without_eol PASSED
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_stderr_callback PASSED
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_stdout_and_stderr_callbacks PASSED
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_stdout_callback PASSED
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_timeout TEST-UNEXPECTED-FAIL
[task 2024-09-05T11:32:03.665Z] 
[task 2024-09-05T11:32:03.665Z] =================================== FAILURES ===================================
[task 2024-09-05T11:32:03.665Z] ________________________ TestProcessReader.test_timeout ________________________
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py:74: in test_timeout
[task 2024-09-05T11:32:03.665Z]     self.assertTrue(self.timeout)
[task 2024-09-05T11:32:03.665Z] E   AssertionError: False is not true
[task 2024-09-05T11:32:03.665Z] =============================== warnings summary ===============================
[task 2024-09-05T11:32:03.665Z] testing/mozbase/mozprocess/tests/test_process_reader.py::TestProcessReader::test_timeout
[task 2024-09-05T11:32:03.665Z]   /Users/cltbld/.mozbuild/srcdirs/gecko-eb8a38f30bf4/_virtualenvs/python-test/lib/python3.8/site-packages/_pytest/threadexception.py:73: PytestUnhandledThreadExceptionWarning: Exception in thread ProcessReader
[task 2024-09-05T11:32:03.665Z] 
[task 2024-09-05T11:32:03.665Z]   Traceback (most recent call last):
[task 2024-09-05T11:32:03.665Z]     File "/opt/worker/tasks/task_172553276771738/fetches/python/lib/python3.8/threading.py", line 932, in _bootstrap_inner
[task 2024-09-05T11:32:03.665Z]       self.run()
[task 2024-09-05T11:32:03.665Z]     File "/opt/worker/tasks/task_172553276771738/fetches/python/lib/python3.8/threading.py", line 870, in run
[task 2024-09-05T11:32:03.665Z]       self._target(*self._args, **self._kwargs)
[task 2024-09-05T11:32:03.665Z]     File "/opt/worker/tasks/task_172553276771738/checkouts/gecko/testing/mozbase/mozprocess/mozprocess/processhandler.py", line 1151, in _read
[task 2024-09-05T11:32:03.665Z]       for line, callback in iter(get_line, (b"", None)):
[task 2024-09-05T11:32:03.665Z]     File "/opt/worker/tasks/task_172553276771738/checkouts/gecko/testing/mozbase/mozprocess/mozprocess/processhandler.py", line 1145, in get_line
[task 2024-09-05T11:32:03.665Z]       return queue.get(timeout=queue_timeout)
[task 2024-09-05T11:32:03.666Z]     File "/opt/worker/tasks/task_172553276771738/fetches/python/lib/python3.8/queue.py", line 172, in get
[task 2024-09-05T11:32:03.666Z]       raise ValueError("'timeout' must be a non-negative number")
[task 2024-09-05T11:32:03.666Z]   ValueError: 'timeout' must be a non-negative number
[task 2024-09-05T11:32:03.666Z] 
[task 2024-09-05T11:32:03.666Z]     warnings.warn(pytest.PytestUnhandledThreadExceptionWarning(msg))
[task 2024-09-05T11:32:03.666Z] 
[task 2024-09-05T11:32:03.666Z] -- Docs: https://docs.pytest.org/en/stable/how-to/capture-warnings.html
[task 2024-09-05T11:32:03.666Z] ==================== 1 failed, 8 passed, 1 warning in 0.95s ====================
[task 2024-09-05T11:32:03.666Z] 
[task 2024-09-05T11:32:03.666Z] 
[task 2024-09-05T11:32:03.666Z] Tests Completed: 100%|██████████| 87/87 [01:06<00:00,  1.32Test/s]Return code from mach python-test: 1
[task 2024-09-05T11:32:03.712Z] 
[taskcluster 2024-09-05T11:32:03.767Z]    Exit Code: 1
[taskcluster 2024-09-05T11:32:03.767Z]    User Time: 7m9.889764s
[taskcluster 2024-09-05T11:32:03.767Z]  Kernel Time: 6m14.680054s
[taskcluster 2024-09-05T11:32:03.767Z]    Wall Time: 3m35.596208s
[taskcluster 2024-09-05T11:32:03.767Z]       Result: FAILED
[taskcluster 2024-09-05T11:32:03.768Z] === Task Finished ===
[taskcluster 2024-09-05T11:32:03.768Z] Task Duration: 3m35.601735s

Comment 1

[Intermittent Failures Robot]

5 failures in 3668 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 5

Platform and build breakdown:

• macosx1015-64: 5
  • opt: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-09-02&endday=2024-09-08&tree=all

Comment 2

[Intermittent Failures Robot]

3 failures in 4448 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2
• autoland: 1

Platform and build breakdown:

• macosx1015-64: 3
  • opt: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-09-09&endday=2024-09-15&tree=all

Comment 3

[Intermittent Failures Robot]

1 failures in 4860 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1015-64: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-09-16&endday=2024-09-22&tree=all

Comment 4

[Intermittent Failures Robot]

3 failures in 4889 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 3

Platform and build breakdown:

• macosx1015-64: 3
  • opt: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-09-23&endday=2024-09-29&tree=all

Comment 5

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.

Comment 6

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=480021135&repo=autoland

Comment 7

[Intermittent Failures Robot]

1 failures in 4361 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1015-64: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-10-28&endday=2024-11-03&tree=all

Comment 8

[Intermittent Failures Robot]

1 failures in 4515 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• macosx1015-64: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-11-04&endday=2024-11-10&tree=all

Comment 9

[Intermittent Failures Robot]

1 failures in 3002 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1015-64: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-11-18&endday=2024-11-24&tree=all

Comment 10

[Intermittent Failures Robot]

2 failures in 4722 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 2

Platform and build breakdown:

• macosx1015-64: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-12-02&endday=2024-12-08&tree=all

Comment 11

[Intermittent Failures Robot]

Summary

1 failures in 3774 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• macosx1015-64: 1
  • opt: 1

Table

	1proc	1proc-s	1proc-swr	a11y-checks	a11y-checks-s	a11y-checks-swr	a11y-checks-swr-s	condprof-s	fis	fis-hv	fis-hv-s	fis-s	headless	headless-s	http2	http3	mda-gpu	mda-gpu-s	msix	msix-s	no_variant	nofis	nofis-aab	nofis-s	nofis-ship	nofis-ship-s	nofis-spi	nofis-swr	nofis-swr-s	nogpu	nogpu-s	s	spi	spi-nw	spi-nw-1proc	spi-nw-nofis	spi-nw-nofis-s	spi-nw-s	spi-s	swr	swr-s	vt	vt-s	wmfme	wr-dc1-p	wr-dc2-o	wr-dc3-c	wr-dc3-c-s	xorig	xorig-s
macosx1015-64/opt																					1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-12-16&endday=2024-12-22&tree=all

Comment 12

[Intermittent Failures Robot]

Summary

1 failures in 1319 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• macosx1015-64: 1
  • opt: 1

Table

	no_variant
macosx1015-64/opt	1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2024-12-30&endday=2025-01-05&tree=all

Comment 13

[Intermittent Failures Robot]

Summary

1 failures in 4508 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• macosx1015-64: 1
  • opt: 1

Table

	no_variant
macosx1015-64/-/opt	1

For more details, see:

https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1916979&startday=2025-01-13&endday=2025-01-19&tree=all

Comment 14

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.