Closed Bug 1461132 Opened 7 years ago Closed 7 years ago

Intermittent dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement17.html | application ran for longer than allowed maximum time

Categories

(Core :: DOM: Core & HTML, defect, P5)

Product:
Core
Component:
DOM: Core & HTML
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: crash, intermittent-failure)

Crash Data

Filed by: btara [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=178180637&repo=mozilla-central https://queue.taskcluster.net/v1/task/O41f7G1PTmyOZ4gKdc80fA/runs/0/artifacts/public/logs/live_backing.log [task 2018-05-12T16:38:53.688Z] 16:38:53 INFO - 248 INFO TEST-OK | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement10.html | took 56572ms [task 2018-05-12T16:39:04.981Z] 16:39:04 INFO - 249 INFO None250 INFO TEST-START | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement11.html [task 2018-05-12T16:39:53.649Z] 16:39:53 INFO - 251 INFO TEST-OK | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement11.html | took 47008ms [task 2018-05-12T16:40:22.924Z] 16:40:22 INFO - 252 INFO None253 INFO TEST-START | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement12.html [task 2018-05-12T16:42:19.237Z] 16:42:19 INFO - 254 INFO TEST-OK | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement12.html | took 113262ms [task 2018-05-12T16:42:44.399Z] 16:42:44 INFO - 255 INFO None256 INFO TEST-START | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement13.html [task 2018-05-12T16:44:14.198Z] 16:44:14 INFO - 257 INFO TEST-OK | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement13.html | took 87354ms [task 2018-05-12T16:44:24.938Z] 16:44:24 INFO - 258 INFO None259 INFO TEST-START | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement14.html [task 2018-05-12T16:45:28.574Z] 16:45:28 INFO - 260 INFO TEST-OK | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement14.html | took 62704ms [task 2018-05-12T16:45:39.332Z] 16:45:39 INFO - 261 INFO None262 INFO TEST-START | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement15.html [task 2018-05-12T16:46:28.467Z] 16:46:28 INFO - 263 INFO TEST-OK | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement15.html | took 39342ms [task 2018-05-12T16:46:39.212Z] 16:46:39 INFO - 264 INFO None265 INFO TEST-START | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement16.html [task 2018-05-12T16:47:54.265Z] 16:47:54 INFO - 266 INFO TEST-OK | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement16.html | took 65901ms [task 2018-05-12T16:48:16.984Z] 16:48:16 INFO - 267 INFO None268 INFO TEST-START | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement17.html [task 2018-05-12T16:48:53.700Z] 16:48:53 INFO - Browser unexpectedly found running. Killing... [task 2018-05-12T16:48:53.701Z] 16:48:53 INFO - TEST-INFO | started process screentopng [task 2018-05-12T16:48:54.562Z] 16:48:54 INFO - TEST-INFO | screentopng: exit 0 [task 2018-05-12T16:49:12.543Z] 16:49:12 INFO - org.mozilla.fennec_aurora still alive after SIGABRT: waiting... [task 2018-05-12T16:49:17.968Z] 16:49:17 WARNING - TEST-UNEXPECTED-FAIL | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement17.html | application ran for longer than allowed maximum time [task 2018-05-12T16:49:17.969Z] 16:49:17 INFO - INFO | automation.py | Application ran for: 1:30:45.390731 [task 2018-05-12T16:49:17.972Z] 16:49:17 INFO - INFO | zombiecheck | Reading PID log: /tmp/tmpelk8ADpidlog [task 2018-05-12T16:49:18.420Z] 16:49:18 INFO - Contents of /data/anr/traces.txt: [task 2018-05-12T16:49:18.421Z] 16:49:18 INFO - ----- pid 818 at 2018-05-12 09:48:55 ----- [task 2018-05-12T16:49:18.422Z] 16:49:18 INFO - Cmd line: org.mozilla.fennec_aurora [task 2018-05-12T16:49:18.423Z] 16:49:18 INFO - JNI: CheckJNI is on; workarounds are off; pins=0; globals=265 [task 2018-05-12T16:49:18.424Z] 16:49:18 INFO - DALVIK THREADS: [task 2018-05-12T16:49:18.425Z] 16:49:18 INFO - (mutexes: tll=0 tsl=0 tscl=0 ghl=0) [task 2018-05-12T16:49:18.426Z] 16:49:18 INFO - "main" prio=5 tid=1 NATIVE [task 2018-05-12T16:49:18.427Z] 16:49:18 INFO - | group="main" sCount=1 dsCount=0 obj=0x414c9578 self=0x2a00d090 [task 2018-05-12T16:49:18.428Z] 16:49:18 INFO - | sysTid=818 nice=0 sched=0/0 cgrp=apps handle=1073811452 [task 2018-05-12T16:49:18.430Z] 16:49:18 INFO - | state=S schedstat=( 666479190766 663616513525 358938 ) utm=39297 stm=27350 core=0 [task 2018-05-12T16:49:18.433Z] 16:49:18 INFO - #00 pc 0001c5a4 /system/lib/libc.so (__futex_syscall3+8) [task 2018-05-12T16:49:18.434Z] 16:49:18 INFO - #01 pc 0000e688 /system/lib/libc.so (__pthread_cond_timedwait_relative+48) [task 2018-05-12T16:49:18.435Z] 16:49:18 INFO - #02 pc 0000e6e8 /system/lib/libc.so (__pthread_cond_timedwait+64) [task 2018-05-12T16:49:18.436Z] 16:49:18 INFO - #03 pc 00052e97 /system/lib/libdvm.so [task 2018-05-12T16:49:18.437Z] 16:49:18 INFO - #04 pc 00053461 /system/lib/libdvm.so (dvmChangeStatus(Thread*, ThreadStatus)+30) [task 2018-05-12T16:49:18.438Z] 16:49:18 INFO - #05 pc 00048d29 /system/lib/libdvm.so [task 2018-05-12T16:49:18.439Z] 16:49:18 INFO - #06 pc 00039afd /system/lib/libdvm.so [task 2018-05-12T16:49:18.440Z] 16:49:18 INFO - #07 pc 0004b7a9 /system/lib/libandroid_runtime.so (android::AndroidRuntime::getJNIEnv()+16) [task 2018-05-12T16:49:18.441Z] 16:49:18 INFO - #08 pc 0005eed5 /system/lib/libandroid_runtime.so (android::NativeDisplayEventReceiver::dispatchVsync(long long, int, unsigned int)+20) [task 2018-05-12T16:49:18.443Z] 16:49:18 INFO - #09 pc 0005f0b9 /system/lib/libandroid_runtime.so (android::NativeDisplayEventReceiver::handleEvent(int, int, void*)+80) [task 2018-05-12T16:49:18.445Z] 16:49:18 INFO - #10 pc 00015129 /system/lib/libutils.so (android::Looper::pollInner(int)+468) [task 2018-05-12T16:49:18.447Z] 16:49:18 INFO - #11 pc 000151d5 /system/lib/libutils.so (android::Looper::pollOnce(int, int*, int*, void**)+92) [task 2018-05-12T16:49:18.449Z] 16:49:18 INFO - #12 pc 00067b69 /system/lib/libandroid_runtime.so (android::NativeMessageQueue::pollOnce(_JNIEnv*, int)+22) [task 2018-05-12T16:49:18.450Z] 16:49:18 INFO - #13 pc 0001dc4c /system/lib/libdvm.so (dvmPlatformInvoke+112) [task 2018-05-12T16:49:18.451Z] 16:49:18 INFO - #14 pc 0004dcab /system/lib/libdvm.so (dvmCallJNIMethod(unsigned int const*, JValue*, Method const*, Thread*)+394) [task 2018-05-12T16:49:18.455Z] 16:49:18 INFO - #15 pc 000385e1 /system/lib/libdvm.so (dvmCheckCallJNIMethod(unsigned int const*, JValue*, Method const*, Thread*)+8) [task 2018-05-12T16:49:18.456Z] 16:49:18 INFO - #16 pc 00000214 /dev/ashmem/dalvik-jit-code-cache (deleted) [task 2018-05-12T16:49:18.456Z] 16:49:18 INFO - at android.os.MessageQueue.nativePollOnce(Native Method) [task 2018-05-12T16:49:18.457Z] 16:49:18 INFO - at android.os.MessageQueue.next(MessageQueue.java:132) [task 2018-05-12T16:49:18.457Z] 16:49:18 INFO - at android.os.Looper.loop(Looper.java:124) [task 2018-05-12T16:49:18.458Z] 16:49:18 INFO - at android.app.ActivityThread.main(ActivityThread.java:5103) [task 2018-05-12T16:49:18.458Z] 16:49:18 INFO - at java.lang.reflect.Method.invokeNative(Native Method) [task 2018-05-12T16:49:18.458Z] 16:49:18 INFO - at java.lang.reflect.Method.invoke(Method.java:525) [task 2018-05-12T16:49:18.459Z] 16:49:18 INFO - at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:737) [task 2018-05-12T16:49:18.459Z] 16:49:18 INFO - at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:553) [task 2018-05-12T16:49:18.459Z] 16:49:18 INFO - at dalvik.system.NativeStart.main(Native Method) [task 2018-05-12T16:49:18.459Z] 16:49:18 INFO - "GeckoIconTask" prio=5 tid=16 WAIT [task 2018-05-12T16:49:18.658Z] 16:49:18 INFO - "<no name>" sysTid=1011 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.660Z] 16:49:18 INFO - | state=S schedstat=( 4842843698 3158079639 4411 ) utm=415 stm=69 core=0 [task 2018-05-12T16:49:18.661Z] 16:49:18 INFO - "<no name>" sysTid=1039 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.662Z] 16:49:18 INFO - | state=S schedstat=( 214553055 437738173 70 ) utm=15 stm=6 core=0 [task 2018-05-12T16:49:18.664Z] 16:49:18 INFO - "<no name>" sysTid=1072 nice=1 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.665Z] 16:49:18 INFO - | state=S schedstat=( 544504569 1753839322 116 ) utm=47 stm=7 core=0 [task 2018-05-12T16:49:18.666Z] 16:49:18 INFO - "<no name>" sysTid=1073 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.668Z] 16:49:18 INFO - | state=S schedstat=( 3717783560 3395437028 1268 ) utm=328 stm=43 core=0 [task 2018-05-12T16:49:18.669Z] 16:49:18 INFO - "<no name>" sysTid=1074 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.670Z] 16:49:18 INFO - | state=S schedstat=( 462909153 1932930774 127 ) utm=36 stm=10 core=0 [task 2018-05-12T16:49:18.671Z] 16:49:18 INFO - "<no name>" sysTid=1075 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.673Z] 16:49:18 INFO - | state=S schedstat=( 382660674 1193695720 154 ) utm=30 stm=8 core=0 [task 2018-05-12T16:49:18.674Z] 16:49:18 INFO - "<no name>" sysTid=1105 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.675Z] 16:49:18 INFO - | state=S schedstat=( 132001326 258417703 51 ) utm=4 stm=9 core=0 [task 2018-05-12T16:49:18.676Z] 16:49:18 INFO - "<no name>" sysTid=1106 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.677Z] 16:49:18 INFO - | state=S schedstat=( 11856182 23623615 4 ) utm=1 stm=0 core=0 [task 2018-05-12T16:49:18.679Z] 16:49:18 INFO - "<no name>" sysTid=1126 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.680Z] 16:49:18 INFO - | state=S schedstat=( 5691988 17989182 4 ) utm=0 stm=0 core=0 [task 2018-05-12T16:49:18.681Z] 16:49:18 INFO - "<no name>" sysTid=4766 nice=0 sched=0/0 cgrp=apps [task 2018-05-12T16:49:18.683Z] 16:49:18 INFO - | state=S schedstat=( 98173932 192218870 44 ) utm=1 stm=8 core=0 [task 2018-05-12T16:49:18.684Z] 16:49:18 INFO - ----- end 818 ----- [task 2018-05-12T16:49:18.991Z] 16:49:18 INFO - /data/tombstones does not exist; tombstone check skipped [task 2018-05-12T16:49:21.366Z] 16:49:21 INFO - mozcrash Copy/paste: /usr/local/bin/linux64-minidump_stackwalk /tmp/tmp7AG0FS/65170640-b45f-74c1-9a4d-20777847db33.dmp /builds/worker/workspace/build/symbols [task 2018-05-12T16:49:56.718Z] 16:49:56 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/65170640-b45f-74c1-9a4d-20777847db33.dmp [task 2018-05-12T16:49:56.720Z] 16:49:56 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/65170640-b45f-74c1-9a4d-20777847db33.extra [task 2018-05-12T16:49:56.728Z] 16:49:56 WARNING - PROCESS-CRASH | dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement17.html | application crashed [@ libc.so + 0x1c3dc] [task 2018-05-12T16:49:56.729Z] 16:49:56 INFO - Crash dump filename: /tmp/tmp7AG0FS/65170640-b45f-74c1-9a4d-20777847db33.dmp [task 2018-05-12T16:49:56.730Z] 16:49:56 INFO - Operating system: Android [task 2018-05-12T16:49:56.733Z] 16:49:56 INFO - 0.0.0 Linux 2.6.29-gea477bb #1 Wed Sep 26 11:04:45 PDT 2012 armv7l [task 2018-05-12T16:49:56.733Z] 16:49:56 INFO - CPU: arm [task 2018-05-12T16:49:56.734Z] 16:49:56 INFO - ARMv7 ARM Cortex-A8 features: swp,half,thumb,fastmult,vfpv2,edsp,neon,vfpv3 [task 2018-05-12T16:49:56.735Z] 16:49:56 INFO - 1 CPU [task 2018-05-12T16:49:56.736Z] 16:49:56 INFO - GPU: UNKNOWN [task 2018-05-12T16:49:56.737Z] 16:49:56 INFO - Crash reason: SIGABRT [task 2018-05-12T16:49:56.739Z] 16:49:56 INFO - Crash address: 0x12d2 [task 2018-05-12T16:49:56.740Z] 16:49:56 INFO - Process uptime: not available [task 2018-05-12T16:49:56.741Z] 16:49:56 INFO - Thread 0 (crashed) [task 2018-05-12T16:49:56.743Z] 16:49:56 INFO - 0 libc.so + 0x1c3dc [task 2018-05-12T16:49:56.745Z] 16:49:56 INFO - r0 = 0xfffffffc r1 = 0xbe9564a8 r2 = 0x00000010 r3 = 0xffffffff [task 2018-05-12T16:49:56.746Z] 16:49:56 INFO - r4 = 0x2a047d00 r5 = 0x00000000 r6 = 0x2a047d14 r7 = 0x000000fc [task 2018-05-12T16:49:56.747Z] 16:49:56 INFO - r8 = 0x2a047d48 r9 = 0x00000014 r10 = 0x2a00d0a0 r12 = 0xbe9564a8 [task 2018-05-12T16:49:56.748Z] 16:49:56 INFO - fp = 0xbe95661c sp = 0xbe956488 lr = 0x400b1fb5 pc = 0x400433dc [task 2018-05-12T16:49:56.750Z] 16:49:56 INFO - Found by: given as instruction pointer in context [task 2018-05-12T16:49:56.751Z] 16:49:56 INFO - 1 libbinder.so + 0x1bc2d [task 2018-05-12T16:49:56.754Z] 16:49:56 INFO - sp = 0xbe9564d8 pc = 0x400f7c2f [task 2018-05-12T16:49:56.755Z] 16:49:56 INFO - Found by: stack scanning [task 2018-05-12T16:49:56.756Z] 16:49:56 INFO - 2 libbinder.so + 0x18603 [task 2018-05-12T16:49:56.758Z] 16:49:56 INFO - sp = 0xbe9564f8 pc = 0x400f4605 [task 2018-05-12T16:49:56.759Z] 16:49:56 INFO - Found by: stack scanning [task 2018-05-12T16:49:56.761Z] 16:49:56 INFO - 3 libbinder.so + 0x2032d [task 2018-05-12T16:49:56.762Z] 16:49:56 INFO - sp = 0xbe956500 pc = 0x400fc32f [task 2018-05-12T16:49:56.764Z] 16:49:56 INFO - Found by: stack scanning [task 2018-05-12T16:49:56.765Z] 16:49:56 INFO - 4 libc.so + 0x109e9 [task 2018-05-12T16:49:56.767Z] 16:49:56 INFO - sp = 0xbe956518 pc = 0x400379eb [task 2018-05-12T16:49:56.768Z] 16:49:56 INFO - Found by: stack scanning [task 2018-05-12T16:49:56.770Z] 16:49:56 INFO - 5 libc.so + 0xd9bf [task 2018-05-12T16:49:56.771Z] 16:49:56 INFO - sp = 0xbe956530 pc = 0x400349c1 [task 2018-05-12T16:49:56.773Z] 16:49:56 INFO - Found by: stack scanning [task 2018-05-12T16:49:56.774Z] 16:49:56 INFO - 6 libbinder.so + 0x1e561 [task 2018-05-12T16:49:56.776Z] 16:49:56 INFO - sp = 0xbe956538 pc = 0x400fa563 [task 2018-05-12T16:49:56.777Z] 16:49:56 INFO - Found by: stack scanning [task 2018-05-12T16:49:56.779Z] 16:49:56 INFO - 7 libbinder.so + 0x1e5cf [task 2018-05-12T16:49:56.780Z] 16:49:56 INFO - sp = 0xbe956550 pc = 0x400fa5d1 [task 2018-05-12T16:49:56.781Z] 16:49:56 INFO - Found by: stack scanning
Summary: Intermittent dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement17.html | application crashed [@ libc.so + 0x1c3dc] → Intermittent dom/tests/mochitest/dom-level2-html/test_HTMLObjectElement17.html | application ran for longer than allowed maximum time
You need to log in before you can comment on or make changes to this bug.