Closed Bug 1461133 Opened 8 years ago Closed 8 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | application timed out after 370 seconds with no output

Categories

(Core :: Graphics: CanvasWebGL, defect, P5)

Product:
Core
Component:
Graphics: CanvasWebGL
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: btara [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=178175818&repo=mozilla-central https://queue.taskcluster.net/v1/task/BCZ3gQ8zRYGyAohcHQYCHA/runs/0/artifacts/public/logs/live_backing.log 12:06:15 INFO - 545 INFO TEST-START | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html 12:06:15 INFO - GECKO(1900) | JavaScript warning: http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/js/webgl-test-utils.js, line 1521: Error: WebGL warning: Exceeded 16 live WebGL contexts for this principal, losing the least recently used one. 12:06:15 INFO - GECKO(1900) | WebGL(0C925800)::ForceLoseContext 12:06:15 INFO - GECKO(1900) | JavaScript warning: http://mochi.test:8888/tests/dom/canvas/test/webgl-conf/checkout/js/webgl-test-utils.js, line 1521: Error: WebGL warning: Exceeded 16 live WebGL contexts for this principal, losing the least recently used one. 12:06:15 INFO - GECKO(1900) | WebGL(0D24D400)::ForceLoseContext 12:12:31 INFO - Buffered messages logged at 12:06:15 12:12:31 INFO - 546 INFO TEST-PASS | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | A valid string reason is expected 12:12:31 INFO - 547 INFO TEST-PASS | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | Reason cannot be empty 12:12:31 INFO - 548 INFO TEST-PASS | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | shader with uniform with 100 operators in temp expressions in multiple lines 12:12:31 INFO - 549 INFO TEST-PASS | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | shader with uniform with 100 operators in temp expressions in one line 12:12:31 INFO - 550 INFO TEST-PASS | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | shader with uniform with 1000 operators in temp expressions in multiple lines 12:12:31 INFO - Buffered messages logged at 12:06:16 12:12:31 INFO - 551 INFO TEST-PASS | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | shader with uniform with 1000 operators in temp expressions in one line 12:12:31 INFO - Buffered messages logged at 12:06:21 12:12:31 INFO - 552 INFO TEST-PASS | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | shader with uniform with 10000 operators in temp expressions in multiple lines 12:12:31 INFO - Buffered messages finished 12:12:31 WARNING - TEST-UNEXPECTED-TIMEOUT | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | application timed out after 370 seconds with no output 12:12:31 INFO - 553 ERROR Force-terminating active process(es). 12:12:31 INFO - Determining child pids from psutil... 12:12:31 INFO - [2660, 500, 1576] 12:12:31 INFO - ==> process 1900 launched child process 1576 ("Z:\task_1526125755\build\application\firefox\firefox.exe" -contentproc --channel="1900.0.1687676603\765270071" -childID 1 -isForBrowser -prefsHandle 1788 -prefsLen 16562 -schedulerPrefs 0001,2 -parentBuildID 20180512100055 -greomni "Z:\task_1526125755\build\application\firefox\omni.ja" -appomni "Z:\task_1526125755\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1526125755\build\application\firefox\browser" - 1900 "\\.\pipe\gecko-crash-server-pipe.1900" 1888 tab) 12:12:31 INFO - ==> process 1900 launched child process 500 ("Z:\task_1526125755\build\application\firefox\firefox.exe" -contentproc --channel="1900.6.723881621\761835245" -childID 2 -isForBrowser -prefsHandle 2184 -prefsLen 16562 -schedulerPrefs 0001,2 -parentBuildID 20180512100055 -greomni "Z:\task_1526125755\build\application\firefox\omni.ja" -appomni "Z:\task_1526125755\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1526125755\build\application\firefox\browser" - 1900 "\\.\pipe\gecko-crash-server-pipe.1900" 2196 tab) 12:12:31 INFO - ==> process 1900 launched child process 2660 ("Z:\task_1526125755\build\application\firefox\firefox.exe" -contentproc --channel="1900.12.1730615589\1488753057" -childID 3 -isForBrowser -prefsHandle 2148 -prefsLen 17906 -schedulerPrefs 0001,2 -parentBuildID 20180512100055 -greomni "Z:\task_1526125755\build\application\firefox\omni.ja" -appomni "Z:\task_1526125755\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1526125755\build\application\firefox\browser" - 1900 "\\.\pipe\gecko-crash-server-pipe.1900" 2144 tab) 12:12:31 INFO - Found child pids: set([1576, 500, 2660]) 12:12:31 INFO - Killing process: 1576 12:12:31 INFO - TEST-INFO | started process screenshot 12:12:31 INFO - TEST-INFO | screenshot: exit 0 12:12:31 INFO - mozcrash kill_pid(): wait failed (-1) terminating pid 1576: error 5 12:12:31 INFO - Killing process: 500 12:12:31 INFO - Not taking screenshot here: see the one that was previously logged 12:12:31 INFO - mozcrash kill_pid(): wait failed (-1) terminating pid 500: error 5 12:12:31 INFO - Killing process: 2660 12:12:31 INFO - Not taking screenshot here: see the one that was previously logged 12:12:31 INFO - mozcrash kill_pid(): unable to terminate pid 2660: 5 12:12:32 INFO - psutil found pid 500 dead 12:12:32 INFO - psutil found pid 2660 dead 12:12:32 INFO - psutil found pid 1576 dead 12:12:32 INFO - Killing process: 1900 12:12:32 INFO - Not taking screenshot here: see the one that was previously logged 12:12:32 INFO - mozcrash kill_pid(): wait failed (-1) terminating pid 1900: error 5 12:12:32 INFO - psutil found pid 1900 dead 12:12:32 INFO - TEST-INFO | Main app process: exit 1 12:12:32 INFO - Buffered messages finished 12:12:32 ERROR - 554 ERROR TEST-UNEXPECTED-FAIL | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | application terminated with exit code 1 12:12:32 INFO - runtests.py | Application ran for: 0:09:01.334000 12:12:32 INFO - zombiecheck | Reading PID log: c:\users\task_1526125755\appdata\local\temp\tmpgg86tdpidlog 12:12:32 INFO - ==> process 1900 launched child process 1576 ("Z:\task_1526125755\build\application\firefox\firefox.exe" -contentproc --channel="1900.0.1687676603\765270071" -childID 1 -isForBrowser -prefsHandle 1788 -prefsLen 16562 -schedulerPrefs 0001,2 -parentBuildID 20180512100055 -greomni "Z:\task_1526125755\build\application\firefox\omni.ja" -appomni "Z:\task_1526125755\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1526125755\build\application\firefox\browser" - 1900 "\\.\pipe\gecko-crash-server-pipe.1900" 1888 tab) 12:12:32 INFO - ==> process 1900 launched child process 500 ("Z:\task_1526125755\build\application\firefox\firefox.exe" -contentproc --channel="1900.6.723881621\761835245" -childID 2 -isForBrowser -prefsHandle 2184 -prefsLen 16562 -schedulerPrefs 0001,2 -parentBuildID 20180512100055 -greomni "Z:\task_1526125755\build\application\firefox\omni.ja" -appomni "Z:\task_1526125755\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1526125755\build\application\firefox\browser" - 1900 "\\.\pipe\gecko-crash-server-pipe.1900" 2196 tab) 12:12:32 INFO - ==> process 1900 launched child process 2660 ("Z:\task_1526125755\build\application\firefox\firefox.exe" -contentproc --channel="1900.12.1730615589\1488753057" -childID 3 -isForBrowser -prefsHandle 2148 -prefsLen 17906 -schedulerPrefs 0001,2 -parentBuildID 20180512100055 -greomni "Z:\task_1526125755\build\application\firefox\omni.ja" -appomni "Z:\task_1526125755\build\application\firefox\browser\omni.ja" -appdir "Z:\task_1526125755\build\application\firefox\browser" - 1900 "\\.\pipe\gecko-crash-server-pipe.1900" 2144 tab) 12:12:32 INFO - zombiecheck | Checking for orphan process with PID: 1576 12:12:32 INFO - zombiecheck | Checking for orphan process with PID: 2660 12:12:32 INFO - zombiecheck | Checking for orphan process with PID: 500 12:12:32 INFO - mozcrash Downloading symbols from: https://queue.taskcluster.net/v1/task/S-MjitAwS52nKqjqSyXJ3w/artifacts/public/build/target.crashreporter-symbols.zip 12:12:35 INFO - mozcrash Copy/paste: Z:\task_1526125755\build\win32-minidump_stackwalk.exe c:\users\task_1526125755\appdata\local\temp\tmpmzuf9l.mozrunner\minidumps\2bcb0fdb-b92a-431f-8fb9-141d99dc7d07.dmp c:\users\task_1526125755\appdata\local\temp\tmpygmp_g 12:12:48 INFO - mozcrash Saved minidump as Z:\task_1526125755\build\blobber_upload_dir\2bcb0fdb-b92a-431f-8fb9-141d99dc7d07.dmp 12:12:48 WARNING - PROCESS-CRASH | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | application crashed [None] 12:12:48 INFO - Crash dump filename: c:\users\task_1526125755\appdata\local\temp\tmpmzuf9l.mozrunner\minidumps\2bcb0fdb-b92a-431f-8fb9-141d99dc7d07.dmp 12:12:48 INFO - Operating system: Windows NT 12:12:48 INFO - 6.1.7601 Service Pack 1 12:12:48 INFO - CPU: x86 12:12:48 INFO - GenuineIntel family 6 model 45 stepping 7 12:12:48 INFO - 8 CPUs 12:12:49 INFO - GPU: UNKNOWN 12:12:49 INFO - No crash 12:12:49 INFO - Process uptime: 539 seconds 12:12:49 INFO - Thread 0 12:12:49 INFO - 0 ntdll.dll!KiFastSystemCallRet + 0x0 12:12:49 INFO - eip = 0x774270b4 esp = 0x0031f468 ebp = 0x0031f4c0 ebx = 0x0031f4c8 12:12:49 INFO - esi = 0x00000000 edi = 0x00000000 eax = 0x0031f530 ecx = 0x00e2b1f0 12:12:49 INFO - edx = 0x00000000 efl = 0x00000247 12:12:49 INFO - Found by: given as instruction pointer in context 12:12:49 INFO - 1 ntdll.dll!ZwWaitForKeyedEvent + 0xc 12:12:49 INFO - eip = 0x774269f4 esp = 0x0031f46c ebp = 0x0031f4c0 12:12:49 INFO - Found by: call frame info 12:12:49 INFO - 2 ntdll.dll!RtlSleepConditionVariableSRW + 0xda 12:12:49 INFO - eip = 0x773e4a1a esp = 0x0031f470 ebp = 0x0031f4c0 12:12:49 INFO - Found by: call frame info 12:12:49 INFO - 3 xul.dll!nsBox::GetXULMinSize(nsBoxLayoutState &) [nsBox.cpp:809b0329507e97d46600f52fe33d1c0fb2e118cf : 280 + 0x4] 12:12:49 INFO - eip = 0x59f30100 esp = 0x0031f48c ebp = 0x0031f4c0 12:12:49 INFO - Found by: stack scanning 12:12:49 INFO - 4 kernel32.dll!wcslen + 0xa4 12:12:49 INFO - eip = 0x75862419 esp = 0x0031f4c8 ebp = 0x0031f4ec 12:12:49 INFO - Found by: call frame info 12:12:49 INFO - 5 mozglue.dll!mozilla::detail::ConditionVariableImpl::wait(mozilla::detail::MutexImpl &) [ConditionVariable_windows.cpp:809b0329507e97d46600f52fe33d1c0fb2e118cf : 58 + 0xe] 12:12:49 INFO - eip = 0x62ab9f21 esp = 0x0031f4f4 ebp = 0x0031f504 12:12:49 INFO - Found by: call frame info 12:12:49 INFO - 6 xul.dll!mozilla::ThreadEventQueue<mozilla::PrioritizedEventQueue<mozilla::LabeledEventQueue> >::GetEvent(bool,mozilla::EventPriority *) [ThreadEventQueue.cpp:809b0329507e97d46600f52fe33d1c0fb2e118cf : 155 + 0x11] 12:12:49 INFO - eip = 0x5aa827cf esp = 0x0031f50c ebp = 0x0031f52c 12:12:49 INFO - Found by: call frame info 12:12:49 INFO - 7 xul.dll!nsThread::ProcessNextEvent(bool,bool *) [nsThread.cpp:809b0329507e97d46600f52fe33d1c0fb2e118cf : 994 + 0x19] 12:12:49 INFO - eip = 0x59f3d5eb esp = 0x0031f534 ebp = 0x0031fb50 12:12:49 INFO - Found by: call frame info 12:12:49 INFO - 8 xul.dll!NS_ProcessNextEvent(nsIThread *,bool) [nsThreadUtils.cpp:809b0329507e97d46600f52fe33d1c0fb2e118cf : 519 + 0xb] 12:12:49 INFO - eip = 0x5a15dba0 esp = 0x0031fb58 ebp = 0x0031fb6c 12:12:49 INFO - Found by: call frame info 12:12:49 INFO - 9 xul.dll!mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate *) [MessagePump.cpp:809b0329507e97d46600f52fe33d1c0fb2e118cf : 125 + 0x9] 12:12:49 INFO - eip = 0x5a1f5d54 esp = 0x0031fb74 ebp = 0x0031fb8c 12:12:49 INFO - Found by: call frame info 12:12:49 INFO - 10 xul.dll!mozilla::ipc::MessagePumpForChildProcess::Run(base::MessagePump::Delegate *) [MessagePump.cpp:809b0329507e97d46600f52fe33d1c0fb2e118cf : 301 + 0x8] 12:12:49 INFO - eip = 0x5ac7d4fb esp = 0x0031fb94 ebp = 0x0031fba8 12:12:49 INFO - Found by: call frame info
Summary: Intermittent dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | application crashed [None] | After timed out and terminated with exit code 1 → Intermittent TEST-UNEXPECTED-TIMEOUT | dom/canvas/test/webgl-conf/generated/test_conformance__glsl__bugs__temp-expressions-should-not-crash.html | application timed out after 370 seconds with no output
You need to log in before you can comment on or make changes to this bug.