1666661 - Intermittent TEST-UNEXPECTED-TIMEOUT | dom/media/tests/mochitest/test_enumerateDevices.html | application timed out after 370 seconds with no output

Status: RESOLVED INCOMPLETE

(Core :: WebRTC, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2020-09-23T00:32:44.219Z] 00:32:44     INFO - TEST-PASS | dom/media/tests/mochitest/test_enumerateDevices.html | unknown plain deviceId on video must succeed 
[task 2020-09-23T00:32:44.219Z] 00:32:44     INFO - TEST-PASS | dom/media/tests/mochitest/test_enumerateDevices.html | unknown plain deviceId on audio must succeed 
[task 2020-09-23T00:32:44.219Z] 00:32:44     INFO - Buffered messages finished
[task 2020-09-23T00:32:44.219Z] 00:32:44    ERROR - TEST-UNEXPECTED-TIMEOUT | dom/media/tests/mochitest/test_enumerateDevices.html | application timed out after 370 seconds with no output
[task 2020-09-23T00:32:44.219Z] 00:32:44    ERROR - Force-terminating active process(es).
[task 2020-09-23T00:32:44.219Z] 00:32:44     INFO - Determining child pids from psutil...
[task 2020-09-23T00:32:44.238Z] 00:32:44     INFO - [2404, 2297, 2326, 2331, 2336, 2484, 2445]
[task 2020-09-23T00:32:44.238Z] 00:32:44     INFO - ==> process 2228 launched child process 2250
[task 2020-09-23T00:32:44.238Z] 00:32:44     INFO - ==> process 2228 launched child process 2297
[task 2020-09-23T00:32:44.239Z] 00:32:44     INFO - ==> process 2228 launched child process 2326
[task 2020-09-23T00:32:44.240Z] 00:32:44     INFO - ==> process 2228 launched child process 2331
[task 2020-09-23T00:32:44.241Z] 00:32:44     INFO - ==> process 2228 launched child process 2336
[task 2020-09-23T00:32:44.241Z] 00:32:44     INFO - ==> process 2228 launched child process 2404
[task 2020-09-23T00:32:44.242Z] 00:32:44     INFO - ==> process 2228 launched child process 2445
[task 2020-09-23T00:32:44.243Z] 00:32:44     INFO - ==> process 2228 launched child process 2484
[task 2020-09-23T00:32:44.243Z] 00:32:44     INFO - Found child pids: set([2336, 2404, 2250, 2445, 2484, 2326, 2297, 2331])
[task 2020-09-23T00:32:44.246Z] 00:32:44     INFO - Failed to get child procs
[task 2020-09-23T00:32:44.246Z] 00:32:44     INFO - Killing process: 2336
[task 2020-09-23T00:32:44.246Z] 00:32:44     INFO - TEST-INFO | started process screentopng```

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1666661&startday=2020-09-21&endday=2020-09-27&tree=all

Comment 2

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

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

Comment 3

[Andreea Pavel [:apavel]]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=321727847&repo=mozilla-central&lineNumber=16725

[task 2020-11-13T17:44:39.947Z] 17:44:39 INFO - TEST-START | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html
[task 2020-11-13T17:44:40.210Z] 17:44:40 INFO - GECKO(2158) | TEST DEVICES: Got loopback audio: Monitor of Null Output
[task 2020-11-13T17:44:40.210Z] 17:44:40 INFO - GECKO(2158) | TEST DEVICES: Got loopback video: Dummy video device (0x0000)
[task 2020-11-13T17:44:40.536Z] 17:44:40 INFO - GECKO(2158) | 1605289480533 Marionette TRACE Received observer notification toplevel-window-ready
[task 2020-11-13T17:47:47.942Z] 17:47:47 INFO - GECKO(2158) | 1605289667935 addons.xpi ERROR System addon update list error Error: got node name: html, expected: updates
[task 2020-11-13T17:53:57.961Z] 17:53:57 INFO - Buffered messages logged at 17:44:40
[task 2020-11-13T17:53:57.962Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | A valid string reason is expected
[task 2020-11-13T17:53:57.962Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | Reason cannot be empty
[task 2020-11-13T17:53:57.962Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | At least one device found
[task 2020-11-13T17:53:57.962Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | kind survived serializer
[task 2020-11-13T17:53:57.963Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | deviceId survived serializer
[task 2020-11-13T17:53:57.963Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | Known device kind
[task 2020-11-13T17:53:57.963Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | deviceId length id as expected for Firefox
[task 2020-11-13T17:53:57.964Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | Device label: Dummy video device (0x0000)
[task 2020-11-13T17:53:57.964Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | groupId must be present.
[task 2020-11-13T17:53:57.964Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | Track label is a string
[task 2020-11-13T17:53:57.964Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | Track label is the device label
[task 2020-11-13T17:53:57.964Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | Known device kind
[task 2020-11-13T17:53:57.964Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | deviceId length id as expected for Firefox
[task 2020-11-13T17:53:57.965Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | Device label: Monitor of Null Output
[task 2020-11-13T17:53:57.966Z] 17:53:57 INFO - TEST-PASS | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | groupId must be present.
[task 2020-11-13T17:53:57.966Z] 17:53:57 INFO - Buffered messages finished
[task 2020-11-13T17:53:57.966Z] 17:53:57 ERROR - TEST-UNEXPECTED-TIMEOUT | dom/media/webrtc/tests/mochitests/test_enumerateDevices.html | application timed out after 370 seconds with no output
[task 2020-11-13T17:53:57.966Z] 17:53:57 ERROR - Force-terminating active process(es).
[task 2020-11-13T17:53:57.966Z] 17:53:57 INFO - Determining child pids from psutil...
[task 2020-11-13T17:53:57.969Z] 17:53:57 INFO - [2226, 2208, 2270, 2298, 2347, 2534]
[task 2020-11-13T17:53:57.970Z] 17:53:57 INFO - ==> process 2158 launched child process 2174
[task 2020-11-13T17:53:57.970Z] 17:53:57 INFO - ==> process 2158 launched child process 2226
[task 2020-11-13T17:53:57.970Z] 17:53:57 INFO - ==> process 2158 launched child process 2270
[task 2020-11-13T17:53:57.970Z] 17:53:57 INFO - ==> process 2158 launched child process 2298
[task 2020-11-13T17:53:57.970Z] 17:53:57 INFO - ==> process 2158 launched child process 2347
[task 2020-11-13T17:53:57.970Z] 17:53:57 INFO - ==> process 2158 launched child process 2534
[task 2020-11-13T17:53:57.970Z] 17:53:57 INFO - Found child pids: set([2208, 2534, 2347, 2226, 2174, 2298, 2270])
[task 2020-11-13T17:53:57.971Z] 17:53:57 INFO - Failed to get child procs
[task 2020-11-13T17:53:57.971Z] 17:53:57 INFO - Killing process: 2208
[task 2020-11-13T17:53:57.971Z] 17:53:57 INFO - TEST-INFO | started process screentopng
[task 2020-11-13T17:53:58.192Z] 17:53:58 INFO - TEST-INFO | screentopng: exit 0
[task 2020-11-13T17:53:58.192Z] 17:53:58 INFO - Can't trigger Breakpad, just killing process
[task 2020-11-13T17:54:28.207Z] 17:54:28 INFO - failed to kill pid 2208 after 30s
[task 2020-11-13T17:54:28.207Z] 17:54:28 INFO - Killing process: 2534
[task 2020-11-13T17:54:28.207Z] 17:54:28 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-11-13T17:54:28.207Z] 17:54:28 INFO - Can't trigger Breakpad, just killing process
[task 2020-11-13T17:54:58.230Z] 17:54:58 INFO - failed to kill pid 2534 after 30s
[task 2020-11-13T17:54:58.230Z] 17:54:58 INFO - Killing process: 2347
[task 2020-11-13T17:54:58.230Z] 17:54:58 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-11-13T17:54:58.230Z] 17:54:58 INFO - Can't trigger Breakpad, just killing process
[task 2020-11-13T17:55:28.234Z] 17:55:28 INFO - failed to kill pid 2366 after 30s
[task 2020-11-13T17:55:28.234Z] 17:55:28 INFO - failed to kill pid 2347 after 30s
[task 2020-11-13T17:55:28.235Z] 17:55:28 INFO - Killing process: 2226
[task 2020-11-13T17:55:28.235Z] 17:55:28 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-11-13T17:55:28.235Z] 17:55:28 INFO - Can't trigger Breakpad, just killing process
[task 2020-11-13T17:55:58.242Z] 17:55:58 INFO - psutil found pid 2226 dead
[task 2020-11-13T17:55:58.242Z] 17:55:58 INFO - failed to kill pid 2252 after 30s
[task 2020-11-13T17:55:58.244Z] 17:55:58 INFO - Killing process: 2174

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1
• autoland: 1

Platform breakdown:

• linux1804-64-tsan: 1
• linux1804-64-qr: 1

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

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64-qr: 1

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

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64-tsan: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2020-11-30&endday=2020-12-06&tree=all

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• linux1804-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2020-12-14&endday=2020-12-20&tree=all

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2020-12-21&endday=2020-12-27&tree=all

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64-qr: 1

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

Comment 10

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

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

Comment 11

[Atila Butkovits]

Recent occurrence: https://treeherder.mozilla.org/logviewer?job_id=330127020&repo=autoland&lineNumber=17447

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-tsan: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-02-15&endday=2021-02-21&tree=all

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-tsan: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-02-22&endday=2021-02-28&tree=all

Comment 14

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

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

Comment 15

[Atila Butkovits]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=336066852&repo=autoland&lineNumber=17371

Comment 16

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-tsan: 2
  • opt: 2

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

Comment 17

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-tsan: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-04-12&endday=2021-04-18&tree=all

Comment 18

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-tsan: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-04-26&endday=2021-05-02&tree=all

Comment 19

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

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

Comment 20

[Iulian Moraru]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=341163509&repo=autoland&lineNumber=22462

Comment 21

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-tsan: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-05-24&endday=2021-05-30&tree=all

Comment 22

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

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

Comment 23

[Alexandru Michis [:malexandru]]

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=343574760&repo=autoland&lineNumber=26025

Comment 24

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-06-21&endday=2021-06-27&tree=all

Comment 25

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-07-05&endday=2021-07-11&tree=all

Comment 26

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-07-12&endday=2021-07-18&tree=all

Comment 27

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

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

Comment 28

[Sandor Molnar[:smolnar]]

https://treeherder.mozilla.org/logviewer?job_id=353031729&repo=autoland&lineNumber=26685

Comment 29

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2021-09-27&endday=2021-10-03&tree=all

Comment 30

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

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

Comment 31

[Treeherder Bug Filer]

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

Comment 32

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1666661&startday=2022-01-24&endday=2022-01-30&tree=all

Comment 33

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

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