844490 - Intermittent test_incoming_connecting_hangup.js | ScriptTimeoutException: timed out

Status: RESOLVED FIXED

(Core :: DOM: Device Interfaces, defect)

Description

[Phil Ringnalda (:philor)]

https://tbpl.mozilla.org/php/getParsedLog.php?id=20015860&tree=Mozilla-B2g18
b2g_ics_armv7a_gecko_emulator mozilla-b2g18 opt test marionette-webapi on 2013-02-22 23:47:48 PST for push f96b3fe5d05b
slave: talos-r3-fed-092

23:55:53     INFO -  ERROR: /home/cltbld/talos-slave/test/build/tests/marionette/tests/dom/telephony/test/marionette/test_incoming_connecting_hangup.js, runTest (marionette_test.MarionetteJSTestCase)
23:55:53     INFO -  ----------------------------------------------------------------------
23:55:53    ERROR -  Traceback (most recent call last):
23:55:53     INFO -    File "/home/cltbld/talos-slave/test/build/tests/marionette/marionette/marionette_test.py", line 213, in runTest
23:55:53     INFO -      results = self.marionette.execute_js_script(js, args, special_powers=True)
23:55:53     INFO -    File "/home/cltbld/talos-slave/test/build/tests/marionette/marionette/marionette.py", line 467, in execute_js_script
23:55:53     INFO -      specialPowers=special_powers)
23:55:53     INFO -    File "/home/cltbld/talos-slave/test/build/tests/marionette/marionette/marionette.py", line 239, in _send_message
23:55:53     INFO -      self._handle_error(response)
23:55:53     INFO -    File "/home/cltbld/talos-slave/test/build/tests/marionette/marionette/marionette.py", line 288, in _handle_error
23:55:53    ERROR -      raise ScriptTimeoutException(message=message, status=status, stacktrace=stacktrace)
23:55:53    ERROR -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_hangup.js | ScriptTimeoutException: timed out
23:55:53     INFO -  ----------------------------------------------------------------------
23:55:53     INFO -  Ran 1 test in 10.747s
23:55:53    ERROR -  FAILED (errors=1)

Comment 1

[Legacy TBPL/Treeherder Robot]

philor
https://tbpl.mozilla.org/php/getParsedLog.php?id=20732504&tree=Mozilla-Inbound
b2g_ics_armv7a_gecko_emulator_vm mozilla-inbound opt test marionette-webapi on 2013-03-16 18:40:09
slave: tst-linux64-ec2-369

18:48:40    ERROR -      raise ScriptTimeoutException(message=message, status=status, stacktrace=stacktrace)
18:48:40    ERROR -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_hangup.js | ScriptTimeoutException: timed out
18:48:41     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_remote_hangup.js | MarionetteException: Emulator callback still pending when finish() called
18:48:42     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_hangup_held.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
18:48:43     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_remote_cancel.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
18:48:45     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_remote_hangup_held.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
18:48:46     INFO -  TEST-UNEXPECTED-FAIL | test_outgoing_already_held.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
18:48:46     INFO -  TEST-UNEXPECTED-FAIL | test_outgoing_answer_local_hangup.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
18:53:09    ERROR - Return code: 10
18:53:11     INFO -  I/Gecko   (  268): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_connecting_remote_hangup.js | undefined - got inbound from 5555551111 : incoming, expected OK
18:53:11     INFO -  I/Gecko   (  268): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_hangup_held.js | undefined - got inbound from 5555551111 : incoming, expected OK
18:53:11     INFO -  I/Gecko   (  268): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_remote_cancel.js | undefined - got inbound from 5555551111 : incoming, expected OK
18:53:11     INFO -  I/Gecko   (  268): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_remote_hangup_held.js | undefined - got inbound from 5555551111 : incoming, expected OK
18:53:11     INFO -  I/Gecko   (  268): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_outgoing_already_held.js | undefined - got inbound from 5555551111 : incoming, expected OK
18:53:11     INFO -  I/Gecko   (  268): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_outgoing_answer_local_hangup.js | undefined - got inbound from 5555551111 : incoming, expected OK

Comment 2

[Jonathan Griffin (:jgriffin)]

This looks like another case where we may just need to increase the test's timeout.

Comment 3

[Robert Wood [:rwood]]

Attachment: Increase test timeout

Increase timeout as the emulator is slow and sometimes can't complete processing the command before the test timeout expires. Thanks Jonathan!

Comment 4

[Robert Wood [:rwood]]

Comment on attachment 735165 [details] [diff] [review]
Increase test timeout

Ignore the attachment please, going to make one patch to increase timeout for all sms/telephony tests.

Comment 5

[Robert Wood [:rwood]]

Attachment: Increase timeouts for telephony tests

Increase timeout for all WebAPI telephony tests, to fix/prevent intermittent timeout faiules. The timeouts for the SMS tests are increased in a different patch in bug 841285.

Comment 6

[Legacy TBPL/Treeherder Robot]

edmorley
https://tbpl.mozilla.org/php/getParsedLog.php?id=21641773&tree=Mozilla-Central
b2g_ics_armv7a_gecko_emulator_vm mozilla-central opt test marionette-webapi on 2013-04-09 23:08:29
slave: tst-linux64-ec2-363

06:21:07    ERROR -      raise ScriptTimeoutException(message=message, status=status, stacktrace=stacktrace)
06:21:07    ERROR -  TEST-UNEXPECTED-FAIL | test_incoming_answer_remote_hangup.js | ScriptTimeoutException: timed out
06:21:09     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_hangup.js | MarionetteException: Emulator callback still pending when finish() called
06:21:10     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_remote_hangup.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
06:21:11     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_hangup_held.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
06:21:11     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_remote_cancel.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
06:21:13     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_remote_hangup_held.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
06:21:14     INFO -  TEST-UNEXPECTED-FAIL | test_outgoing_already_held.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
06:21:15     INFO -  TEST-UNEXPECTED-FAIL | test_outgoing_answer_local_hangup.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
06:21:16     INFO -  TEST-UNEXPECTED-FAIL | test_outgoing_emergency_in_airplane_mode.js | got inbound from 5555551111 : incoming, expected OK | got false, expected true
06:25:11    ERROR - Return code: 10
06:25:13     INFO -  I/Gecko   (  238): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_connecting_hangup.js | undefined - got inbound from 5555551111 : incoming, expected OK
06:25:13     INFO -  I/Gecko   (  238): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_connecting_remote_hangup.js | undefined - got inbound from 5555551111 : incoming, expected OK
06:25:13     INFO -  I/Gecko   (  238): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_hangup_held.js | undefined - got inbound from 5555551111 : incoming, expected OK
06:25:13     INFO -  I/Gecko   (  238): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_remote_cancel.js | undefined - got inbound from 5555551111 : incoming, expected OK
06:25:13     INFO -  I/Gecko   (  238): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_incoming_remote_hangup_held.js | undefined - got inbound from 5555551111 : incoming, expected OK
06:25:13     INFO -  I/Gecko   (  238): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_outgoing_already_held.js | undefined - got inbound from 5555551111 : incoming, expected OK
06:25:13     INFO -  I/Gecko   (  238): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_outgoing_answer_local_hangup.js | undefined - got inbound from 5555551111 : incoming, expected OK
06:25:13     INFO -  I/Gecko   (  238): MARIONETTE TEST RESULT:TEST-UNEXPECTED-FAIL | test_outgoing_emergency_in_airplane_mode.js | undefined - got inbound from 5555551111 : incoming, expected OK

Comment 7

[Robert Wood [:rwood]]

Pushed to try:

https://tbpl.mozilla.org/?tree=Try&rev=b4464c8b6aac

Comment 8

[Robert Wood [:rwood]]

https://hg.mozilla.org/integration/mozilla-inbound/rev/eb32f40fed8e

Comment 9

[Ryan VanderMeulen [:RyanVM]]

https://hg.mozilla.org/mozilla-central/rev/eb32f40fed8e

Comment 10

[Robert Wood [:rwood]]

https://hg.mozilla.org/releases/mozilla-b2g18/rev/290fb6229459

Comment 11

[Legacy TBPL/Treeherder Robot]

philor
https://tbpl.mozilla.org/php/getParsedLog.php?id=24525536&tree=Mozilla-Inbound
b2g_ics_armv7a_gecko_emulator_vm mozilla-inbound opt test marionette-webapi on 2013-06-24 11:26:34
revision: 7164e457fa94
slave: tst-linux64-ec2-066

11:39:33    ERROR -      raise ScriptTimeoutException(message=message, status=status, stacktrace=stacktrace)
11:39:33    ERROR -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_hangup.js | ScriptTimeoutException: timed out
11:39:37     INFO -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_remote_hangup.js | MarionetteException: Emulator callback still pending when finish() called
11:47:54    ERROR - Return code: 10

Comment 12

[Legacy TBPL/Treeherder Robot]

RyanVM
https://tbpl.mozilla.org/php/getParsedLog.php?id=25617184&tree=Birch
b2g_emulator birch opt test marionette-webapi on 2013-07-23 10:15:11
revision: a5393966c608
slave: talos-r3-fed-048

10:16:12    ERROR - Return code: 1
10:16:13    ERROR - Return code: 1
10:24:06    ERROR -      raise TimeoutException(message='socket.timeout', status=ErrorCodes.TIMEOUT, stacktrace=None)
10:24:06    ERROR -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_hangup.js | TimeoutException: socket.timeout
10:29:45    ERROR - Return code: 2560
10:29:51    ERROR - Marionette exited with return code 2560: harness failures
10:29:51    ERROR - # TBPL FAILURE #

Comment 13

[Legacy TBPL/Treeherder Robot]

Tomcat
https://tbpl.mozilla.org/php/getParsedLog.php?id=25773610&tree=Birch
b2g_emulator birch opt test marionette-webapi on 2013-07-26 05:54:01
revision: e0e3dbe66a51
slave: talos-r3-fed-095

06:03:13    ERROR -      raise TimeoutException(message='socket.timeout', status=ErrorCodes.TIMEOUT, stacktrace=None)
06:03:13    ERROR -  TEST-UNEXPECTED-FAIL | test_incoming_connecting_hangup.js | TimeoutException: socket.timeout
06:09:06    ERROR - Return code: 2560
06:09:16    ERROR - Marionette exited with return code 2560: harness failures
06:09:16    ERROR - # TBPL FAILURE #

Comment 14

[Legacy TBPL/Treeherder Robot]

RyanVM
https://tbpl.mozilla.org/php/getParsedLog.php?id=27583072&tree=B2g-Inbound
b2g_emulator b2g-inbound opt test marionette-webapi on 2013-09-09 09:10:41
revision: ffb7f33ee1a9
slave: talos-r3-fed-056

ImportError: cannot import name OrderedDict
raise ScriptTimeoutException(message=message, status=status, stacktrace=stacktrace)
TEST-UNEXPECTED-FAIL | test_incoming_connecting_hangup.js | ScriptTimeoutException: timed out
Return code: 2560
Marionette exited with return code 2560: harness failures
# TBPL FAILURE #