Closed Bug 1429712 Opened 8 years ago Closed 8 years ago

Intermittent 26 ERROR TEST-UNEXPECTED-FAIL | automation.py | application crashed [@ js::XDRBuffer<0>::write(unsigned __int64)]

Categories

(Core :: JavaScript Engine, defect, P5)

Product:
Core
Component:
JavaScript Engine
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: crash, intermittent-failure)

Filed by: apavel [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=155434200&repo=autoland https://queue.taskcluster.net/v1/task/MnQqe632RrmcfT-zAJHDxw/runs/0/artifacts/public/logs/live_backing.log 21:10:25 INFO - 15 INFO TEST-START | dom/canvas/test/crossorigin/test_webgl_crossorigin_textures.html 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] Shutdown: decoder=000001EEDA898400 state machine=000001EEDA49B000 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] Enter: state machine=000001EED7386310 reader=000001EEDA485820 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] Shutdown: reader=000001EEDA4FF000 shutdown demuxer=000001EEDA3E4960 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] Shutdown: pool=000001EEDA4842B0 count=1 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] operator (): pool=000001EEDA4842B0 shutdown=true count=0 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] TearDownDecoders: reader=000001EEDA4FF000 shut down audio task queue 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] TearDownDecoders: reader=000001EEDA4FF000 shut down video task queue 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] FinishShutdown: state machine=000001EEDA49B000 21:10:25 INFO - GECKO(10892) | [DEBUG SHUTDOWN] Unregister: decoder=000001EEDA898400, count=0 21:10:25 INFO - GECKO(10892) | JavaScript warning: http://mochi.test:8888/tests/dom/canvas/test/crossorigin/test_webgl_crossorigin_textures.html, line 48: Error: WebGL warning: texImage2D: Cross-origin elements require CORS. 21:10:25 INFO - GECKO(10892) | JavaScript warning: http://mochi.test:8888/tests/dom/canvas/test/crossorigin/test_webgl_crossorigin_textures.html, line 48: Error: WebGL warning: texImage2D: Cross-origin elements require CORS. 21:10:25 INFO - GECKO(10892) | JavaScript warning: http://mochi.test:8888/tests/dom/canvas/test/crossorigin/test_webgl_crossorigin_textures.html, line 48: Error: WebGL warning: texImage2D: Cross-origin elements require CORS. 21:10:25 INFO - GECKO(10892) | MEMORY STAT | vsize 1578MB | vsizeMaxContiguous 131263907MB | residentFast 101MB | heapAllocated 17MB 21:10:25 INFO - 16 INFO TEST-OK | dom/canvas/test/crossorigin/test_webgl_crossorigin_textures.html | took 369ms 21:10:25 INFO - 17 INFO TEST-START | Shutdown 21:10:25 INFO - 18 INFO Passed: 144 21:10:25 INFO - 19 INFO Failed: 0 21:10:25 INFO - 20 INFO Todo: 0 21:10:25 INFO - 21 INFO Mode: e10s 21:10:25 INFO - 22 INFO Slowest: 2496ms - /tests/dom/canvas/test/crossorigin/test_video_crossorigin.html 21:10:25 INFO - 23 INFO SimpleTest FINISHED 21:10:25 INFO - 24 INFO TEST-INFO | Ran 1 Loops 21:10:25 INFO - 25 INFO SimpleTest FINISHED 21:10:25 INFO - GECKO(10892) | Unable to read VR Path Registry from C:\Users\GenericWorker\AppData\Local\openvr\openvrpaths.vrpath 21:10:25 INFO - GECKO(10892) | [Parent 10892, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 21:10:25 INFO - GECKO(10892) | [Child 10220, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 21:10:26 INFO - GECKO(10892) | Unable to read VR Path Registry from C:\Users\GenericWorker\AppData\Local\openvr\openvrpaths.vrpath 21:10:26 INFO - GECKO(10892) | [Child 9388, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 21:10:26 INFO - GECKO(10892) | [Child 9388, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 21:10:26 INFO - GECKO(10892) | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:10:26 INFO - GECKO(10892) | 1515618626406 Marionette DEBUG Received observer notification "xpcom-shutdown" 21:10:26 INFO - GECKO(10892) | 1515618626406 Marionette DEBUG New connections will no longer be accepted 21:10:26 INFO - GECKO(10892) | Unable to read VR Path Registry from C:\Users\GenericWorker\AppData\Local\openvr\openvrpaths.vrpath 21:10:26 INFO - GECKO(10892) | [GPU 1292, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 21:10:26 INFO - TEST-INFO | Main app process: exit 0 21:10:26 INFO - runtests.py | Application ran for: 0:00:13.947000 21:10:26 INFO - zombiecheck | Reading PID log: c:\users\genericworker\appdata\local\temp\tmpplkxqopidlog 21:10:26 INFO - ==> process 10892 launched child process 1292 ("Z:\task_1515618409\build\application\firefox\firefox.exe" -contentproc --channel="10892.0.1228507535\903028424" -greomni "Z:\task_1515618409\build\application\firefox\omni.ja" -appomni "Z:\task_1515618409\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1515618409\build\application\firefox\browser" "C:\Users\GenericWorker\AppData\LocalLow\Mozilla\Temp-{cb528e14-2791-4034-8cfb-0b86d20d4aca}" 10892 "\\.\pipe\gecko-crash-server-pipe.10892" gpu) 21:10:26 INFO - ==> process 10892 launched child process 9388 ("Z:\task_1515618409\build\application\firefox\firefox.exe" -contentproc --channel="10892.3.1541185481\1268890315" -childID 1 -isForBrowser -intPrefs 6:50|7:-1|35:1000|43:0|44:5|45:0|52:0|58:128|59:10000|64:0|66:400|67:1|68:0|69:0|70:100|75:0|76:120|77:120|159:2|160:1|164:60|165:30|166:1000|175:0|177:0|191:32|192:256|193:5|206:10000|227:24|228:32768|230:0|231:0|240:2|244:1048576|246:100|247:5000|249:600|251:1|271:604800|274:5|278:0|287:60000|305:300|306:30| -boolPrefs 1:0|2:0|4:1|5:1|25:1|28:1|29:1|30:1|32:1|33:1|34:1|37:1|38:1|39:1|42:1|46:1|47:0|48:0|49:1|50:1|51:1|53:0|56:1|57:1|60:1|61:0|62:0|63:0|65:0|71:1|72:1|73:1|74:1|78:1|79:1|80:0|81:0|82:1|83:1|84:1|85:1|88:0|89:0|92:1|93:1|97:1|98:1|99:0|100:0|101:0|103:0|104:0|105:1|106:1|107:1|110:1|111:1|112:1|113:1|114:1|115:0|116:1|117:1|118:0|119:0|120:1|121:1|122:0|123:1|124:1|125:1|127:1|128:1|129:1|130:1|131:0|132:0|133:0|134:1|135:1|136:1|137:1|138:1|139:1|140:1|141:1|142:1|143:1|144:1|145:0|146:1|147:1|148:0|149:1|150:1|152:0|153:0|154:0|155:1|156:1|157:1|158:1|161:1|162:0|169:1|172:0|173:0|174:1|178:1|181:0|182:1|184:1|186:0|188:1|190:1|194:1|195:0|196:1|197:1|198:0|201:1|205:1|207:0|208:0|210:1|213:0|219:0|220:1|221:0|222:1|225:0|226:0|229:1|232:0|234:1|235:1|237:1|238:0|245:1|248:1|253:0|254:0|255:0|256:1|257:0|261:1|264:1|265:1|266:1|267:1|268:1|269:0|270:1|272:1|273:1|276:0|279:1|280:0|281:1|282:1|283:0|284:1|285:1|286:1|288:0|289:0|291:0|300:1|301:1|302:0|303:0|304:0| -stringPrefs "3:7;default|151:0;|212:4;0.01|223:332; ����!==> process 10892 launched child process 10220 ("Z:\task_1515618409\build\application\firefox\firefox.exe" -contentproc --channel="10892.13.1419811015\213555954" -childID 2 -isForBrowser -intPrefs 6:50|7:-1|35:1000|43:0|44:5|45:0|52:0|58:128|59:10000|64:0|66:400|67:1|68:0|69:0|70:100|75:0|76:120|77:120|159:2|160:1|164:60|165:30|166:1000|175:0|177:0|191:32|192:256|193:5|206:10000|227:24|228:32768|230:0|231:0|240:2|244:1048576|246:100|247:5000|249:600|251:1|271:604800|274:5|278:0|287:60000|305:300|306:30| -boolPrefs 1:0|2:0|4:1|5:1|25:1|28:1|29:1|30:1|32:1|33:1|34:1|37:1|38:1|39:1|42:1|46:1|47:0|48:0|49:1|50:1|51:1|53:0|56:1|57:1|60:1|61:0|62:0|63:0|65:0|71:1|72:1|73:1|74:1|78:1|79:1|80:0|81:0|82:1|83:1|84:1|85:1|88:0|89:0|92:1|93:1|97:1|98:1|99:0|100:0|101:0|103:0|104:0|105:1|106:1|107:1|110:1|111:1|112:1|113:1|114:1|115:0|116:1|117:1|118:0|119:0|120:1|121:1|122:0|123:1|124:1|125:1|127:1|128:1|129:1|130:1|131:0|132:0|133:0|134:1|135:1|136:1|137:1|138:1|139:1|140:1|141:1|142:1|143:1|144:1|145:0|146:1|147:1|148:0|149:1|150:1|152:0|153:0|154:0|155:1|156:1|157:1|158:1|161:1|162:0|169:1|172:0|173:0|174:1|178:1|181:0|182:1|184:1|186:0|188:1|190:1|194:1|195:0|196:1|197:1|198:0|201:1|205:1|207:0|208:0|210:1|213:0|219:0|220:1|221:0|222:1|225:0|226:0|229:1|232:0|234:1|235:1|237:1|238:0|245:1|248:1|253:0|254:0|255:0|256:1|257:0|261:1|264:1|265:1|266:1|267:1|268:1|269:0|270:1|272:1|273:1|276:0|279:1|280:0|281:1|282:1|283:0|284:1|285:1|286:1|288:0|289:0|291:0|300:1|301:1|302:0|303:0|304:0| -stringPrefs "3:7;default|151:0;|212:4;0.01|223:332; ����! 21:10:26 INFO - zombiecheck | Checking for orphan process with PID: 9388 21:10:26 INFO - zombiecheck | Checking for orphan process with PID: 1292 21:10:26 INFO - Stopping web server 21:10:26 INFO - Stopping web socket server 21:10:26 INFO - Stopping ssltunnel 21:10:26 INFO - leakcheck | refcount logging is off, so leaks can't be detected! 21:10:26 INFO - runtests.py | Running tests: end. 21:10:27 INFO - Buffered messages finished 21:10:27 INFO - Running manifest: dom\canvas\test\mochitest.ini 21:10:27 INFO - Z:\task_1515618409\build\tests\bin\pk12util.exe: PKCS12 IMPORT SUCCESSFUL 21:10:28 INFO - MochitestServer : launching [u'Z:\\task_1515618409\\build\\tests\\bin\\xpcshell.exe', '-g', 'Z:\\task_1515618409\\build\\application\\firefox', '-f', 'Z:\\task_1515618409\\build\\tests\\bin\\components\\httpd.js', '-e', "const _PROFILE_PATH = 'c:\\\\users\\\\genericworker\\\\appdata\\\\local\\\\temp\\\\tmp6dc7yg.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', 'Z:\\task_1515618409\\build\\tests\\mochitest\\server.js'] 21:10:28 INFO - runtests.py | Server pid: 9224 21:10:28 INFO - runtests.py | Websocket server pid: 9972 21:10:28 INFO - runtests.py | SSL tunnel pid: 5076 21:10:28 INFO - runtests.py | Running with e10s: True 21:10:28 INFO - runtests.py | Running tests: start. 21:10:28 INFO - Application command: Z:\task_1515618409\build\application\firefox\firefox.exe -marionette -foreground -profile c:\users\genericworker\appdata\local\temp\tmp6dc7yg.mozrunner 21:10:28 INFO - runtests.py | Application pid: 5964 21:10:28 INFO - TEST-INFO | started process GECKO(5964) 21:13:28 INFO - runtests.py | Waiting for browser... 21:13:28 INFO - TEST-INFO | Main app process: exit 1 21:13:28 INFO - Buffered messages finished 21:13:28 ERROR - 26 ERROR TEST-UNEXPECTED-FAIL | automation.py | application terminated with exit code 1 21:13:28 INFO - runtests.py | Application ran for: 0:03:00.425000 21:13:28 INFO - zombiecheck | Reading PID log: c:\users\genericworker\appdata\local\temp\tmpsggprqpidlog 21:13:28 INFO - mozcrash Downloading symbols from: https://queue.taskcluster.net/v1/task/ekhFBQBhT2WuxzAepUXScQ/artifacts/public/build/target.crashreporter-symbols.zip 21:13:36 INFO - mozcrash Copy/paste: Z:\task_1515618409\build\win32-minidump_stackwalk.exe c:\users\genericworker\appdata\local\temp\tmp6dc7yg.mozrunner\minidumps\70d93998-2f98-4e5e-9939-2a313d4bea26.dmp c:\users\genericworker\appdata\local\temp\tmpjwpdgn 21:13:44 INFO - mozcrash Saved minidump as Z:\task_1515618409\build\blobber_upload_dir\70d93998-2f98-4e5e-9939-2a313d4bea26.dmp 21:13:44 INFO - mozcrash Saved app info as Z:\task_1515618409\build\blobber_upload_dir\70d93998-2f98-4e5e-9939-2a313d4bea26.extra 21:13:44 WARNING - PROCESS-CRASH | automation.py | application crashed [@ js::XDRBuffer<0>::write(unsigned __int64)] 21:13:44 INFO - Crash dump filename: c:\users\genericworker\appdata\local\temp\tmp6dc7yg.mozrunner\minidumps\70d93998-2f98-4e5e-9939-2a313d4bea26.dmp 21:13:44 INFO - Operating system: Windows NT 21:13:44 INFO - 10.0.15063 21:13:44 INFO - CPU: amd64 21:13:44 INFO - family 6 model 45 stepping 7 21:13:44 INFO - 8 CPUs 21:13:44 INFO - GPU: UNKNOWN 21:13:44 INFO - Crash reason: EXCEPTION_ACCESS_VIOLATION_READ 21:13:44 INFO - Crash address: 0x10 21:13:44 INFO - Process uptime: 1 seconds 21:13:44 INFO - Thread 0 (crashed) 21:13:44 INFO - 0 xul.dll!js::XDRBuffer<0>::write(unsigned __int64) [Xdr.h:2fb3a7563abc : 55 + 0xa] 21:13:44 INFO - rax = 0x0000000000000006 rdx = 0x000001eb807e39d0 21:13:44 INFO - rcx = 0x000000f5c03f1a88 rbx = 0x000000f5c03f1a88 21:13:44 INFO - rsi = 0x000001eb807e39d0 rdi = 0x0000000000000000 21:13:44 INFO - rbp = 0x000000f5c03f1a00 rsp = 0x000000f5c03f18c8 21:13:44 INFO - r8 = 0x000000f5c03f1ce8 r9 = 0x000002a8064cefa9 21:13:44 INFO - r10 = 0x000002a80771a6c7 r11 = 0x000002a8064ced6a 21:13:44 INFO - r12 = 0x000002a8051346d0 r13 = 0x0000000000000000 21:13:44 INFO - r14 = 0x0000000000000010 r15 = 0x000002a805024040 21:13:44 INFO - rip = 0x00007ffe35a0a6c9 21:13:44 INFO - Found by: given as instruction pointer in context 21:13:44 INFO - 1 xul.dll!js::XDRState<0>::codeChars(char16_t *,unsigned __int64) [Xdr.cpp:2fb3a7563abc : 70 + 0x10] 21:13:44 INFO - rbx = 0x000000f5c03f1a88 rbp = 0x000000f5c03f1a00 21:13:44 INFO - rsp = 0x000000f5c03f18f8 r12 = 0x000002a8051346d0 21:13:44 INFO - r13 = 0x0000000000000000 r14 = 0x0000000000000010 21:13:44 INFO - r15 = 0x000002a805024040 rip = 0x00007ffe359e3177 21:13:44 INFO - Found by: call frame info 21:13:44 INFO - 2 0x2a805024030 21:13:45 INFO - rbx = 0x000000f5c03f1a88 rbp = 0x000000f5c03f1a00 21:13:45 INFO - rsp = 0x000000f5c03f1928 r12 = 0x000002a8051346d0 21:13:45 INFO - r13 = 0x0000000000000000 r14 = 0x0000000000000010 21:13:45 INFO - r15 = 0x000002a805024040 rip = 0x000002a805024030 21:13:45 INFO - Found by: call frame info 21:13:45 INFO - 3 mozglue.dll!Allocator<MozJemallocBase>::free(void *) [malloc_decls.h:2fb3a7563abc : 40 + 0x17] 21:13:45 INFO - rbp = 0x000000f5c03f1a00 rsp = 0x000000f5c03f19c0 21:13:45 INFO - rip = 0x00007ffe4b4f3993 21:13:45 INFO - Found by: stack scanning 21:13:45 INFO - 4 0x7ffe00200002 21:13:45 INFO - rbp = 0x000000f5c03f1a00 rsp = 0x000000f5c03f19f0 21:13:45 INFO - rip = 0x00007ffe00200002 21:13:45 INFO - Found by: call frame info 21:13:45 INFO - 5 xul.dll!js::XDRInterpretedFunction<0>(js::XDRState<0> *,JS::Handle<js::Scope *>,JS::Handle<js::ScriptSourceObject *>,JS::MutableHandle<JSFunction *>) [jsfun.cpp:2fb3a7563abc : 664 + 0xe] 21:13:45 INFO - rsp = 0x000000f5c03f1a40 rip = 0x00007ffe35907c93 21:13:45 INFO - Found by: stack scanning 21:13:46 INFO - File "Z:\task_1515618409\build\tests\mochitest\runtests.py", line 2769, in doTests 21:13:46 INFO - marionette_args=marionette_args, 21:13:46 INFO - File "Z:\task_1515618409\build\tests\mochitest\runtests.py", line 2228, in runApp 21:13:46 INFO - self.marionette.start_session() 21:13:46 INFO - File "Z:\task_1515618409\build\venv\lib\site-packages\marionette_driver\decorators.py", line 28, in _ 21:13:46 INFO - m._handle_socket_failure() 21:13:46 INFO - File "Z:\task_1515618409\build\venv\lib\site-packages\marionette_driver\decorators.py", line 23, in _ 21:13:46 INFO - return func(*args, **kwargs) 21:13:46 INFO - File "Z:\task_1515618409\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1215, in start_session 21:13:46 INFO - self.raise_for_port(timeout=timeout) 21:13:46 INFO - File "Z:\task_1515618409\build\venv\lib\site-packages\marionette_driver\marionette.py", line 713, in raise_for_port 21:13:46 INFO - self.host, self.port)) 21:13:46 INFO - timeout: Timed out waiting for connection on localhost:2828! 21:13:46 INFO - 27 ERROR Automation Error: Received unexpected exception while running application 21:13:46 INFO - Stopping web server 21:13:46 INFO - Stopping web socket server 21:13:46 INFO - Stopping ssltunnel 21:13:46 INFO - leakcheck | refcount logging is off, so leaks can't be detected! 21:13:46 INFO - runtests.py | Running tests: end. 21:13:46 INFO - Buffered messages finished
While there are some JS warnings during the test, it looks like the WebGL test completed and we crashed during shutdown in the JS code.
Component: Canvas: WebGL → JavaScript Engine
And ever since we've been dumping every unfiled shutdown crash in this bug, let's see if we can't stop doing that.
Severity: normal → critical
Keywords: crash
Summary: Intermittent 26 ERROR TEST-UNEXPECTED-FAIL | automation.py | application terminated with exit code 1 → Intermittent 26 ERROR TEST-UNEXPECTED-FAIL | automation.py | application crashed [@ js::XDRBuffer<0>::write(unsigned __int64)]
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 8 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.