FFOS2.0 baseline BuildID: 20140916000205 DEFECT DESCRIPTION: MS crashed when play RTSP video REPRODUCING PROCEDURES: 1.Open broswer and go to :http://60.12.220.48/stream.html; 2.RTSP test->rtsp test for interaction->select 'long1.mp4/long2.mp4' to play; 3.After several minutes,ms crashed and restart.->KO EXPECTED BEHAVIOUR: MS can play this video normally without crash. ASSOCIATE SPECIFICATION: TEST PLAN REFERENCE: TOOLS AND PLATFORMS USED: USER IMPACT: REPRODUCING RATE:5/5 For FT PR, Please list reference mobile's behavior:

Ben, any ideas?

(In reply to sync-1 from comment #0) > FFOS2.0 baseline BuildID: 20140916000205 This build is pretty old. We resolved several critical crash issues of RTSP streaming in the past few months. Perhaps the issue you encountered is already fixed. Could you try to reproduce this bug using the latest build?

See bug 1088538, looks like the same crash.

(In reply to Benjamin Chen [:bechen] from comment #5) > See bug 1088538, looks like the same crash. It's a good news. There is a related log: I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:440) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): RtspConnectionHandler::kWhatAccessUnit: trackIndex:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:667) void android::RTSPSource::onTrackDataAvailable(size_t): I/Module ( 1689): RTSPSource::onTrackDataAvailable(size_t trackIndex) err:0, isAudio:1, info->mNPTMappingValid:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:440) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): RtspConnectionHandler::kWhatAccessUnit: trackIndex:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:667) void android::RTSPSource::onTrackDataAvailable(size_t): I/Module ( 1689): RTSPSource::onTrackDataAvailable(size_t trackIndex) err:0, isAudio:1, info->mNPTMappingValid:1 V/audio_hw_primary( 1700): out_write: writing buffer (3840 bytes) to pcm device I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:440) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): RtspConnectionHandler::kWhatAccessUnit: trackIndex:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:667) void android::RTSPSource::onTrackDataAvailable(size_t): I/Module ( 1689): RTSPSource::onTrackDataAvailable(size_t trackIndex) err:0, isAudio:1, info->mNPTMappingValid:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:440) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): RtspConnectionHandler::kWhatAccessUnit: trackIndex:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:667) void android::RTSPSource::onTrackDataAvailable(size_t): I/Module ( 1689): RTSPSource::onTrackDataAvailable(size_t trackIndex) err:0, isAudio:1, info->mNPTMappingValid:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:440) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): RtspConnectionHandler::kWhatAccessUnit: trackIndex:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:667) void android::RTSPSource::onTrackDataAvailable(size_t): I/Module ( 1689): RTSPSource::onTrackDataAvailable(size_t trackIndex) err:0, isAudio:1, info->mNPTMappingValid:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:440) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): RtspConnectionHandler::kWhatAccessUnit: trackIndex:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:667) void android::RTSPSource::onTrackDataAvailable(size_t): I/Module ( 1689): RTSPSource::onTrackDataAvailable(size_t trackIndex) err:0, isAudio:1, info->mNPTMappingValid:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:440) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): RtspConnectionHandler::kWhatAccessUnit: trackIndex:1 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:667) void android::RTSPSource::onTrackDataAvailable(size_t): I/Module ( 1689): RTSPSource::onTrackDataAvailable(size_t trackIndex) err:0, isAudio:1, info->mNPTMappingValid:1 I/Gecko ( 1689): <TZM_LOG> -*- JrdExtension -*-: getSysInfo: "BATTERY_TEMP" I/Gecko ( 1689): <TZM_LOG> -*- jrd_service.jsm -*-: receiveMessage: JrdSrv:Common I/Gecko ( 1689): <TZM_LOG> -*- jrd_service.jsm -*-: _readSysFile entry. V/audio_hw_primary( 1700): out_write: writing buffer (3840 bytes) to pcm device I/Gecko ( 1689): <TZM_LOG> -*- jrd_service.jsm -*-: _readSysFile:success I/Gecko ( 1689): <TZM_LOG> -*- JrdExtension -*-: receiveMessage: {"target":{},"name":"JrdSrv:Common:Return","sync":false,"json":{"data":{"result":"OK","data":"252\n"},"requestID":"id{e52b292e-7730-4bd8-8795-ba06c8d817c4}"},"data":{"data":{"result":"OK","data":"252\n"},"requestID":"id{e52b292e-7730-4bd8-8795-ba06c8d817c4}"},"objects":{}} I/Gecko ( 1689): <TZM_LOG> -*- JrdExtension -*-: Success: {"data":{"result":"OK","data":"252\n"},"requestID":"id{e52b292e-7730-4bd8-8795-ba06c8d817c4}"} V/audio_hw_primary( 1700): out_write: writing buffer (3840 bytes) to pcm device I/GeckoDump( 1689): battery temperatur 25.2 level 2 I/Gecko ( 1689): <TZM_LOG> -*- JrdExtension -*-: receiveMessage: {"target":{},"name":"JrdSrv:Common:Return","sync":false,"json":{"data":{"result":"OK","data":"252\n"},"requestID":"id{e52b292e-7730-4bd8-8795-ba06c8d817c4}"},"data":{"data":{"result":"OK","data":"252\n"},"requestID":"id{e52b292e-7730-4bd8-8795-ba06c8d817c4}"},"objects":{}} I/Gecko ( 1689): <TZM_LOG> -*- JrdExtension -*-: Success: Can not find the request object with id{e52b292e-7730-4bd8-8795-ba06c8d817c4} I/Gecko ( 1689): -------------- WifiCommand: wifi gecko: terminate = falseSIGNAL_POLL D/wpa_supplicant( 1854): RX ctrl_iface - hexdump(len=11): 53 49 47 4e 41 4c 5f 50 4f 4c 4c D/wpa_supplicant( 1854): wlan0: Control interface command 'SIGNAL_POLL' D/wpa_supplicant( 1854): nl80211: survey data missing! I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() V/audio_hw_primary( 1700): out_write: writing buffer (3840 bytes) to pcm device E/ ( 1700): not in avi mode V/audio_hw_primary( 1700): out_write: writing buffer (3840 bytes) to pcm device I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() V/audio_hw_primary( 1700): out_write: writing buffer (3840 bytes) to pcm device V/audio_hw_primary( 1700): out_write: writing buffer (3840 bytes) to pcm device I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:403) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): dropping damaged access unit. I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:440) void android::RTSPSource::onMessageReceived(const android::sp<android::AMessage>&): I/Module ( 1689): RtspConnectionHandler::kWhatAccessUnit: trackIndex:2 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:667) void android::RTSPSource::onTrackDataAvailable(size_t): I/Module ( 1689): RTSPSource::onTrackDataAvailable(size_t trackIndex) err:-1011, isAudio:0, info->mNPTMappingValid:1 I/Gecko ( 1689): [Parent 1689] ###!!! ABORT: file ../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp, line 689 E/Gecko ( 1689): mozalloc_abort: [Parent 1689] ###!!! ABORT: file ../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp, line 689 I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() V/audio_hw_primary( 1700): out_write: writing buffer (3840 bytes) to pcm device I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play() I/Module ( 1689): :--(../../../../../../../../../gecko/netwerk/protocol/rtsp/rtsp/RTSPSource.cpp:106) void android::RTSPSource::play(): I/Module ( 1689): RTSPSource::play()

(In reply to ChengLin.Wu from comment #6) A small suggestion: Logs containing this much text should be added as attachments, rather than being put in comments.

(In reply to Jonathan Hao [:jhao] from comment #7) > (In reply to ChengLin.Wu from comment #6) > > A small suggestion: > Logs containing this much text should be added as attachments, rather than > being put in comments. OK, it's my mistake!

Can we close this out and then mark bug 1088538 blocking midori?

(In reply to Naoki Hirata :nhirata (please use needinfo instead of cc) from comment #9) > Can we close this out and then mark bug 1088538 blocking midori? Sure. But before we do that, I would like to make sure two things: 1. The root cause of this bug is exactly the same as bug 1088538. 2. Is there any new issue raised from this bug that we have not resolved yet? I indicate point 2. because I found something unusual while reproducing this bug: The playback would suddenly jump to the end-of-stream by playing the long-duration clip specified in the STR in comment 0. Please give us several days to clarify these two issues.

Meanwhile, could reporter provide feedback to comment 4?

I can reproduce this bug on the latest build of mozilla-b2g32_v2_0. Hence we could ignore my question in comment 4.

The GDB backtrace log while reproducing this bug on the latest 2.0 build.

The patch of bug 1088538 could avoid the crash problem in this bug. However, even if the crash is avoided, we still cannot play the whole video clip of long1.mp4. The playback would jump to end-of-stream at around 35 seconds from the beginning (which is exactly the crash point). And we don't know the root cause yet. More investigation is needed. But I'll request to uplift the patch of bug 1088538 to v2.0 first.

The patch from bug 1088538 had just landed in v2.0. https://bugzilla.mozilla.org/show_bug.cgi?id=1088538#c22 Ethan, Could you please update your testing result? Thanks!

(In reply to Beatriz Rodríguez [:brg] from comment #15) > The patch from bug 1088538 had just landed in v2.0. > https://bugzilla.mozilla.org/show_bug.cgi?id=1088538#c22 > > Ethan, Could you please update your testing result? Thanks! Hi Beatriz, I verified with the latest build of 2.0. The result is the same as I said in comment 14: It does not crash anymore, but the playback jumps to the end after playing 34~35 seconds. Since this bug was originally reported as crash problem, I suggest we set this bug as resolved fixed by bug 1088538, and file another bug to track the playback issue. By this way we can avoid confusion and also have record for the new issue. What do you think?

(In reply to Ethan Tseng [:ethan] from comment #16) > > What do you think? Agree! Thanks!

This crash issue is caused by the same root cause that we fixed in bug 1088538. Thus set it as duplicate of bug 1088538.

Bug 1151760 was filed for the record of the issue stated in comment 14.