Closed Bug 1544938 Opened 6 years ago Closed 3 years ago

Intermittent dom/media/test/test_videoPlaybackQuality_totalFrames.html | gizmo.mp4 totalFrames should match! - got 159, expected 166

Categories

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

Product:
Core
Component:
Audio/Video: Playback
Type:
defect

Tracking

()

Status:
RESOLVED WORKSFORME

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, regression)

#[markdown(off)]
Filed by: nerli [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=240721828&repo=autoland

https://queue.taskcluster.net/v1/task/cTQvNC9nQR-zQ5RE04CnlA/runs/0/artifacts/public/logs/live_backing.log

18:03:29 INFO - TEST-START | dom/media/test/test_videoPlaybackQuality_totalFrames.html
18:03:29 INFO - GECKO(1983) | ++DOMWINDOW == 33 (0x128dd4400) [pid = 1985] [serial = 1080] [outer = 0x120d3cd40]
18:03:29 INFO - GECKO(1983) | ++DOCSHELL 0x1294a9800 == 5 [pid = 1985] [id = {17310287-0671-bb42-9ecd-a61dbac296b3}]
18:03:29 INFO - GECKO(1983) | ++DOMWINDOW == 34 (0x11737e2e0) [pid = 1985] [serial = 1081] [outer = 0x0]
18:03:29 INFO - GECKO(1983) | ++DOMWINDOW == 35 (0x129114400) [pid = 1985] [serial = 1082] [outer = 0x11737e2e0]
18:03:30 INFO - GECKO(1983) | [Child 1985, Main Thread] WARNING: Wrong inner/outer window combination!: file /builds/worker/workspace/build/src/dom/base/Document.cpp, line 4609
18:03:30 INFO - GECKO(1983) | [Child 1985, Main Thread] WARNING: Wrong inner/outer window combination!: file /builds/worker/workspace/build/src/dom/base/Document.cpp, line 4609
18:03:30 INFO - GECKO(1983) | [Child 1985, Main Thread] WARNING: Wrong inner/outer window combination!: file /builds/worker/workspace/build/src/dom/base/Document.cpp, line 4609
18:03:30 INFO - GECKO(1983) | --DOMWINDOW == 34 (0x11737e100) [pid = 1985] [serial = 1061] [outer = 0x0] [url = about:blank]
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #2] WARNING: Invalid H264 frame @ pts:2800000 dur:33333 dts:2800000: file /builds/worker/workspace/build/src/dom/media/mp4/MP4Demuxer.cpp, line 456
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #4] WARNING: VideoToolbox decoder returned no data: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 279
18:03:34 INFO - GECKO(1983) | [18:03:34.115] vtDecompressionDuctDecodeSingleFrame signalled err=-8969 (err) (VTVideoDecoderDecodeFrame returned error) at /SourceCache/CoreMedia_frameworks/CoreMedia-1562.238/Sources/VideoToolbox/VTDecompressionSession.c line 3241
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #4] WARNING: Couldn't pass frame to decoder: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 185
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #2] WARNING: Invalid H264 frame @ pts:2833333 dur:33333 dts:2833333: file /builds/worker/workspace/build/src/dom/media/mp4/MP4Demuxer.cpp, line 456
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #1] WARNING: VideoToolbox decoder returned no data: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 279
18:03:34 INFO - GECKO(1983) | [18:03:34.116] vtDecompressionDuctDecodeSingleFrame signalled err=-8969 (err) (VTVideoDecoderDecodeFrame returned error) at /SourceCache/CoreMedia_frameworks/CoreMedia-1562.238/Sources/VideoToolbox/VTDecompressionSession.c line 3241
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #1] WARNING: Couldn't pass frame to decoder: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 185
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #2] WARNING: Invalid H264 frame @ pts:2866666 dur:33334 dts:2866666: file /builds/worker/workspace/build/src/dom/media/mp4/MP4Demuxer.cpp, line 456
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #4] WARNING: VideoToolbox decoder returned no data: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 279
18:03:34 INFO - GECKO(1983) | [18:03:34.117] vtDecompressionDuctDecodeSingleFrame signalled err=-8969 (err) (VTVideoDecoderDecodeFrame returned error) at /SourceCache/CoreMedia_frameworks/CoreMedia-1562.238/Sources/VideoToolbox/VTDecompressionSession.c line 3241
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #4] WARNING: Couldn't pass frame to decoder: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 185
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #2] WARNING: Invalid H264 frame @ pts:2900000 dur:33333 dts:2900000: file /builds/worker/workspace/build/src/dom/media/mp4/MP4Demuxer.cpp, line 456
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #1] WARNING: VideoToolbox decoder returned no data: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 279
18:03:34 INFO - GECKO(1983) | [18:03:34.117] vtDecompressionDuctDecodeSingleFrame signalled err=-8969 (err) (VTVideoDecoderDecodeFrame returned error) at /SourceCache/CoreMedia_frameworks/CoreMedia-1562.238/Sources/VideoToolbox/VTDecompressionSession.c line 3241
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #1] WARNING: Couldn't pass frame to decoder: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 185
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #2] WARNING: Invalid H264 frame @ pts:2933333 dur:33333 dts:2933333: file /builds/worker/workspace/build/src/dom/media/mp4/MP4Demuxer.cpp, line 456
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #4] WARNING: VideoToolbox decoder returned no data: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 279
18:03:34 INFO - GECKO(1983) | [18:03:34.118] vtDecompressionDuctDecodeSingleFrame signalled err=-8969 (err) (VTVideoDecoderDecodeFrame returned error) at /SourceCache/CoreMedia_frameworks/CoreMedia-1562.238/Sources/VideoToolbox/VTDecompressionSession.c line 3241
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #4] WARNING: Couldn't pass frame to decoder: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 185
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #2] WARNING: Invalid H264 frame @ pts:2966666 dur:33334 dts:2966666: file /builds/worker/workspace/build/src/dom/media/mp4/MP4Demuxer.cpp, line 456
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #1] WARNING: VideoToolbox decoder returned no data: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 279
18:03:34 INFO - GECKO(1983) | [18:03:34.118] vtDecompressionDuctDecodeSingleFrame signalled err=-8969 (err) (VTVideoDecoderDecodeFrame returned error) at /SourceCache/CoreMedia_frameworks/CoreMedia-1562.238/Sources/VideoToolbox/VTDecompressionSession.c line 3241
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #1] WARNING: Couldn't pass frame to decoder: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 185
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #2] WARNING: Invalid H264 frame @ pts:3000000 dur:33333 dts:3000000: file /builds/worker/workspace/build/src/dom/media/mp4/MP4Demuxer.cpp, line 456
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #4] WARNING: VideoToolbox decoder returned no data: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 279
18:03:34 INFO - GECKO(1983) | [18:03:34.119] vtDecompressionDuctDecodeSingleFrame signalled err=-8969 (err) (VTVideoDecoderDecodeFrame returned error) at /SourceCache/CoreMedia_frameworks/CoreMedia-1562.238/Sources/VideoToolbox/VTDecompressionSession.c line 3241
18:03:34 INFO - GECKO(1983) | [Child 1985, MediaPDecoder #4] WARNING: Couldn't pass frame to decoder: file /builds/worker/workspace/build/src/dom/media/platforms/apple/AppleVTDecoder.cpp, line 185
18:03:34 INFO - GECKO(1983) | --DOMWINDOW == 33 (0x127d9d800) [pid = 1985] [serial = 1069] [outer = 0x0] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:03:34 INFO - GECKO(1983) | --DOMWINDOW == 32 (0x127b68800) [pid = 1985] [serial = 1065] [outer = 0x0] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:03:34 INFO - GECKO(1983) | --DOMWINDOW == 31 (0x127b71000) [pid = 1985] [serial = 1067] [outer = 0x0] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:03:34 INFO - GECKO(1983) | --DOMWINDOW == 30 (0x127da5000) [pid = 1985] [serial = 1062] [outer = 0x0] [url = about:blank]
18:03:34 INFO - GECKO(1983) | --DOMWINDOW == 29 (0x127b63400) [pid = 1985] [serial = 1063] [outer = 0x0] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:03:37 INFO - TEST-INFO | started process screencapture
18:03:37 INFO - TEST-INFO | screencapture: exit 0
18:03:37 INFO - Buffered messages logged at 18:03:29
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | A valid string reason is expected
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | Reason cannot be empty
18:03:37 INFO - Buffered messages logged at 18:03:30
18:03:37 INFO - Started Tue Apr 16 2019 18:03:30 GMT+0000 (Greenwich Mean Time) (1555437810.009s)
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [started bipbop.mp4-0 t=0.013] Length of array should match number of running tests
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [started gizmo.mp4-1 t=0.018] Length of array should match number of running tests
18:03:37 INFO - Buffered messages finished
18:03:37 INFO - TEST-UNEXPECTED-FAIL | dom/media/test/test_videoPlaybackQuality_totalFrames.html | gizmo.mp4 totalFrames should match! - got 159, expected 166
18:03:37 INFO - SimpleTest.is@SimpleTest/SimpleTest.js:320:16
18:03:37 INFO - ended@dom/media/test/test_videoPlaybackQuality_totalFrames.html:23:5
18:03:37 INFO - EventListener.handleEvent*startTest@dom/media/test/test_videoPlaybackQuality_totalFrames.html:27:5
18:03:37 INFO - MediaTestManager/this.nextTest@dom/media/test/manifest.js:1834:12
18:03:37 INFO - MediaTestManager/this.runTests/<@dom/media/test/manifest.js:1754:12
18:03:37 INFO - [finished gizmo.mp4-1] remaining= bipbop.mp4-0
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [finished gizmo.mp4-1 t=7.534] Length of array should match number of running tests
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [started seek-short.webm-2 t=7.536] Length of array should match number of running tests
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | seek-short.webm totalFrames should match!
18:03:37 INFO - [finished seek-short.webm-2] remaining= bipbop.mp4-0
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [finished seek-short.webm-2 t=7.879] Length of array should match number of running tests
18:03:37 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [started seek.webm-3 t=7.881] Length of array should match number of running tests
18:03:38 INFO - GECKO(1983) | [Child 1985, Main Thread] WARNING: Wrong inner/outer window combination!: file /builds/worker/workspace/build/src/dom/base/Document.cpp, line 4609
18:03:38 INFO - GECKO(1983) | --DOMWINDOW == 28 (0x1173dda60) [pid = 1985] [serial = 1071] [outer = 0x0] [url = about:blank]
18:03:41 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | bipbop.mp4 totalFrames should match!
18:03:41 INFO - [finished bipbop.mp4-0] remaining= seek.webm-3
18:03:41 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [finished bipbop.mp4-0 t=11.235] Length of array should match number of running tests
18:03:41 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [started 320x240.ogv-4 t=11.237] Length of array should match number of running tests
18:03:41 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | 320x240.ogv totalFrames should match!
18:03:41 INFO - [finished 320x240.ogv-4] remaining= seek.webm-3
18:03:41 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [finished 320x240.ogv-4 t=11.491] Length of array should match number of running tests
18:03:41 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [started av1.mp4-5 t=11.492] Length of array should match number of running tests
18:03:42 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | seek.webm totalFrames should match!
18:03:42 INFO - [finished seek.webm-3] remaining= av1.mp4-5
18:03:42 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [finished seek.webm-3 t=12.121] Length of array should match number of running tests
18:03:42 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | av1.mp4 totalFrames should match!
18:03:42 INFO - [finished av1.mp4-5] remaining=
18:03:42 INFO - TEST-PASS | dom/media/test/test_videoPlaybackQuality_totalFrames.html | [finished av1.mp4-5 t=12.525] Length of array should match number of running tests
18:03:42 INFO - GECKO(1983) | --DOMWINDOW == 27 (0x127da1c00) [pid = 1985] [serial = 1073] [outer = 0x0] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:03:42 INFO - GECKO(1983) | --DOMWINDOW == 26 (0x127da0400) [pid = 1985] [serial = 1072] [outer = 0x0] [url = about:blank]
18:03:42 INFO - GECKO(1983) | --DOMWINDOW == 25 (0x129117800) [pid = 1985] [serial = 1079] [outer = 0x0] [url = http://mochi.test:8888/tests/SimpleTest/iframe-between-tests.html]
18:03:42 INFO - GECKO(1983) | --DOMWINDOW == 24 (0x127da3400) [pid = 1985] [serial = 1076] [outer = 0x0] [url = about:blank]
18:03:42 INFO - GECKO(1983) | --DOCSHELL 0x128199000 == 4 [pid = 1985] [id = {1cb2281f-f6ec-7542-a09c-ebae59013233}] [url = http://mochi.test:8888/tests/dom/media/test/bug461281.ogg]
18:03:42 INFO - GECKO(1983) | --DOCSHELL 0x11861f800 == 3 [pid = 1985] [id = {93e551eb-bb7b-f14a-9337-bc1759c07cbc}] [url = about:blank]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 23 (0x117439100) [pid = 1985] [serial = 1075] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/bug461281.ogg]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 22 (0x127b64800) [pid = 1985] [serial = 1064] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/test_trackelementevent.html]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 21 (0x1281ea400) [pid = 1985] [serial = 1060] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/test_timeupdate_small_files.html]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 20 (0x127d9e400) [pid = 1985] [serial = 1070] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/test_unseekable.html]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 19 (0x127ba6400) [pid = 1985] [serial = 1074] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/test_videoDocumentTitle.html]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 18 (0x127b6fc00) [pid = 1985] [serial = 1068] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/test_trackevent.html]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 17 (0x127b69800) [pid = 1985] [serial = 1066] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/test_trackelementsrc.html]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 16 (0x127b71400) [pid = 1985] [serial = 1077] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/320x240.ogv]
18:03:43 INFO - GECKO(1983) | --DOMWINDOW == 15 (0x127ba6800) [pid = 1985] [serial = 1078] [outer = 0x0] [url = http://mochi.test:8888/tests/dom/media/test/bug461281.ogg]
18:03:43 INFO - Finished at Tue Apr 16 2019 18:03:43 GMT+0000 (Greenwich Mean Time) (1555437823.426s)
18:03:43 INFO - Running time: 13.418s
18:03:43 INFO - GECKO(1983) | MEMORY STAT | vsize 5092MB | residentFast 183MB | heapAllocated 29MB
18:03:43 INFO - TEST-OK | dom/media/test/test_videoPlaybackQuality_totalFrames.html | took 13611ms
18:03:43 INFO - GECKO(1983) | ++DOMWINDOW == 16 (0x127b63800) [pid = 1985] [serial = 1083] [outer = 0x120d3cd40]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE

:drno - this test appears to be consistently failing on macosx1014. The aim is to move most of the macosx machines to 1014 in the near future, and this is blocking migration of the mochitest-media suite. Would you be able to take a look at this test, or accept the test being turned off?

Flags: needinfo?(drno)
Status: REOPENED → RESOLVED
Closed: 5 years ago → 3 years ago
Resolution: --- → WORKSFORME

Declaring NI bankruptcy.

Flags: needinfo?(drno)
You need to log in before you can comment on or make changes to this bug.