[sip-comm-dev] A heavy crash of SC !!


#1

All,

after updating my SC to the latest revision (both on my Linux and
my Windows XP) I experienced a "real crash" of SC on the Windows XP
system. For console output see below.

Another note: without changing my logging properties I now see additonal
log messages "Drop first packet!" - what does this mean? Which part of the
source produces this?

The root cause of Java VM crash is usually (99%) an error in a native
library. When I developed native libs for security algorithms I experienced
similar problems: using wrong pointers, overwriting arrays in the C code.

Also I see major differences in parts of the JMF code (for example logging
printouts) between Linux and Windows/Mac implementations. Here the class
"BasicTrackControl" as an example.

Best regards,
Werner

And not the long awaited console printout :slight_smile: :

$ ant run
Buildfile: build.xml

-deploy-os-specific-bundles:
     [copy] Copying 1 file to d:\devhome\ws\workspace\sip-communicator\sc-bundle
s

run:
     [java]
     [java] Welcome to Felix.
     [java] =================
     [java]
     [java] IOException in readRegistry: java.io.EOFException
     [java] 09:49:48.524 WARNUNG: impl.resources.ResourceManagementServiceImpl.g
etI18NString().442 Missing resource for key: impl.media.security.TOGGLE_ON_SECUR
ITY
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] Drop first packet!
     [java] 09:50:15.382 SCHWERWIEGEND: impl.protocol.sip.OperationSetBasicTelep
honySipImpl.processResponse().741 Received error: 404 Not Found
     [java] 09:50:15.573 WARNUNG: impl.media.CallSessionImpl.callStateChanged().
2326 Stopping streaming.
     [java] #
     [java] # An unexpected error has been detected by Java Runtime Environment:

     [java] #
     [java] # EXCEPTION_ACCESS_VIOLATION (0xc0000005) at pc=0x00107d83, pid=264
0, tid=1356
     [java] #
     [java] # Java VM: Java HotSpot(TM) Client VM (1.6.0-b105 mixed mode)
     [java] # Problematic frame:
     [java] # C 0x00107d83
     [java] #
     [java] # An error report file with more information is saved as hs_err_pid2
640.log
     [java] #
     [java] # If you would like to submit a bug report, please visit:
     [java] # http://java.sun.com/webapps/bugreport/crash.jsp
     [java] #

BUILD FAILED
d:\devhome\ws\workspace\sip-communicator\build.xml:636: Java returned: 1

Total time: 1 minute 13 seconds

dems1880@demmwr6c /cygdrive/d/devhome/ws/workspace/sip-communicator
$

···

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net


#2

Hi Werner,

"Drop first packet!" is printed by JMF when, if I'm not wrong, RTP
packets arrive and the rest of the system is unable to handle the
previous packets fast enough. In the case I'd suspect that it's
printed while H.264 is in use. I'm working on implementing noticeable
speed ups to the H.264 encoder and decoder so we should start dropping
less packets afterwords (but we'll see).

With respect to the crash, please attach the hs_err_pid2640.log file
so we can look at the cause. I suspect it's either in the native
ffmpeg library or in the DirectDraw renderer which should be because
of incorrect usage on our side.

Best regards,
Lubo

···

On Sat, Jan 24, 2009 at 11:03 AM, Werner Dittmann <Werner.Dittmann@t-online.de> wrote:

All,

after updating my SC to the latest revision (both on my Linux and
my Windows XP) I experienced a "real crash" of SC on the Windows XP
system. For console output see below.

Another note: without changing my logging properties I now see additonal
log messages "Drop first packet!" - what does this mean? Which part of the
source produces this?

The root cause of Java VM crash is usually (99%) an error in a native
library. When I developed native libs for security algorithms I experienced
similar problems: using wrong pointers, overwriting arrays in the C code.

Also I see major differences in parts of the JMF code (for example logging
printouts) between Linux and Windows/Mac implementations. Here the class
"BasicTrackControl" as an example.

Best regards,
Werner

And not the long awaited console printout :slight_smile: :

$ ant run
Buildfile: build.xml

-deploy-os-specific-bundles:
    [copy] Copying 1 file to d:\devhome\ws\workspace\sip-communicator\sc-bundle
s

run:
    [java]
    [java] Welcome to Felix.
    [java] =================
    [java]
    [java] IOException in readRegistry: java.io.EOFException
    [java] 09:49:48.524 WARNUNG: impl.resources.ResourceManagementServiceImpl.g
etI18NString().442 Missing resource for key: impl.media.security.TOGGLE_ON_SECUR
ITY
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] 09:50:15.382 SCHWERWIEGEND: impl.protocol.sip.OperationSetBasicTelep
honySipImpl.processResponse().741 Received error: 404 Not Found
    [java] 09:50:15.573 WARNUNG: impl.media.CallSessionImpl.callStateChanged().
2326 Stopping streaming.
    [java] #
    [java] # An unexpected error has been detected by Java Runtime Environment:

    [java] #
    [java] # EXCEPTION_ACCESS_VIOLATION (0xc0000005) at pc=0x00107d83, pid=264
0, tid=1356
    [java] #
    [java] # Java VM: Java HotSpot(TM) Client VM (1.6.0-b105 mixed mode)
    [java] # Problematic frame:
    [java] # C 0x00107d83
    [java] #
    [java] # An error report file with more information is saved as hs_err_pid2
640.log
    [java] #
    [java] # If you would like to submit a bug report, please visit:
    [java] # http://java.sun.com/webapps/bugreport/crash.jsp
    [java] #

BUILD FAILED
d:\devhome\ws\workspace\sip-communicator\build.xml:636: Java returned: 1

Total time: 1 minute 13 seconds

dems1880@demmwr6c /cygdrive/d/devhome/ws/workspace/sip-communicator
$

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net


#3

Lubo,

tnahks for the fast answer. Attached the log file.

The never saw the "Drop first packet" message until I updated
to the latest revision. Were there some changes inside JMF?

Regards,
Werner

Lubomir Marinov schrieb:

hs_err_pid2640.log (14.9 KB)

···

Hi Werner,

"Drop first packet!" is printed by JMF when, if I'm not wrong, RTP
packets arrive and the rest of the system is unable to handle the
previous packets fast enough. In the case I'd suspect that it's
printed while H.264 is in use. I'm working on implementing noticeable
speed ups to the H.264 encoder and decoder so we should start dropping
less packets afterwords (but we'll see).

With respect to the crash, please attach the hs_err_pid2640.log file
so we can look at the cause. I suspect it's either in the native
ffmpeg library or in the DirectDraw renderer which should be because
of incorrect usage on our side.

Best regards,
Lubo

On Sat, Jan 24, 2009 at 11:03 AM, Werner Dittmann > <Werner.Dittmann@t-online.de> wrote:

All,

after updating my SC to the latest revision (both on my Linux and
my Windows XP) I experienced a "real crash" of SC on the Windows XP
system. For console output see below.

Another note: without changing my logging properties I now see additonal
log messages "Drop first packet!" - what does this mean? Which part of the
source produces this?

The root cause of Java VM crash is usually (99%) an error in a native
library. When I developed native libs for security algorithms I experienced
similar problems: using wrong pointers, overwriting arrays in the C code.

Also I see major differences in parts of the JMF code (for example logging
printouts) between Linux and Windows/Mac implementations. Here the class
"BasicTrackControl" as an example.

Best regards,
Werner

And not the long awaited console printout :slight_smile: :

$ ant run
Buildfile: build.xml

-deploy-os-specific-bundles:
    [copy] Copying 1 file to d:\devhome\ws\workspace\sip-communicator\sc-bundle
s

run:
    [java]
    [java] Welcome to Felix.
    [java] =================
    [java]
    [java] IOException in readRegistry: java.io.EOFException
    [java] 09:49:48.524 WARNUNG: impl.resources.ResourceManagementServiceImpl.g
etI18NString().442 Missing resource for key: impl.media.security.TOGGLE_ON_SECUR
ITY
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] 09:50:15.382 SCHWERWIEGEND: impl.protocol.sip.OperationSetBasicTelep
honySipImpl.processResponse().741 Received error: 404 Not Found
    [java] 09:50:15.573 WARNUNG: impl.media.CallSessionImpl.callStateChanged().
2326 Stopping streaming.
    [java] #
    [java] # An unexpected error has been detected by Java Runtime Environment:

    [java] #
    [java] # EXCEPTION_ACCESS_VIOLATION (0xc0000005) at pc=0x00107d83, pid=264
0, tid=1356
    [java] #
    [java] # Java VM: Java HotSpot(TM) Client VM (1.6.0-b105 mixed mode)
    [java] # Problematic frame:
    [java] # C 0x00107d83
    [java] #
    [java] # An error report file with more information is saved as hs_err_pid2
640.log
    [java] #
    [java] # If you would like to submit a bug report, please visit:
    [java] # http://java.sun.com/webapps/bugreport/crash.jsp
    [java] #

BUILD FAILED
d:\devhome\ws\workspace\sip-communicator\build.xml:636: Java returned: 1

Total time: 1 minute 13 seconds

dems1880@demmwr6c /cygdrive/d/devhome/ws/workspace/sip-communicator
$

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net


#4

Werner,

tnahks for the fast answer. Attached the log file.

Thank you! The log indicates DirectSound-related functionality
(com.sun.media.protocol.dsound.DSound) performed an access violation
(siginfo: ExceptionCode=0xc0000005, reading address 0x00107d83). If
you have steps to reproduce it or at least squeeze in a brief
recollection of the situation in which it happened, please share the
information.

The never saw the "Drop first packet" message until I updated
to the latest revision. Were there some changes inside JMF?

I'm a little behind on reviewing the recent commits and I've been
primarily following the .impl.media.codec.video changes but I guess
some debug code got accidentally committed. I suppose the committer
will notice this thread and take whatever action is appropriate in
this situation.

Best regards,
Lubo

···

On Sat, Jan 24, 2009 at 2:13 PM, Werner Dittmann <Werner.Dittmann@t-online.de> wrote:

Lubo,

tnahks for the fast answer. Attached the log file.

The never saw the "Drop first packet" message until I updated
to the latest revision. Were there some changes inside JMF?

Regards,
Werner

Lubomir Marinov schrieb:

Hi Werner,

"Drop first packet!" is printed by JMF when, if I'm not wrong, RTP
packets arrive and the rest of the system is unable to handle the
previous packets fast enough. In the case I'd suspect that it's
printed while H.264 is in use. I'm working on implementing noticeable
speed ups to the H.264 encoder and decoder so we should start dropping
less packets afterwords (but we'll see).

With respect to the crash, please attach the hs_err_pid2640.log file
so we can look at the cause. I suspect it's either in the native
ffmpeg library or in the DirectDraw renderer which should be because
of incorrect usage on our side.

Best regards,
Lubo

On Sat, Jan 24, 2009 at 11:03 AM, Werner Dittmann >> <Werner.Dittmann@t-online.de> wrote:

All,

after updating my SC to the latest revision (both on my Linux and
my Windows XP) I experienced a "real crash" of SC on the Windows XP
system. For console output see below.

Another note: without changing my logging properties I now see additonal
log messages "Drop first packet!" - what does this mean? Which part of the
source produces this?

The root cause of Java VM crash is usually (99%) an error in a native
library. When I developed native libs for security algorithms I experienced
similar problems: using wrong pointers, overwriting arrays in the C code.

Also I see major differences in parts of the JMF code (for example logging
printouts) between Linux and Windows/Mac implementations. Here the class
"BasicTrackControl" as an example.

Best regards,
Werner

And not the long awaited console printout :slight_smile: :

$ ant run
Buildfile: build.xml

-deploy-os-specific-bundles:
    [copy] Copying 1 file to d:\devhome\ws\workspace\sip-communicator\sc-bundle
s

run:
    [java]
    [java] Welcome to Felix.
    [java] =================
    [java]
    [java] IOException in readRegistry: java.io.EOFException
    [java] 09:49:48.524 WARNUNG: impl.resources.ResourceManagementServiceImpl.g
etI18NString().442 Missing resource for key: impl.media.security.TOGGLE_ON_SECUR
ITY
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] Drop first packet!
    [java] 09:50:15.382 SCHWERWIEGEND: impl.protocol.sip.OperationSetBasicTelep
honySipImpl.processResponse().741 Received error: 404 Not Found
    [java] 09:50:15.573 WARNUNG: impl.media.CallSessionImpl.callStateChanged().
2326 Stopping streaming.
    [java] #
    [java] # An unexpected error has been detected by Java Runtime Environment:

    [java] #
    [java] # EXCEPTION_ACCESS_VIOLATION (0xc0000005) at pc=0x00107d83, pid=264
0, tid=1356
    [java] #
    [java] # Java VM: Java HotSpot(TM) Client VM (1.6.0-b105 mixed mode)
    [java] # Problematic frame:
    [java] # C 0x00107d83
    [java] #
    [java] # An error report file with more information is saved as hs_err_pid2
640.log
    [java] #
    [java] # If you would like to submit a bug report, please visit:
    [java] # http://java.sun.com/webapps/bugreport/crash.jsp
    [java] #

BUILD FAILED
d:\devhome\ws\workspace\sip-communicator\build.xml:636: Java returned: 1

Total time: 1 minute 13 seconds

dems1880@demmwr6c /cygdrive/d/devhome/ws/workspace/sip-communicator
$

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net


#5

Lubo,

the situation was pretty simple: I did an svn update to get the latest
commits for SC, then did an "ant rebuild" and an "ant run".
The account uses a registrar and was successfully registered.

I called the SC on the XP from another SC (on my Linux box), the
call setup was ok, ZRTP worked, RTP data was exchanged between the
client. then I did a hangup from the Linux box which sent the BYE to
the SC on XP - booooooom :slight_smile: .

Something happened inside JMF when stopping the stream which is part
of hangup processing.

Regards,
Werner

Lubomir Marinov schrieb:

Werner,

tnahks for the fast answer. Attached the log file.

Thank you! The log indicates DirectSound-related functionality
(com.sun.media.protocol.dsound.DSound) performed an access violation
(siginfo: ExceptionCode=0xc0000005, reading address 0x00107d83). If
you have steps to reproduce it or at least squeeze in a brief
recollection of the situation in which it happened, please share the
information.

The never saw the "Drop first packet" message until I updated
to the latest revision. Were there some changes inside JMF?

I'm a little behind on reviewing the recent commits and I've been
primarily following the .impl.media.codec.video changes but I guess
some debug code got accidentally committed. I suppose the committer
will notice this thread and take whatever action is appropriate in
this situation.

Best regards,
Lubo

Lubo,

tnahks for the fast answer. Attached the log file.

The never saw the "Drop first packet" message until I updated
to the latest revision. Were there some changes inside JMF?

Regards,
Werner

Lubomir Marinov schrieb:

Hi Werner,

"Drop first packet!" is printed by JMF when, if I'm not wrong, RTP
packets arrive and the rest of the system is unable to handle the
previous packets fast enough. In the case I'd suspect that it's
printed while H.264 is in use. I'm working on implementing noticeable
speed ups to the H.264 encoder and decoder so we should start dropping
less packets afterwords (but we'll see).

With respect to the crash, please attach the hs_err_pid2640.log file
so we can look at the cause. I suspect it's either in the native
ffmpeg library or in the DirectDraw renderer which should be because
of incorrect usage on our side.

Best regards,
Lubo

<SNIP ---- SNAP>

···

On Sat, Jan 24, 2009 at 2:13 PM, Werner Dittmann > <Werner.Dittmann@t-online.de> wrote:

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: dev-help@sip-communicator.dev.java.net