Closed Bug 1041823 Opened 10 years ago Closed 9 years ago

Intermittent test_nfc_error_messages.js | TimeoutException: TimeoutException: Connection timed out

Categories

(Firefox OS Graveyard :: NFC, defect)

x86_64
Gonk (Firefox OS)
defect
Not set
normal

Tracking

(Not tracked)

RESOLVED WORKSFORME

People

(Reporter: KWierso, Unassigned)

References

Details

(Keywords: intermittent-failure)

https://tbpl.mozilla.org/php/getParsedLog.php?id=44284004&tree=Mozilla-Inbound b2g_emulator_vm mozilla-inbound opt test marionette-webapi on 2014-07-21 09:01:32 PDT for push 8e5e7c9c0d66 slave: tst-linux64-spot-921 09:53:04 INFO - 07-21 12:47:01.600 E/GeckoConsole( 44): [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "data:text/html,<html>test%20page</html>" line: 0}] 09:53:04 INFO - 07-21 12:47:01.880 I/Gecko ( 44): 1405961221883 Marionette INFO sendToClient: {"from":"0","ok":true}, {a3fe0a67-4393-4ad7-bd1c-cd9a4068c75b}, {a3fe0a67-4393-4ad7-bd1c-cd9a4068c75b} 09:53:04 INFO - 07-21 12:47:01.920 I/Gecko ( 44): 1405961221924 Marionette INFO sendToClient: {"from":"0","ok":true}, {a043cd2b-6894-4561-b196-d32f94fe277d}, {a043cd2b-6894-4561-b196-d32f94fe277d} 09:53:04 INFO - 07-21 12:47:02.139 I/Gecko ( 44): MARIONETTE LOG: INFO: Skipping test on system without NFC 09:53:04 INFO - 07-21 12:47:02.139 I/Gecko ( 44): MARIONETTE TEST RESULT:TEST-PASS | test_nfc_read_tag.js | Skipping test on system without NFC - true was true, expected true 09:53:04 INFO - 07-21 12:47:02.159 I/Gecko ( 44): 1405961222162 Marionette INFO sendToClient: {"from":"0","value":{"passed":1,"failed":0,"failures":[]}}, {07b82694-b973-44d4-b54c-3f95cc0c6a3d}, {07b82694-b973-44d4-b54c-3f95cc0c6a3d} 09:53:04 INFO - 07-21 12:47:02.179 I/Gecko ( 44): 1405961222186 Marionette DEBUG Got request: execute, data: {"to":"0","sessionId":{"rotatable":true,"browserVersion":"33.0a1","takesScreenshot":true,"appBuildId":"20140721080821","XULappId":"{3c2e2abc-06d4-11e1-ac3b-374f68613e61}","secureSsl":false,"platform":"ANDROID","browserName":"B2G","version":"33.0a1","device":"qemu","b2g":true,"nativeEvents":false,"platformVersion":"33.0a1","takesElementScreenshot":true,"platformName":"ANDROID","handlesAlerts":false},"name":"executeScript","parameters":{"scriptTimeout":null,"specialPowers":false,"script":"log('TEST-END: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_read_tag.js');","newSandbox":true,"args":[],"filename":"marionette_test.py","line":537}}, id: {def73de4-5366-4547-80fa-83303867eb64} 09:53:04 INFO - 07-21 12:47:02.209 I/Gecko ( 44): MARIONETTE LOG: INFO: TEST-END: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_read_tag.js 09:53:04 INFO - 07-21 12:47:02.229 I/Gecko ( 44): 1405961222231 Marionette INFO sendToClient: {"from":"0","value":null}, {def73de4-5366-4547-80fa-83303867eb64}, {def73de4-5366-4547-80fa-83303867eb64} 09:53:04 INFO - 07-21 12:47:02.249 I/Gecko ( 44): 1405961222253 Marionette DEBUG Got request: setTestName, data: {"to":"0","sessionId":{"rotatable":true,"browserVersion":"33.0a1","takesScreenshot":true,"appBuildId":"20140721080821","XULappId":"{3c2e2abc-06d4-11e1-ac3b-374f68613e61}","secureSsl":false,"platform":"ANDROID","browserName":"B2G","version":"33.0a1","device":"qemu","b2g":true,"nativeEvents":false,"platformVersion":"33.0a1","takesElementScreenshot":true,"platformName":"ANDROID","handlesAlerts":false},"name":"setTestName","parameters":{"value":null}}, id: {0c55e8ed-0562-430f-8c12-7b5a07fe2f11} 09:53:04 INFO - 07-21 12:47:02.249 I/Gecko ( 44): 1405961222259 Marionette INFO sendToClient: {"from":"0","ok":true}, {0c55e8ed-0562-430f-8c12-7b5a07fe2f11}, {0c55e8ed-0562-430f-8c12-7b5a07fe2f11} 09:53:04 INFO - 07-21 12:47:02.289 I/Gecko ( 44): 1405961222297 Marionette INFO sendToClient: {"from":"0","value":[["INFO","TEST-START: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_read_tag.js","Mon Jul 21 2014 12:47:01 GMT-0400 (EDT)"],["INFO","Skipping test on system without NFC","Mon Jul 21 2014 12:47:02 GMT-0400 (EDT)"],["INFO","TEST-END: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_read_tag.js","Mon Jul 21 2014 12:47:02 GMT-0400 (EDT)"]]}, {ae0dd510-5504-4739-9287-74388bca756d}, {ae0dd510-5504-4739-9287-74388bca756d} 09:53:04 INFO - 07-21 12:47:02.359 I/Gecko ( 44): 1405961222363 Marionette INFO sendToClient: {"from":"0","ok":true}, {1e90c03a-6d9d-4f1e-a0bd-7ff64996c82f}, {1e90c03a-6d9d-4f1e-a0bd-7ff64996c82f} 09:53:04 INFO - 07-21 12:47:03.870 I/Gecko ( 44): 1405961223869 Marionette DEBUG accepted connection on 127.0.0.1:36999 09:53:04 INFO - 07-21 12:47:04.030 I/Gecko ( 44): 1405961224036 Marionette INFO could not load listener into content for page: chrome://b2g/content/shell.html 09:53:04 INFO - 07-21 12:47:04.089 I/Gecko ( 44): 1405961224092 Marionette INFO sendToClient: {"from":"0","value":{"browserName":"B2G","browserVersion":"33.0a1","platformName":"ANDROID","platformVersion":"33.0a1","handlesAlerts":false,"nativeEvents":false,"rotatable":true,"secureSsl":false,"takesElementScreenshot":true,"takesScreenshot":true,"platform":"ANDROID","XULappId":"{3c2e2abc-06d4-11e1-ac3b-374f68613e61}","appBuildId":"20140721080821","device":"qemu","version":"33.0a1","b2g":true}}, {b7cc9326-081e-4a63-9670-379d784a6485}, {b7cc9326-081e-4a63-9670-379d784a6485} 09:53:04 INFO - 07-21 12:47:04.149 I/Gecko ( 44): 1405961224158 Marionette INFO sendToClient: {"from":"0","ok":true}, {953ebbd9-84a3-4506-a3ba-4d9ca8807d44}, {953ebbd9-84a3-4506-a3ba-4d9ca8807d44} 09:53:04 INFO - 07-21 12:47:04.229 I/Gecko ( 44): 1405961224236 Marionette DEBUG Got request: setTestName, data: {"to":"0","sessionId":{"rotatable":true,"browserVersion":"33.0a1","takesScreenshot":true,"appBuildId":"20140721080821","XULappId":"{3c2e2abc-06d4-11e1-ac3b-374f68613e61}","secureSsl":false,"platform":"ANDROID","browserName":"B2G","version":"33.0a1","device":"qemu","b2g":true,"nativeEvents":false,"platformVersion":"33.0a1","takesElementScreenshot":true,"platformName":"ANDROID","handlesAlerts":false},"name":"setTestName","parameters":{"value":"test_nfc_checkP2PRegistration.js"}}, id: {679dead2-2571-4922-be9b-92c5f4059721} 09:53:04 INFO - 07-21 12:47:04.249 I/Gecko ( 44): 1405961224254 Marionette INFO sendToClient: {"from":"0","ok":true}, {679dead2-2571-4922-be9b-92c5f4059721}, {679dead2-2571-4922-be9b-92c5f4059721} 09:53:04 INFO - 07-21 12:47:04.279 I/Gecko ( 44): 1405961224282 Marionette DEBUG Got request: execute, data: {"to":"0","sessionId":{"rotatable":true,"browserVersion":"33.0a1","takesScreenshot":true,"appBuildId":"20140721080821","XULappId":"{3c2e2abc-06d4-11e1-ac3b-374f68613e61}","secureSsl":false,"platform":"ANDROID","browserName":"B2G","version":"33.0a1","device":"qemu","b2g":true,"nativeEvents":false,"platformVersion":"33.0a1","takesElementScreenshot":true,"platformName":"ANDROID","handlesAlerts":false},"name":"executeScript","parameters":{"scriptTimeout":null,"specialPowers":false,"script":"log('TEST-START: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_checkP2PRegistration.js');","newSandbox":true,"args":[],"filename":"marionette_test.py","line":409}}, id: {ce27dd54-213f-482f-a246-956caed9f889} 09:53:04 INFO - 07-21 12:47:04.319 I/Gecko ( 44): MARIONETTE LOG: INFO: TEST-START: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_checkP2PRegistration.js 09:53:04 INFO - 07-21 12:47:04.369 I/Gecko ( 44): 1405961224376 Marionette INFO sendToClient: {"from":"0","value":null}, {ce27dd54-213f-482f-a246-956caed9f889}, {ce27dd54-213f-482f-a246-956caed9f889} 09:53:04 INFO - 07-21 12:47:04.620 E/GeckoConsole( 44): [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "data:text/html,<html>test%20page</html>" line: 0}] 09:53:04 INFO - 07-21 12:47:04.910 I/Gecko ( 44): 1405961224912 Marionette INFO sendToClient: {"from":"0","ok":true}, {f0fd50f2-eb43-43ba-9f35-d33bf90e6f1d}, {f0fd50f2-eb43-43ba-9f35-d33bf90e6f1d} 09:53:04 INFO - 07-21 12:47:04.940 I/Gecko ( 44): 1405961224946 Marionette INFO sendToClient: {"from":"0","ok":true}, {564a499d-6e7b-4774-b328-843e516882ab}, {564a499d-6e7b-4774-b328-843e516882ab} 09:53:04 INFO - 07-21 12:47:05.339 I/Gecko ( 44): MARIONETTE LOG: INFO: Skipping test on system without NFC 09:53:04 INFO - 07-21 12:47:05.359 I/Gecko ( 44): MARIONETTE TEST RESULT:TEST-PASS | test_nfc_checkP2PRegistration.js | Skipping test on system without NFC - true was true, expected true 09:53:04 INFO - 07-21 12:47:05.429 I/Gecko ( 44): 1405961225432 Marionette INFO sendToClient: {"from":"0","value":{"passed":1,"failed":0,"failures":[]}}, {b11b29cc-3a9b-43ee-a77a-02a7813f5f9b}, {b11b29cc-3a9b-43ee-a77a-02a7813f5f9b} 09:53:04 INFO - 07-21 12:47:05.460 I/Gecko ( 44): 1405961225464 Marionette DEBUG Got request: execute, data: {"to":"0","sessionId":{"rotatable":true,"browserVersion":"33.0a1","takesScreenshot":true,"appBuildId":"20140721080821","XULappId":"{3c2e2abc-06d4-11e1-ac3b-374f68613e61}","secureSsl":false,"platform":"ANDROID","browserName":"B2G","version":"33.0a1","device":"qemu","b2g":true,"nativeEvents":false,"platformVersion":"33.0a1","takesElementScreenshot":true,"platformName":"ANDROID","handlesAlerts":false},"name":"executeScript","parameters":{"scriptTimeout":null,"specialPowers":false,"script":"log('TEST-END: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_checkP2PRegistration.js');","newSandbox":true,"args":[],"filename":"marionette_test.py","line":537}}, id: {92c803ae-f389-45f3-9c09-64776fafe2a6} 09:53:04 INFO - 07-21 12:47:05.490 I/Gecko ( 44): MARIONETTE LOG: INFO: TEST-END: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_checkP2PRegistration.js 09:53:04 INFO - 07-21 12:47:05.510 I/Gecko ( 44): 1405961225510 Marionette INFO sendToClient: {"from":"0","value":null}, {92c803ae-f389-45f3-9c09-64776fafe2a6}, {92c803ae-f389-45f3-9c09-64776fafe2a6} 09:53:04 INFO - 07-21 12:47:05.540 I/Gecko ( 44): 1405961225543 Marionette DEBUG Got request: setTestName, data: {"to":"0","sessionId":{"rotatable":true,"browserVersion":"33.0a1","takesScreenshot":true,"appBuildId":"20140721080821","XULappId":"{3c2e2abc-06d4-11e1-ac3b-374f68613e61}","secureSsl":false,"platform":"ANDROID","browserName":"B2G","version":"33.0a1","device":"qemu","b2g":true,"nativeEvents":false,"platformVersion":"33.0a1","takesElementScreenshot":true,"platformName":"ANDROID","handlesAlerts":false},"name":"setTestName","parameters":{"value":null}}, id: {844e61c4-97c5-4af0-9c7d-0b9d2ae57db5} 09:53:04 INFO - 07-21 12:47:05.540 I/Gecko ( 44): 1405961225549 Marionette INFO sendToClient: {"from":"0","ok":true}, {844e61c4-97c5-4af0-9c7d-0b9d2ae57db5}, {844e61c4-97c5-4af0-9c7d-0b9d2ae57db5} 09:53:04 INFO - 07-21 12:47:05.580 I/Gecko ( 44): 1405961225586 Marionette INFO sendToClient: {"from":"0","value":[["INFO","TEST-START: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_checkP2PRegistration.js","Mon Jul 21 2014 12:47:04 GMT-0400 (EDT)"],["INFO","Skipping test on system without NFC","Mon Jul 21 2014 12:47:05 GMT-0400 (EDT)"],["INFO","TEST-END: /builds/slave/test/build/tests/marionette/tests/dom/nfc/tests/marionette/test_nfc_checkP2PRegistration.js","Mon Jul 21 2014 12:47:05 GMT-0400 (EDT)"]]}, {2884f2ce-f6ef-4662-b2d7-cee056922ec5}, {2884f2ce-f6ef-4662-b2d7-cee056922ec5} 09:53:04 INFO - 07-21 12:47:05.649 I/Gecko ( 44): 1405961225650 Marionette INFO sendToClient: {"from":"0","ok":true}, {de675298-0edc-4ab5-923a-5dacbf144717}, {de675298-0edc-4ab5-923a-5dacbf144717} 09:53:04 INFO - 07-21 12:47:07.060 I/Gecko ( 44): 1405961227062 Marionette DEBUG accepted connection on 127.0.0.1:37000 09:53:04 INFO - 07-21 12:47:07.199 I/Gecko ( 44): 1405961227204 Marionette INFO could not load listener into content for page: chrome://b2g/content/shell.html 09:53:04 INFO - 07-21 12:47:07.240 I/Gecko ( 44): 1405961227245 Marionette INFO sendToClient: {"from":"0","value":{"browserName":"B2G","browserVersion":"33.0a1","platformName":"ANDROID","platformVersion":"33.0a1","handlesAlerts":false,"nativeEvents":false,"rotatable":true,"secureSsl":false,"takesElementScreenshot":true,"takesScreenshot":true,"platform":"ANDROID","XULappId":"{3c2e2abc-06d4-11e1-ac3b-374f68613e61}","appBuildId":"20140721080821","device":"qemu","version":"33.0a1","b2g":true}}, {5d61ccd6-6707-4609-8318-b8f6a4b74b97}, {5d61ccd6-6707-4609-8318-b8f6a4b74b97} 09:53:04 INFO - 07-21 12:47:07.339 I/Gecko ( 44): 1405961227330 Marionette INFO sendToClient: {"from":"0","ok":true}, {4c55a224-37d6-4e75-aecd-ca1ba53ce594}, {4c55a224-37d6-4e75-aecd-ca1ba53ce594} 09:53:04 INFO - B2G is still running but Marionette can't respond due to either a Gecko, Gaia or Marionette error. Above, the 5 most recent errors are listed. Check logcat for all errors if these errors are not the cause of the failure. 09:53:04 ERROR - TEST-UNEXPECTED-ERROR | test_nfc_error_messages.js | TimeoutException: TimeoutException: Connection timed out 09:53:04 INFO - Traceback (most recent call last): 09:53:04 INFO - File "/builds/slave/test/build/tests/marionette/marionette/marionette_test.py", line 171, in run 09:53:04 INFO - testMethod() 09:53:04 INFO - File "/builds/slave/test/build/tests/marionette/marionette/marionette_test.py", line 408, in runTest 09:53:04 INFO - self.marionette.test_name = os.path.basename(self.jsFile) 09:53:04 INFO - File "/builds/slave/test/build/tests/marionette/marionette/marionette.py", line 753, in test_name 09:53:04 INFO - if self._send_message('setTestName', 'ok', value=test_name): 09:53:04 INFO - File "/builds/slave/test/build/tests/marionette/marionette/decorators.py", line 35, in _ 09:53:04 INFO - return func(*args, **kwargs) 09:53:04 INFO - File "/builds/slave/test/build/tests/marionette/marionette/marionette.py", line 611, in _send_message 09:53:04 INFO - "Connection timed out", status=errors.ErrorCodes.TIMEOUT) 09:53:04 INFO - TEST-INFO expected PASS | took 362152ms 09:53:04 INFO - DeviceManager _runCmd - command: /builds/slave/test/build/emulator/b2g-distro/out/host/linux-x86/bin/adb -s emulator-5554 pull /data/local/tests/profile/minidumps /tmp/tmpAU3ZQo 09:53:04 INFO - DeviceManager remote object '/data/local/tests/profile/minidumps' does not exist 09:53:04 INFO - DeviceManager _runCmd - command: /builds/slave/test/build/emulator/b2g-distro/out/host/linux-x86/bin/adb -s emulator-5554 shell ls -a /data/local/tests/profile/minidumps/ 09:53:04 INFO - DeviceManager /data/local/tests/profile/minidumps/: No such file or directory 09:53:04 INFO - DeviceManager _runCmd - command: /builds/slave/test/build/emulator/b2g-distro/out/host/linux-x86/bin/adb -s emulator-5554 shell ls -a /data/local/tests/profile/minidumps 09:53:04 INFO - DeviceManager /data/local/tests/profile/minidumps: No such file or directory 09:53:04 INFO - DeviceManager _runCmd - command: /builds/slave/test/build/emulator/b2g-distro/out/host/linux-x86/bin/adb -s emulator-5554 pull /data/local/tests/profile/minidumps /tmp/tmpjBwNL6 09:53:04 INFO - DeviceManager remote object '/data/local/tests/profile/minidumps' does not exist 09:53:04 INFO - DeviceManager _runCmd - command: /builds/slave/test/build/emulator/b2g-distro/out/host/linux-x86/bin/adb -s emulator-5554 shell ls -a /data/local/tests/profile/minidumps/ 09:53:04 INFO - DeviceManager /data/local/tests/profile/minidumps/: No such file or directory 09:53:04 INFO - DeviceManager _runCmd - command: /builds/slave/test/build/emulator/b2g-distro/out/host/linux-x86/bin/adb -s emulator-5554 shell ls -a /data/local/tests/profile/minidumps 09:53:05 INFO - DeviceManager /data/local/tests/profile/minidumps: No such file or directory 09:53:05 INFO - DeviceManager shell - command: /builds/slave/test/build/emulator/b2g-distro/out/host/linux-x86/bin/adb -s emulator-5554 shell b2g-ps; echo $? 09:53:05 INFO - DeviceManager APPLICATION SEC USER PID PPID VSIZE RSS WCHAN PC NAME 09:53:05 INFO - DeviceManager b2g 0 root 44 1 176500 72408 ffffffff 400693c0 S /system/b2g/b2g 09:53:05 INFO - DeviceManager (Nuwa) 0 root 145 44 54572 20932 ffffffff 400693c0 S /system/b2g/plugin-container 09:53:05 INFO - DeviceManager (Preallocated a 2 app_6066 6066 145 60456 20500 ffffffff 400693c0 S /system/b2g/plugin-container 09:53:05 INFO - DeviceManager 0 09:53:05 INFO - TEST-START | test_sensor_orientation.js
Inactive; closing (see bug 1180138).
Status: NEW → RESOLVED
Closed: 9 years ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.