Closed Bug 1944575 Opened 25 days ago Closed 25 days ago

Intermittent TV dom/media/webrtc/tests/mochitests/test_peerConnection_simulcastOffer.html | application timed out after 370 seconds with no output

Categories

(Core :: WebRTC: Audio/Video, defect, P5)

defect

Tracking

()

RESOLVED DUPLICATE of bug 1861710
Tracking Status
firefox-esr128 --- unaffected
firefox134 --- unaffected
firefox135 --- unaffected
firefox136 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, regression, test-verify-fail)

Filed by: amarc [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=492304579&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/OuanQSCgTLuSzJJ45FpdIw/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/OuanQSCgTLuSzJJ45FpdIw/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1


[task 2025-01-29T13:39:10.128Z] 13:39:10     INFO -  TEST-START | dom/media/webrtc/tests/mochitests/test_peerConnection_simulcastOffer.html
[task 2025-01-29T13:45:43.086Z] 13:45:43     INFO -  wait for org.mozilla.geckoview.test_runner complete; top activity=org.mozilla.geckoview.test_runner
[task 2025-01-29T13:45:43.086Z] 13:45:43     INFO -  org.mozilla.geckoview.test_runner unexpectedly found running. Killing...
[task 2025-01-29T13:45:56.285Z] 13:45:56  WARNING -  TEST-UNEXPECTED-FAIL | dom/media/webrtc/tests/mochitests/test_peerConnection_simulcastOffer.html | application timed out after 370 seconds with no output
[task 2025-01-29T13:45:56.285Z] 13:45:56     INFO -  runtestsremote.py | Application ran for: 0:06:51.678728
[task 2025-01-29T13:45:56.361Z] 13:45:56     INFO -  mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/bqYPVCxKSb25ZLbTAdsOVw/artifacts/public/build/target.crashreporter-symbols.zip
[task 2025-01-29T13:46:16.016Z] 13:46:16     INFO -  mozcrash Copy/paste: /builds/worker/fetches/minidump-stackwalk/minidump-stackwalk --symbols-url=https://symbols.mozilla.org/ --cyborg=/tmp/tmpat1r5kgr/6fcbc5fd-58cc-acbd-134a-931f3806980f.trace /tmp/tmplgc1up5a/6fcbc5fd-58cc-acbd-134a-931f3806980f.dmp /tmp/tmpcgrtkcnh
[task 2025-01-29T13:46:21.004Z] 13:46:21     INFO -  mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/6fcbc5fd-58cc-acbd-134a-931f3806980f.dmp
[task 2025-01-29T13:46:21.004Z] 13:46:21     INFO -  mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/6fcbc5fd-58cc-acbd-134a-931f3806980f.extra
[task 2025-01-29T13:46:21.006Z] 13:46:21  WARNING -  PROCESS-CRASH | application crashed [@ libc.so + 0x000000000008c66a] | dom/media/webrtc/tests/mochitests/mochitest_peerconnection.toml
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  Process type: main
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  Process pid: 3526
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  Crash dump filename: /tmp/tmplgc1up5a/6fcbc5fd-58cc-acbd-134a-931f3806980f.dmp
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  Operating system: Android
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -                    0.0.0 Linux 3.10.0+ #260 SMP PREEMPT Fri May 19 12:48:14 PDT 2017 x86_64
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  CPU: amd64
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -       family 6 model 6 stepping 3
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -       4 CPUs
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  Crash reason:  SIGABRT
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  Crash address: 0x00000000000010ca
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  Crashing instruction: `cmp rax, -0xfff`
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  No memory accessed by instruction
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  No instruction pointer update by instruction
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -  Crashing address may be the result of a flipped bit:
[task 2025-01-29T13:46:21.006Z] 13:46:21     INFO -    0. Valid address: 0x00000000200010ca (0.250)
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -    1. Valid address: 0x00000000400010ca (0.250)
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -  Process uptime: not available
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -  Linux memory map count: 1562
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -  Thread 0 AndroidUI (crashed) - tid: 3526
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -   0  libc.so + 0x8c66a
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -       rax = 0xfffffffffffffffc    rdx = 0x0000000000000010
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -       rcx = 0xffffffffffffffff    rbx = 0x00000000ffffffff
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -       rsi = 0x00007fff330ec1b0    rdi = 0x000000000000001f
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -       rbp = 0x00000000ffffffff    rsp = 0x00007fff330ec138
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -        r8 = 0x0000000000000000     r9 = 0x0000000000000008
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -       r10 = 0x00000000ffffffff    r11 = 0x0000000000000246
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -       r12 = 0x00000000ffffffff    r13 = 0x000075816fb29e60
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -       r14 = 0x0000000000000000    r15 = 0x0000000000000000
[task 2025-01-29T13:46:21.007Z] 13:46:21     INFO -       rip = 0x0000758172a4366a
[task 2025-01-29T13:46:21.008Z] 13:46:21     INFO -      Found by: given as instruction pointer in context
[task 2025-01-29T13:46:21.008Z] 13:46:21     INFO -   1  libc.so + 0x2a0e5
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec140    rip = 0x00007581729e10e6
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -   2  libutils.so + 0x184e6
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec160    rip = 0x00007581732294e7
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -   3  libart.so + 0x14cd90
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec170    rip = 0x000075816f458d91
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -   4  dalvik-LinearAlloc (deleted) + 0x15967
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec190    rip = 0x000075816e205968
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -   5  boot-framework.oat + 0xfff
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec198    rip = 0x0000000071745000
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -   6  dalvik-main space (deleted) + 0x331df
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec1b0    rip = 0x0000000012c331e0
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -   7  base.odex + 0x348007
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec200    rip = 0x0000758156578008
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -   8  base.odex + 0x347ff3
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec208    rip = 0x0000758156577ff4
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -   9  libart.so + 0x14cd90
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec210    rip = 0x000075816f458d91
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -  10  libart.so + 0x39c37e
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec250    rip = 0x000075816f6a837f
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -  11  libart.so + 0x6e3c3f
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec258    rip = 0x000075816f9efc40
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -  12  libutils.so + 0x1837a
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec2b0    rip = 0x000075817322937b
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -  13  system@framework@boot-framework.art + 0x3f5b0f
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -       rsp = 0x00007fff330ec2d8    rip = 0x000000006fe86b10
[task 2025-01-29T13:46:21.009Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.010Z] 13:46:21     INFO -  14  dalvik-main space (deleted) + 0x95d7
[task 2025-01-29T13:46:21.010Z] 13:46:21     INFO -       rsp = 0x00007fff330ec2e0    rip = 0x0000000012c095d8
[task 2025-01-29T13:46:21.010Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.010Z] 13:46:21     INFO -  15  libandroid_runtime.so + 0xff855
[task 2025-01-29T13:46:21.010Z] 13:46:21     INFO -       rsp = 0x00007fff330ec2f0    rip = 0x00007581736aa856
[task 2025-01-29T13:46:21.010Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.010Z] 13:46:21     INFO -  16  system@framework@boot-framework.art + 0x3f5b0f
[task 2025-01-29T13:46:21.010Z] 13:46:21     INFO -       rsp = 0x00007fff330ec2f8    rip = 0x000000006fe86b10
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -  17  boot-framework.oat + 0x1e1721f
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -       rsp = 0x00007fff330ec310    rip = 0x000000007355b220
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -  18  system@framework@boot-framework.art + 0x3f5b0f
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -       rsp = 0x00007fff330ec328    rip = 0x000000006fe86b10
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -  19  dalvik-main space (deleted) + 0x95d7
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -       rsp = 0x00007fff330ec330    rip = 0x0000000012c095d8
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -      Found by: stack scanning
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -  20  system@framework@boot-framework.art + 0x3f578f
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -       rsp = 0x00007fff330ec338    rip = 0x000000006fe86790
[task 2025-01-29T13:46:21.016Z] 13:46:21     INFO -      Found by: stack scanning
<...>
[task 2025-01-29T13:46:22.058Z] 13:46:22     INFO -  SUITE-START | Running 1 tests
[task 2025-01-29T13:46:22.058Z] 13:46:22     INFO -  :::
[task 2025-01-29T13:46:22.058Z] 13:46:22     INFO -  ::: Test verification summary for:
[task 2025-01-29T13:46:22.058Z] 13:46:22     INFO -  :::
[task 2025-01-29T13:46:22.058Z] 13:46:22     INFO -  ::: dom/media/webrtc/tests/mochitests/test_peerConnection_simulcastOffer.html
[task 2025-01-29T13:46:22.058Z] 13:46:22     INFO -  :::
[task 2025-01-29T13:46:22.058Z] 13:46:22     INFO -  ::: 1. Run each test 10 times in one browser. : FAIL
[task 2025-01-29T13:46:22.059Z] 13:46:22     INFO -  ::: 2. Run each test 5 times in a new browser each time. : not run / incomplete
[task 2025-01-29T13:46:22.059Z] 13:46:22     INFO -  ::: 3. Run each test 10 times in one browser, in chaos mode. : not run / incomplete
[task 2025-01-29T13:46:22.059Z] 13:46:22     INFO -  ::: 4. Run each test 5 times in a new browser each time, in chaos mode. : not run / incomplete
[task 2025-01-29T13:46:22.059Z] 13:46:22     INFO -  :::
[task 2025-01-29T13:46:22.059Z] 13:46:22     INFO -  ::: Test verification FAILED!
[task 2025-01-29T13:46:22.059Z] 13:46:22     INFO -  :::
[task 2025-01-29T13:46:22.059Z] 13:46:22     INFO -  Buffered messages finished
[task 2025-01-29T13:46:22.059Z] 13:46:22     INFO -  SUITE-END | took 0s
[task 2025-01-29T13:46:22.082Z] 13:46:22     INFO - Return code: 0
[task 2025-01-29T13:46:22.082Z] 13:46:22    ERROR - No tests run or test summary not found
[task 2025-01-29T13:46:22.082Z] 13:46:22     INFO - TinderboxPrint: mochitest-media<br/><em class="testfail">T-FAIL</em>
[task 2025-01-29T13:46:22.082Z] 13:46:22     INFO - ##### mochitest-media log ends
[task 2025-01-29T13:46:22.082Z] 13:46:22  WARNING - setting return code to 1
[task 2025-01-29T13:46:22.082Z] 13:46:22  WARNING - TinderboxPrint: Per-test run of .../test_peerConnection_simulcastOffer.html<br/>: WARNING
[task 2025-01-29T13:46:22.083Z] 13:46:22     INFO - Running post-action listener: _package_coverage_data
[task 2025-01-29T13:46:22.083Z] 13:46:22     INFO - Running post-action listener: _resource_record_post_action
[task 2025-01-29T13:46:22.083Z] 13:46:22     INFO - Running post-action listener: process_java_coverage_data
[task 2025-01-29T13:46:22.083Z] 13:46:22     INFO - Running post-action listener: stop_device
[task 2025-01-29T13:46:22.315Z] 13:46:22     INFO - /data/anr/traces.txt deleted
[task 2025-01-29T13:46:22.467Z] 13:46:22     INFO - Killing logcat pid 1346.
[task 2025-01-29T13:46:22.467Z] 13:46:22     INFO - Killing every process called qemu-system-x86_64
[task 2025-01-29T13:46:22.474Z] 13:46:22     INFO - [mozharness: 2025-01-29 13:46:22.473831Z] Finished run-tests step (success)
[task 2025-01-29T13:46:22.474Z] 13:46:22     INFO - Running post-run listener: _resource_record_post_run
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - Total resource usage - Wall time: 484s; CPU: 5%; Read bytes: 0; Write bytes: 579858432; Read time: 0; Write time: 480928
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - TinderboxPrint: CPU usage<br/>5.2%
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - TinderboxPrint: I/O read bytes / time<br/>0 / 0
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - TinderboxPrint: I/O write bytes / time<br/>579,858,432 / 480,928
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - TinderboxPrint: CPU guest<br/>98.0 (2.5%)
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - TinderboxPrint: CPU idle<br/>3,671.2 (92.2%)
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - TinderboxPrint: CPU system<br/>61.8 (1.6%)
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - TinderboxPrint: CPU user<br/>145.7 (3.7%)
[task 2025-01-29T13:46:22.670Z] 13:46:22     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2025-01-29T13:46:22.671Z] 13:46:22     INFO - start-emulator - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2025-01-29T13:46:22.674Z] 13:46:22     INFO - verify-device - Wall time: 30s; CPU: 28%; Read bytes: 0; Write bytes: 53321728; Read time: 0; Write time: 23128
[task 2025-01-29T13:46:22.676Z] 13:46:22     INFO - install - Wall time: 12s; CPU: 34%; Read bytes: 0; Write bytes: 406884352; Read time: 0; Write time: 384452
[task 2025-01-29T13:46:22.713Z] 13:46:22     INFO - run-tests - Wall time: 441s; CPU: 3%; Read bytes: 0; Write bytes: 119635968; Read time: 0; Write time: 73344
[task 2025-01-29T13:46:23.698Z] 13:46:23  WARNING - returning nonzero exit status 1
[task 2025-01-29T13:46:23.796Z] cleanup
[task 2025-01-29T13:46:23.796Z] + cleanup
[task 2025-01-29T13:46:23.796Z] + local rv=1
[task 2025-01-29T13:46:23.796Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2025-01-29T13:46:23.796Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2025-01-29T13:46:23.798Z] + false
[task 2025-01-29T13:46:23.798Z] + '[' ']'
[task 2025-01-29T13:46:23.798Z] + true
[task 2025-01-29T13:46:23.798Z] + cleanup_xvfb
[task 2025-01-29T13:46:23.798Z] ++ pidof Xvfb
[task 2025-01-29T13:46:23.801Z] + local xvfb_pid=58
[task 2025-01-29T13:46:23.801Z] + local vnc=false
[task 2025-01-29T13:46:23.801Z] + local interactive=false
[task 2025-01-29T13:46:23.801Z] + '[' -n 58 ']'
[task 2025-01-29T13:46:23.801Z] + [[ false == false ]]
[task 2025-01-29T13:46:23.801Z] + [[ false == false ]]
[task 2025-01-29T13:46:23.801Z] + kill 58
[task 2025-01-29T13:46:23.801Z] + exit 1
[taskcluster 2025-01-29 13:46:24.415Z] === Task Finished ===
[taskcluster 2025-01-29 13:46:26.775Z] Unsuccessful task run with exit code: 1 completed in 632.623 seconds

Keywords: regression
Regressed by: 1934347

:pehrsons, since you are the author of the regressor, bug 1934347, could you take a look?

For more information, please visit BugBot documentation.

Flags: needinfo?(apehrson)

Set release status flags based on info from the regressing bug 1934347

Depends on: 1944812
Status: NEW → RESOLVED
Closed: 25 days ago
Duplicate of bug: 1861710
Flags: needinfo?(apehrson)
Resolution: --- → DUPLICATE
No longer regressed by: 1934347
You need to log in before you can comment on or make changes to this bug.