Closed Bug 1451156 Opened 7 years ago Closed 7 years ago

Intermittent font-inflation/intrinsic-max-1.html == font-inflation/intrinsic-max-1-ref.html | application crashed [@ libc.so + 0x1c3dc]

Categories

(Core :: Layout: Text and Fonts, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: crash, intermittent-failure)

Crash Data

Filed by: apavel [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=171589418&repo=mozilla-central https://queue.taskcluster.net/v1/task/XXpKwBnXTVeccVQaPG5DSQ/runs/0/artifacts/public/logs/live_backing.log https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://queue.taskcluster.net/v1/task/XXpKwBnXTVeccVQaPG5DSQ/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1 [task 2018-04-03T11:47:07.271Z] 11:47:07 INFO - REFTEST TEST-START | http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-min-1.html == http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-min-1-ref.html [task 2018-04-03T11:47:07.272Z] 11:47:07 INFO - REFTEST INFO | RESTORE PREFERENCE pref(font.size.inflation.lineThreshold,400) [task 2018-04-03T11:47:07.273Z] 11:47:07 INFO - REFTEST INFO | RESTORE PREFERENCE pref(font.size.inflation.forceEnabled,false) [task 2018-04-03T11:47:07.274Z] 11:47:07 INFO - REFTEST INFO | RESTORE PREFERENCE pref(font.size.inflation.emPerLine,0) [task 2018-04-03T11:47:07.275Z] 11:47:07 INFO - REFTEST INFO | SET PREFERENCE pref(font.size.inflation.emPerLine,15) [task 2018-04-03T11:47:07.276Z] 11:47:07 INFO - REFTEST INFO | SET PREFERENCE pref(font.size.inflation.forceEnabled,true) [task 2018-04-03T11:47:07.278Z] 11:47:07 INFO - REFTEST INFO | SET PREFERENCE pref(font.size.inflation.lineThreshold,0) [task 2018-04-03T11:47:07.279Z] 11:47:07 INFO - REFTEST TEST-LOAD | http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-min-1.html | 368 / 542 (67%) [task 2018-04-03T11:47:19.101Z] 11:47:19 INFO - REFTEST INFO | RESTORE PREFERENCE pref(font.size.inflation.lineThreshold,400) [task 2018-04-03T11:47:19.101Z] 11:47:19 INFO - REFTEST INFO | RESTORE PREFERENCE pref(font.size.inflation.forceEnabled,false) [task 2018-04-03T11:47:19.103Z] 11:47:19 INFO - REFTEST INFO | RESTORE PREFERENCE pref(font.size.inflation.emPerLine,0) [task 2018-04-03T11:47:19.104Z] 11:47:19 INFO - REFTEST TEST-LOAD | http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-min-1-ref.html | 368 / 542 (67%) [task 2018-04-03T11:47:19.106Z] 11:47:19 INFO - REFTEST TEST-PASS | http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-min-1.html == http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-min-1-ref.html | image comparison, max difference: 0, number of differing pixels: 0 [task 2018-04-03T11:47:19.108Z] 11:47:19 INFO - REFTEST TEST-END | http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-min-1.html == http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-min-1-ref.html [task 2018-04-03T11:47:19.110Z] 11:47:19 INFO - REFTEST TEST-START | http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-max-1.html == http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-max-1-ref.html [task 2018-04-03T11:47:19.112Z] 11:47:19 INFO - REFTEST INFO | SET PREFERENCE pref(font.size.inflation.emPerLine,15) [task 2018-04-03T11:47:19.113Z] 11:47:19 INFO - REFTEST INFO | SET PREFERENCE pref(font.size.inflation.forceEnabled,true) [task 2018-04-03T11:47:19.114Z] 11:47:19 INFO - REFTEST INFO | SET PREFERENCE pref(font.size.inflation.lineThreshold,0) [task 2018-04-03T11:47:19.116Z] 11:47:19 INFO - REFTEST TEST-LOAD | http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-max-1.html | 369 / 542 (68%) [task 2018-04-03T11:47:20.319Z] 11:47:20 INFO - Browser unexpectedly found running. Killing... [task 2018-04-03T11:47:20.321Z] 11:47:20 INFO - REFTEST TEST-INFO | started process screentopng [task 2018-04-03T11:47:20.953Z] 11:47:20 INFO - REFTEST TEST-INFO | screentopng: exit 0 [task 2018-04-03T11:47:36.620Z] 11:47:36 WARNING - TEST-UNEXPECTED-FAIL | http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-max-1.html == http://10.0.2.2:8888/tests/layout/reftests/font-inflation/intrinsic-max-1-ref.html | application ran for longer than allowed maximum time [task 2018-04-03T11:47:36.621Z] 11:47:36 INFO - INFO | automation.py | Application ran for: 1:30:45.056682 [task 2018-04-03T11:47:36.621Z] 11:47:36 INFO - INFO | zombiecheck | Reading PID log: /tmp/tmpUBufe2pidlog [task 2018-04-03T11:47:36.935Z] 11:47:36 INFO - Contents of /data/anr/traces.txt: [task 2018-04-03T11:47:36.936Z] 11:47:36 INFO - ----- pid 830 at 2018-04-03 04:47:21 ----- [task 2018-04-03T11:47:36.936Z] 11:47:36 INFO - Cmd line: org.mozilla.fennec_aurora [task 2018-04-03T11:47:36.938Z] 11:47:36 INFO - JNI: CheckJNI is on; workarounds are off; pins=0; globals=292 [task 2018-04-03T11:47:36.938Z] 11:47:36 INFO - DALVIK THREADS: [task 2018-04-03T11:47:36.938Z] 11:47:36 INFO - (mutexes: tll=0 tsl=0 tscl=0 ghl=0) [task 2018-04-03T11:47:36.939Z] 11:47:36 INFO - "main" prio=5 tid=1 SUSPENDED [task 2018-04-03T11:47:36.940Z] 11:47:36 INFO - | group="main" sCount=1 dsCount=0 obj=0x414c9578 self=0x2a00d090 [task 2018-04-03T11:47:36.940Z] 11:47:36 INFO - | sysTid=830 nice=0 sched=0/0 cgrp=apps handle=1073811452 [task 2018-04-03T11:47:36.941Z] 11:47:36 INFO - | state=S schedstat=( 816851503876 636069115383 429875 ) utm=46967 stm=34718 core=0 [task 2018-04-03T11:47:36.942Z] 11:47:36 INFO - #00 pc 0001c5a4 /system/lib/libc.so (__futex_syscall3+8) [task 2018-04-03T11:47:36.943Z] 11:47:36 INFO - #01 pc 0000e688 /system/lib/libc.so (__pthread_cond_timedwait_relative+48) [task 2018-04-03T11:47:36.944Z] 11:47:36 INFO - #02 pc 0000e6e8 /system/lib/libc.so (__pthread_cond_timedwait+64) [task 2018-04-03T11:47:36.945Z] 11:47:36 INFO - #03 pc 00052e97 /system/lib/libdvm.so [task 2018-04-03T11:47:36.946Z] 11:47:36 INFO - #04 pc 00053461 /system/lib/libdvm.so (dvmChangeStatus(Thread*, ThreadStatus)+30) [task 2018-04-03T11:47:36.947Z] 11:47:36 INFO - #05 pc 0004dcb3 /system/lib/libdvm.so (dvmCallJNIMethod(unsigned int const*, JValue*, Method const*, Thread*)+402) [task 2018-04-03T11:47:36.948Z] 11:47:36 INFO - #06 pc 000385e1 /system/lib/libdvm.so (dvmCheckCallJNIMethod(unsigned int const*, JValue*, Method const*, Thread*)+8) [task 2018-04-03T11:47:36.948Z] 11:47:36 INFO - #07 pc 00000214 /dev/ashmem/dalvik-jit-code-cache (deleted) [task 2018-04-03T11:47:36.949Z] 11:47:36 INFO - at android.view.DisplayEventReceiver.nativeScheduleVsync(Native Method) [task 2018-04-03T11:47:36.949Z] 11:47:36 INFO - at android.view.DisplayEventReceiver.scheduleVsync(DisplayEventReceiver.java:132) [task 2018-04-03T11:47:36.950Z] 11:47:36 INFO - at android.view.Choreographer.scheduleVsyncLocked(Choreographer.java:596) [task 2018-04-03T11:47:36.951Z] 11:47:36 INFO - at android.view.Choreographer.scheduleFrameLocked(Choreographer.java:472) [task 2018-04-03T11:47:36.951Z] 11:47:36 INFO - at android.view.Choreographer.postCallbackDelayedInternal(Choreographer.java:316) [task 2018-04-03T11:47:36.952Z] 11:47:36 INFO - at android.view.Choreographer.postCallbackDelayed(Choreographer.java:299) [task 2018-04-03T11:47:36.953Z] 11:47:36 INFO - at android.view.Choreographer.postCallback(Choreographer.java:273) [task 2018-04-03T11:47:36.953Z] 11:47:36 INFO - at android.animation.ValueAnimator$AnimationHandler.scheduleAnimation(ValueAnimator.java:651) [task 2018-04-03T11:47:36.954Z] 11:47:36 INFO - at android.animation.ValueAnimator$AnimationHandler.doAnimationFrame(ValueAnimator.java:638) [task 2018-04-03T11:47:36.955Z] 11:47:36 INFO - at android.animation.ValueAnimator$AnimationHandler.run(ValueAnimator.java:646) [task 2018-04-03T11:47:36.955Z] 11:47:36 INFO - at android.view.Choreographer$CallbackRecord.run(Choreographer.java:749) [task 2018-04-03T11:47:36.956Z] 11:47:36 INFO - at android.view.Choreographer.doCallbacks(Choreographer.java:562) [task 2018-04-03T11:47:36.956Z] 11:47:36 INFO - at android.view.Choreographer.doFrame(Choreographer.java:531) [task 2018-04-03T11:47:36.957Z] 11:47:36 INFO - at android.view.Choreographer$FrameDisplayEventReceiver.run(Choreographer.java:735) [task 2018-04-03T11:47:36.957Z] 11:47:36 INFO - at android.os.Handler.handleCallback(Handler.java:730) [task 2018-04-03T11:47:36.958Z] 11:47:36 INFO - at android.os.Handler.dispatchMessage(Handler.java:92) [task 2018-04-03T11:47:36.959Z] 11:47:36 INFO - at android.os.Looper.loop(Looper.java:137) [task 2018-04-03T11:47:36.960Z] 11:47:36 INFO - at android.app.ActivityThread.main(ActivityThread.java:5103) [task 2018-04-03T11:47:36.960Z] 11:47:36 INFO - at java.lang.reflect.Method.invokeNative(Native Method) [task 2018-04-03T11:47:36.962Z] 11:47:36 INFO - at java.lang.reflect.Method.invoke(Method.java:525) [task 2018-04-03T11:47:36.962Z] 11:47:36 INFO - at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737) [task 2018-04-03T11:47:36.963Z] 11:47:36 INFO - at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553) [task 2018-04-03T11:47:36.963Z] 11:47:36 INFO - at dalvik.system.NativeStart.main(Native Method) [task 2018-04-03T11:47:36.964Z] 11:47:36 INFO - "Thread-84" prio=5 tid=28 NATIVE [task 2018-04-03T11:47:36.964Z] 11:47:36 INFO - | group="main" sCount=1 dsCount=0 obj=0x41f28988 self=0x2a4246d8 [task 2018-04-03T11:47:36.965Z] 11:47:36 INFO - | sysTid=950 nice=0 sched=0/0 cgrp=apps handle=708847912 [task 2018-04-03T11:47:36.965Z] 11:47:36 INFO - | state=S schedstat=( 309787155650 319903277406 127407 ) utm=18983 stm=11995 core=0 [task 2018-04-03T11:47:36.965Z] 11:47:36 INFO - #00 pc 0001c5a4 /system/lib/libc.so (__futex_syscall3+8) [task 2018-04-03T11:47:36.966Z] 11:47:36 INFO - #01 pc 0000e688 /system/lib/libc.so (__pthread_cond_timedwait_relative+48) [task 2018-04-03T11:47:36.966Z] 11:47:36 INFO - #02 pc 0000e6e8 /system/lib/libc.so (__pthread_cond_timedwait+64) [task 2018-04-03T11:47:36.967Z] 11:47:36 INFO - #03 pc 003215a1 /data/data/org.mozilla.fennec_aurora/cache/libxul.so [task 2018-04-03T11:47:36.967Z] 11:47:36 INFO - at dalvik.system.NativeStart.run(Native Method) [task 2018-04-03T11:47:36.967Z] 11:47:36 INFO - "AsyncTask #5" prio=5 tid=27 WAIT [task 2018-04-03T11:47:36.968Z] 11:47:36 INFO - | group="main" sCount=1 dsCount=0 obj=0x41f11558 self=0x2a416f18 [task 2018-04-03T11:47:36.969Z] 11:47:36 INFO - | sysTid=958 nice=10 sched=0/0 cgrp=apps/bg_non_interactive handle=708932456 [task 2018-04-03T11:47:36.969Z] 11:47:36 INFO - | state=S schedstat=( 20328237 1102739780 12 ) utm=1 stm=1 core=0 [task 2018-04-03T11:47:36.969Z] 11:47:36 INFO - at java.lang.Object.wait(Native Method) [task 2018-04-03T11:47:36.970Z] 11:47:36 INFO - - waiting on <0x41f116b0> (a java.lang.VMThread) held by tid=27 (AsyncTask #5) [task 2018-04-03T11:47:36.971Z] 11:47:36 INFO - at java.lang.Thread.parkFor(Thread.java:1205) [task 2018-04-03T11:47:36.971Z] 11:47:36 INFO - at sun.misc.Unsafe.park(Unsafe.java:325) [task 2018-04-03T11:47:36.972Z] 11:47:36 INFO - at java.util.concurrent.locks.LockSupport.park(LockSupport.java:159) [task 2018-04-03T11:47:36.972Z] 11:47:36 INFO - at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2019) [task 2018-04-03T11:47:36.973Z] 11:47:36 INFO - at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:413) [task 2018-04-03T11:47:36.973Z] 11:47:36 INFO - at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1013) [task 2018-04-03T11:47:36.974Z] 11:47:36 INFO - at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1073) [task 2018-04-03T11:47:36.975Z] 11:47:36 INFO - at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:573) [task 2018-04-03T11:47:36.975Z] 11:47:36 INFO - at java.lang.Thread.run(Thread.java:841)
Component: Reftest → Layout: Text
Product: Testing → Core
Version: Version 3 → unspecified
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.