Closed Bug 1471746 Opened 6 years ago Closed 6 years ago

Intermittent css-display/display-contents-xbl-7.xhtml == css-display/display-contents-xbl-7-ref.html | application ran for longer than allowed maximum time

Categories

(Firefox for Android Graveyard :: Testing, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1472032

People

(Reporter: intermittent-bug-filer, Assigned: gbrown)

Details

(Keywords: intermittent-failure)

Filed by: apavel [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=185208820&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/G2tXel5HS-excVF1zdXgag/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/G2tXel5HS-excVF1zdXgag/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2018-06-27T18:55:30.252Z] 18:55:30     INFO -  REFTEST TEST-START | http://10.0.2.2:8888/tests/layout/reftests/css-display/display-contents-xbl-7.xhtml == http://10.0.2.2:8888/tests/layout/reftests/css-display/display-contents-xbl-7-ref.html
[task 2018-06-27T18:55:30.253Z] 18:55:30     INFO -  REFTEST TEST-LOAD | http://10.0.2.2:8888/tests/layout/reftests/css-display/display-contents-xbl-7.xhtml | 621 / 634 (97%)
[task 2018-06-27T18:55:31.262Z] 18:55:31     INFO -  Browser unexpectedly found running. Killing...
[task 2018-06-27T18:55:31.263Z] 18:55:31     INFO -  REFTEST TEST-INFO | started process screentopng
[task 2018-06-27T18:55:31.799Z] 18:55:31     INFO -  REFTEST TEST-INFO | screentopng: exit 0
[task 2018-06-27T18:55:46.974Z] 18:55:46  WARNING -  TEST-UNEXPECTED-FAIL | http://10.0.2.2:8888/tests/layout/reftests/css-display/display-contents-xbl-7.xhtml == http://10.0.2.2:8888/tests/layout/reftests/css-display/display-contents-xbl-7-ref.html | application ran for longer than allowed maximum time
[task 2018-06-27T18:55:46.974Z] 18:55:46     INFO -  INFO | automation.py | Application ran for: 1:30:38.690620
[task 2018-06-27T18:55:46.975Z] 18:55:46     INFO -  INFO | zombiecheck | Reading PID log: /tmp/tmpu_6IbRpidlog
[task 2018-06-27T18:55:47.293Z] 18:55:47     INFO -  Contents of /data/anr/traces.txt:
[task 2018-06-27T18:55:47.293Z] 18:55:47     INFO -  ----- pid 825 at 2018-06-27 11:55:32 -----
[task 2018-06-27T18:55:47.294Z] 18:55:47     INFO -  Cmd line: org.mozilla.fennec_aurora
[task 2018-06-27T18:55:47.295Z] 18:55:47     INFO -  JNI: CheckJNI is on; workarounds are off; pins=0; globals=285
[task 2018-06-27T18:55:47.297Z] 18:55:47     INFO -  DALVIK THREADS:
[task 2018-06-27T18:55:47.297Z] 18:55:47     INFO -  (mutexes: tll=0 tsl=0 tscl=0 ghl=0)
[task 2018-06-27T18:55:47.298Z] 18:55:47     INFO -  "main" prio=5 tid=1 NATIVE
[task 2018-06-27T18:55:47.300Z] 18:55:47     INFO -    | group="main" sCount=1 dsCount=0 obj=0x414c9578 self=0x2a00d090
[task 2018-06-27T18:55:47.301Z] 18:55:47     INFO -    | sysTid=825 nice=0 sched=0/0 cgrp=apps handle=1073811452
[task 2018-06-27T18:55:47.302Z] 18:55:47     INFO -    | state=S schedstat=( 629513614284 544631822432 394834 ) utm=35336 stm=27615 core=0
[task 2018-06-27T18:55:47.303Z] 18:55:47     INFO -    #00  pc 0001c5a4  /system/lib/libc.so (__futex_syscall3+8)
[task 2018-06-27T18:55:47.304Z] 18:55:47     INFO -    #01  pc 0000e688  /system/lib/libc.so (__pthread_cond_timedwait_relative+48)
[task 2018-06-27T18:55:47.305Z] 18:55:47     INFO -    #02  pc 0000e6e8  /system/lib/libc.so (__pthread_cond_timedwait+64)
[task 2018-06-27T18:55:47.306Z] 18:55:47     INFO -    #03  pc 00052e97  /system/lib/libdvm.so
[task 2018-06-27T18:55:47.307Z] 18:55:47     INFO -    #04  pc 00053461  /system/lib/libdvm.so (dvmChangeStatus(Thread*, ThreadStatus)+30)
[task 2018-06-27T18:55:47.307Z] 18:55:47     INFO -    #05  pc 00048d29  /system/lib/libdvm.so
[task 2018-06-27T18:55:47.308Z] 18:55:47     INFO -    #06  pc 00039afd  /system/lib/libdvm.so
[task 2018-06-27T18:55:47.308Z] 18:55:47     INFO -    #07  pc 0004b7a9  /system/lib/libandroid_runtime.so (android::AndroidRuntime::getJNIEnv()+16)
[task 2018-06-27T18:55:47.309Z] 18:55:47     INFO -    #08  pc 0005eed5  /system/lib/libandroid_runtime.so (android::NativeDisplayEventReceiver::dispatchVsync(long long, int, unsigned int)+20)
[task 2018-06-27T18:55:47.310Z] 18:55:47     INFO -    #09  pc 0005f0b9  /system/lib/libandroid_runtime.so (android::NativeDisplayEventReceiver::handleEvent(int, int, void*)+80)
[task 2018-06-27T18:55:47.310Z] 18:55:47     INFO -    #10  pc 00015129  /system/lib/libutils.so (android::Looper::pollInner(int)+468)
[task 2018-06-27T18:55:47.311Z] 18:55:47     INFO -    #11  pc 000151d5  /system/lib/libutils.so (android::Looper::pollOnce(int, int*, int*, void**)+92)
[task 2018-06-27T18:55:47.311Z] 18:55:47     INFO -    #12  pc 00067b69  /system/lib/libandroid_runtime.so (android::NativeMessageQueue::pollOnce(_JNIEnv*, int)+22)
[task 2018-06-27T18:55:47.312Z] 18:55:47     INFO -    #13  pc 0001dc4c  /system/lib/libdvm.so (dvmPlatformInvoke+112)
[task 2018-06-27T18:55:47.313Z] 18:55:47     INFO -    #14  pc 0004dcab  /system/lib/libdvm.so (dvmCallJNIMethod(unsigned int const*, JValue*, Method const*, Thread*)+394)
[task 2018-06-27T18:55:47.313Z] 18:55:47     INFO -    #15  pc 000385e1  /system/lib/libdvm.so (dvmCheckCallJNIMethod(unsigned int const*, JValue*, Method const*, Thread*)+8)
[task 2018-06-27T18:55:47.314Z] 18:55:47     INFO -    #16  pc 00000214  /dev/ashmem/dalvik-jit-code-cache (deleted)
[task 2018-06-27T18:55:47.315Z] 18:55:47     INFO -    at android.os.MessageQueue.nativePollOnce(Native Method)
[task 2018-06-27T18:55:47.317Z] 18:55:47     INFO -    at android.os.MessageQueue.next(MessageQueue.java:132)
[task 2018-06-27T18:55:47.317Z] 18:55:47     INFO -    at android.os.Looper.loop(Looper.java:124)
[task 2018-06-27T18:55:47.317Z] 18:55:47     INFO -    at android.app.ActivityThread.main(ActivityThread.java:5103)
[task 2018-06-27T18:55:47.318Z] 18:55:47     INFO -    at java.lang.reflect.Method.invokeNative(Native Method)
[task 2018-06-27T18:55:47.318Z] 18:55:47     INFO -    at java.lang.reflect.Method.invoke(Method.java:525)
[task 2018-06-27T18:55:47.319Z] 18:55:47     INFO -    at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737)
[task 2018-06-27T18:55:47.319Z] 18:55:47     INFO -    at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553)
[task 2018-06-27T18:55:47.320Z] 18:55:47     INFO -    at dalvik.system.NativeStart.main(Native Method)
[task 2018-06-27T18:55:47.320Z] 18:55:47     INFO -  "AsyncTask #5" prio=5 tid=28 WAIT
[task 2018-06-27T18:55:47.321Z] 18:55:47     INFO -    | group="main" sCount=1 dsCount=0 obj=0x41e57e50 self=0x2a4107d0
[task 2018-06-27T18:55:47.322Z] 18:55:47     INFO -    | sysTid=950 nice=10 sched=0/0 cgrp=apps/bg_non_interactive handle=708906016
[task 2018-06-27T18:55:47.322Z] 18:55:47     INFO -    | state=S schedstat=( 25751928 1436387147 24 ) utm=1 stm=1 core=0
[task 2018-06-27T18:55:47.323Z] 18:55:47     INFO -    at java.lang.Object.wait(Native Method)
[task 2018-06-27T18:55:47.324Z] 18:55:47     INFO -    - waiting on <0x41e57fa8> (a java.lang.VMThread) held by tid=28 (AsyncTask #5)
[task 2018-06-27T18:55:47.325Z] 18:55:47     INFO -    at java.lang.Thread.parkFor(Thread.java:1205)
[task 2018-06-27T18:55:47.327Z] 18:55:47     INFO -    at sun.misc.Unsafe.park(Unsafe.java:325)
[task 2018-06-27T18:55:47.328Z] 18:55:47     INFO -    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:159)
[task 2018-06-27T18:55:47.329Z] 18:55:47     INFO -    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2019)
[task 2018-06-27T18:55:47.329Z] 18:55:47     INFO -    at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:413)
[task 2018-06-27T18:55:47.330Z] 18:55:47     INFO -    at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1013)
[task 2018-06-27T18:55:47.331Z] 18:55:47     INFO -    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1073)
[task 2018-06-27T18:55:47.331Z] 18:55:47     INFO -    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:573)
[task 2018-06-27T18:55:47.332Z] 18:55:47     INFO -    at java.lang.Thread.run(Thread.java:841)
[task 2018-06-27T18:55:47.333Z] 18:55:47     INFO -  "AsyncTask #4" prio=5 tid=27 WAIT
[task 2018-06-27T18:55:47.333Z] 18:55:47     INFO -    | group="main" sCount=1 dsCount=0 obj=0x41e56c48 self=0x2a3fce50
[task 2018-06-27T18:55:47.334Z] 18:55:47     INFO -    | sysTid=948 nice=10 sched=0/0 cgrp=apps/bg_non_interactive handle=708825760
[task 2018-06-27T18:55:47.335Z] 18:55:47     INFO -    | state=S schedstat=( 21107064 1135712411 22 ) utm=1 stm=1 core=0
[task 2018-06-27T18:55:47.336Z] 18:55:47     INFO -    at java.lang.Object.wait(Native Method)
[task 2018-06-27T18:55:47.337Z] 18:55:47     INFO -    - waiting on <0x41e56d68> (a java.lang.VMThread) held by tid=27 (AsyncTask #4)
[task 2018-06-27T18:55:47.337Z] 18:55:47     INFO -    at java.lang.Thread.parkFor(Thread.java:1205)
[task 2018-06-27T18:55:47.338Z] 18:55:47     INFO -    at sun.misc.Unsafe.park(Unsafe.java:325)
[task 2018-06-27T18:55:47.339Z] 18:55:47     INFO -    at java.util.concurrent.locks.LockSupport.park(LockSupport.java:159)
[task 2018-06-27T18:55:47.340Z] 18:55:47     INFO -    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2019)
[task 2018-06-27T18:55:47.341Z] 18:55:47     INFO -    at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:413)
[task 2018-06-27T18:55:47.342Z] 18:55:47     INFO -    at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1013)
[task 2018-06-27T18:55:47.343Z] 18:55:47     INFO -    at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1073)
[task 2018-06-27T18:55:47.344Z] 18:55:47     INFO -    at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:573)
[task 2018-06-27T18:55:47.345Z] 18:55:47     INFO -    at java.lang.Thread.run(Thread.java:841)
[task 2018-06-27T18:55:47.346Z] 18:55:47     INFO -  "AsyncTask #3" prio=5 tid=26 WAIT
Assignee: nobody → gbrown
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → DUPLICATE
Product: Firefox for Android → Firefox for Android Graveyard
You need to log in before you can comment on or make changes to this bug.