Skip to content
Snippets Groups Projects
New look: Off

ut_sipcall: timeout after 1h

    • Closed Issue created by François-Simon Fauteux-Chapleau @ffauteux-chapleau

    Happened on September 10, full logs below:

    + docker exec -u 1001:1001 7248adefa7c9224b6d31c2158af87f94b0d4ce7e45eb18af00b1f6e53ca4d5e8 sh -c rm -rf ~/.local/share/jami ~/.config/jami ~/.cache/jami && cd test/unitTest/ && make -j ut_sipcall && ./ut_sipcall
  CXX      call/sipcall.o
  CXXLD    ut_sipcall
[22;36m[1725953008.580|52157] [0mUPnPContext: starting dedicated io_context thread[0m
[22;36m[1725953008.580|52157] [0mCreating UPnPContext instance [0x55bb5b49f5c0][0m
[22;36m[1725953008.580|52158] [0mPUPnP: Creating instance [0x7f2a40000de0] ...[0m
[22;36m[1725953008.580|52157|ringbuffer.cpp          :55  ] [0mCreate new RingBuffer audiolayer_id[0m
[22;36m[1725953008.590|52157|manager.cpp             :732 ] [0mNot initialized[0m
[22;36m[1725953008.590|52157|manager.cpp             :732 ] [0mNot initialized[0m
[22;36m[1725953008.590|52157|manager.cpp             :732 ] [0mNot initialized[0m
[22;36m[1725953008.600|52157|manager.cpp             :806 ] [0mUsing PJSIP version 2.13.1 for x86_64-pc-linux-gnu[0m
[22;36m[1725953008.600|52157|manager.cpp             :807 ] [0mUsing GnuTLS version 3.8.3[0m
[22;36m[1725953008.600|52157|manager.cpp             :808 ] [0mUsing OpenDHT version 3.2.0[0m
[22;36m[1725953008.600|52157|manager.cpp             :809 ] [0mUsing FFmpeg version 6.0.1[0m
[22;36m[1725953008.600|52157|manager.cpp             :812 ] [0mUsing Libgit2 version 1.8.0[0m
[22;36m[1725953008.600|52157|sipvoiplink.cpp         :649 ] [0mUsing SIP nameserver: 192.168.55.1[0m
[22;36m[1725953008.600|52157|sipvoiplink.cpp         :649 ] [0mUsing SIP nameserver: 192.168.50.37[0m
[22;36m[1725953008.600|52157|sipvoiplink.cpp         :743 ] [0mSIPVoIPLink@0x55bb5b4b86c0[0m
[22;36m[1725953008.600|52157|manager.cpp             :828 ] [0mConfiguration file path: jami-sample.yml[0m
ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for 0
[22;36m[1725953008.610|52157|preferences.cpp         :295 ] [0m[01;33m Card with index 0 doesn't exist or is unusable.[0m
ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for 0
[22;36m[1725953008.610|52157|preferences.cpp         :295 ] [0m[01;33m Card with index 0 doesn't exist or is unusable.[0m
ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for 0
[22;36m[1725953008.610|52157|preferences.cpp         :295 ] [0m[01;33m Card with index 0 doesn't exist or is unusable.[0m
[22;36m[1725953008.610|52157|ringbuffer.cpp          :55  ] [0mCreate new RingBuffer urgentRingBuffer_id[0m
[22;36m[1725953008.620|52157|audiolayer.cpp          :60  ] [0m[audiolayer] AGC: 1, noiseReduce: auto, VAD: 1, echoCancel: auto, audioProcessor: webrtc[0m
[22;36m[1725953008.620|52157|audiolayer.cpp          :156 ] [0m[audiolayer] setHasNativeAEC: 0[0m
[22;36m[1725953008.620|52157|audiolayer.cpp          :169 ] [0m[audiolayer] setHasNativeNS: 0[0m
07:23:28.059         os_core_unix.c !pjlib 2.13.1 for POSIX initialized
.[22;36m[1725953008.710|52157|manager.cpp             :2810] [0mAdding account ea32b8f5402e300b with type SIP[0m
[22;36m[1725953008.710|52157|system_codec_container.cpp:221 ] [0m[22;31mCan't find a usable accelerated H265/HEVC codec, disabling.[0m
[22;36m[1725953008.710|52157|system_codec_container.cpp:251 ] [0mEncoders found: H264 VP8 MP4V-ES H263-1998 opus G722 G726-32 speex speex speex PCMA PCMU [0m
[22;36m[1725953008.710|52157|system_codec_container.cpp:252 ] [0mDecoders found: H264 VP8 MP4V-ES H263-1998 opus G722 G726-32 speex speex speex PCMA PCMU [0m
[22;36m[1725953008.710|52157|sipaccount_config.cpp   :268 ] [0m[01;33mNo credentials set, inferring them...[0m
[22;36m[1725953008.710|52157|sipaccount.cpp          :1994] [0m[01;33mAll audio codecs disabled, enabling all[0m
[22;36m[1725953008.710|52157|sipaccount.cpp          :1998] [0m[01;33mAll video codecs disabled, enabling all[0m
[22;36m[1725953008.710|52157|account.cpp             :168 ] [0m[01;33mRingtone /usr/local/share/jami/ringtones/default.opus is not a valid file[0m
[22;36m[1725953008.710|52158] [0mSuccessfully registered controller 0x55bb5b4f5e20[0m[22;36m[1725953008.720|52157|sipaccount.cpp          :1476] [0mPresence enabled for ea32b8f5402e300b : false.[0m

[22;36m[1725953008.720|52158] [0mStarting UPNP context[0m
[22;36m[1725953008.720|52157|manager.cpp             :1793] [0mSaving Configuration to XDG directory jami-sample.yml[0m
[22;36m[1725953008.720|52158] [0mPUPnP: Start search for IGD: attempt 1[0m
[22;36m[1725953008.720|52157|manager.cpp             :1793] [0mSaving Configuration to XDG directory jami-sample.yml[0m
[22;36m[1725953008.720|52157|sipaccount.cpp          :568 ] [0mdoRegister 192.168.50.31[0m
[22;36m[1725953008.730|52157|sipaccount.cpp          :572 ] [0mUPnP: waiting for IGD to register SIP account[0m
[22;36m[1725953008.730|52157] [0mTry to find mapping for port 5060 [UDP][0m
[22;36m[1725953008.730|52157] [0mMapping JAMI-UDP:5060 will be requested when an IGD becomes available[0m
[22;36m[1725953008.730|52157|sipaccount.cpp          :492 ] [0m[01;33m[Account ea32b8f5402e300b] Failed to open port 5060: registering SIP account anyway[0m
[22;36m[1725953008.730|52157|sipvoiplink.cpp         :1522] [0mtry to resolve '192.168.50.31' (port: 0)[0m
[22;36m[1725953008.730|52157|sipaccount.cpp          :665 ] [0m[01;33mCreating transport[0m
[22;36m[1725953008.730|52157|siptransport.cpp        :332 ] [0mCreated UDP transport on address 0.0.0.0:5060[0m
[22;36m[1725953008.730|52157|siptransport.cpp        :80  ] [0mSipTransport@0x55bb5b5cb5e0 tr=0x55bb5b5c0f08 rc=2[0m
[22;36m[1725953008.730|52157|sipaccount.cpp          :316 ] [0mSet new transport [0x55bb5b5cb5e0][0m
[22;36m[1725953008.730|52157|sipaccount.cpp          :757 ] [0mUsing contact header "ALICE" <sip:695@172.17.0.2:5060> in registration[0m
[22;36m[1725953008.730|52157] [0mNumber of 'available' TCP mappings in the local list: 0 (0 open + 0 pending + 0 in progress)[0m
[22;36m[1725953008.730|52157] [0mProvision 4 new mappings of type [TCP][0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-TCP:12815 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-TCP:14291 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-TCP:14445 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-TCP:12652 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mNumber of 'available' UDP mappings in the local list: 0 (0 open + 0 pending + 0 in progress)[0m
[22;36m[1725953008.740|52157] [0mProvision 8 new mappings of type [UDP][0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-UDP:20222 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-UDP:24500 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-UDP:24834 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-UDP:23746 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-UDP:21300 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-UDP:24200 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-UDP:24636 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157] [0mMapping JAMI-UDP:24118 will be requested when an IGD becomes available[0m
[22;36m[1725953008.740|52157|sipaccount.cpp          :575 ] [0mUPnP: UPNP request failed, try to register SIP account anyway[0m
[22;36m[1725953008.740|52157|sipvoiplink.cpp         :1522] [0mtry to resolve '192.168.50.31' (port: 0)[0m
[22;36m[1725953008.740|52157|sipaccount.cpp          :665 ] [0m[01;33mCreating transport[0m
[22;36m[1725953008.740|52157|siptransport.cpp        :101 ] [0m~SipTransport@0x55bb5b5cb5e0 tr=0x55bb5b5c0f08 rc=9[0m
[22;36m[1725953008.740|52157|siptransport.cpp        :295 ] [0m[01;33mRecycling transport 0.0.0.0:5060[0m
[22;36m[1725953008.740|52157|siptransport.cpp        :80  ] [0mSipTransport@0x55bb5b5cb4c0 tr=0x55bb5b5c0f08 rc=9[0m
[22;36m[1725953008.740|52157|sipaccount.cpp          :316 ] [0mSet new transport [0x55bb5b5cb4c0][0m
[22;36m[1725953008.740|52157|sipaccount.cpp          :757 ] [0mUsing contact header "ALICE" <sip:695@172.17.0.2:5060> in registration[0m
[22;36m[1725953008.740|52157|manager.cpp             :1793] [0mSaving Configuration to XDG directory jami-sample.yml[0m
[22;36m[1725953008.750|52157|manager.cpp             :2810] [0mAdding account 96057b7e51ed0173 with type SIP[0m
[22;36m[1725953008.750|52157|sipaccount_config.cpp   :268 ] [0m[01;33mNo credentials set, inferring them...[0m
[22;36m[1725953008.750|52157|sipaccount.cpp          :1994] [0m[01;33mAll audio codecs disabled, enabling all[0m
[22;36m[1725953008.750|52157|sipaccount.cpp          :1998] [0m[01;33mAll video codecs disabled, enabling all[0m
[22;36m[1725953008.750|52157|account.cpp             :168 ] [0m[01;33mRingtone /usr/local/share/jami/ringtones/default.opus is not a valid file[0m
[22;36m[1725953008.750|52162|sipvoiplink.cpp         :777 ] [0musername = 695, server = 192.168.50.31, from = 192.168.50.31[0m
[22;36m[1725953008.750|52157|sipaccount.cpp          :1476] [0mPresence enabled for 96057b7e51ed0173 : false.[0m
[22;36m[1725953008.750|52162|sipaccount.cpp          :1516] [0mMatching account id in request is a fullmatch 695@192.168.50.31[0m
[22;36m[1725953008.750|52157|manager.cpp             :1793] [0mSaving Configuration to XDG directory jami-sample.yml[0m
[22;36m[1725953008.750|52162|sipvoiplink.cpp         :119 ] [0mProcessing out-of-dialog option request[0m
[22;36m[1725953008.750|52162|sipvoiplink.cpp         :158 ] [0mSent out-of-dialog response for option request[0m
[22;36m[1725953008.760|52157|manager.cpp             :1793] [0mSaving Configuration to XDG directory jami-sample.yml[0m
[22;36m[1725953008.760|52157|sipaccount.cpp          :568 ] [0mdoRegister 192.168.50.31[0m
[22;36m[1725953008.760|52157|sipaccount.cpp          :572 ] [0mUPnP: waiting for IGD to register SIP account[0m
[22;36m[1725953008.760|52157] [0mTry to find mapping for port 5060 [UDP][0m
[22;36m[1725953008.760|52157] [0m[01;33mMapping request for JAMI-UDP:5060 already added![0m
[22;36m[1725953008.760|52157] [0mNumber of 'available' TCP mappings in the local list: 4 (0 open + 4 pending + 0 in progress)[0m
[22;36m[1725953008.760|52157] [0mNumber of 'available' UDP mappings in the local list: 8 (0 open + 8 pending + 0 in progress)[0m
[22;36m[1725953008.760|52157|sipaccount.cpp          :575 ] [0mUPnP: UPNP request failed, try to register SIP account anyway[0m
[22;36m[1725953008.760|52157|sipvoiplink.cpp         :1522] [0mtry to resolve '192.168.50.31' (port: 0)[0m
[22;36m[1725953008.760|52157|sipaccount.cpp          :665 ] [0m[01;33mCreating transport[0m
[22;36m[1725953008.760|52157|siptransport.cpp        :291 ] [0mReusing transport 0.0.0.0:5060[0m
[22;36m[1725953008.760|52157|sipaccount.cpp          :316 ] [0mSet new transport [0x55bb5b5cb4c0][0m
[22;36m[1725953008.760|52157|sipaccount.cpp          :757 ] [0mUsing contact header "BOB" <sip:694@172.17.0.2:5060> in registration[0m
[22;36m[1725953008.760|52157|manager.cpp             :1793] [0mSaving Configuration to XDG directory jami-sample.yml[0m
[22;36m[1725953008.770|52157|common.cpp              :82  ] [0mWaiting for 2 account to be announced...[0m
[22;36m[1725953008.123|52158] [0mPUPnP: Initialized on 172.17.0.2:0[0m
[22;36m[1725953008.124|52158] [0mPUPnP: Successfully registered client[0m
[22;36m[1725953008.124|52158] [0mPUPnP: Send IGD search request[0m
[22;36m[1725953008.124|52158] [0mIGD Discovery started[0m
[22;36m[1725953008.124|52158] [0mIGD Discovery started[0m
[22;36m[1725953008.124|52158] [0mNAT-PMP: Trying to initialize IGD[0m
[22;36m[1725953008.124|52158] [0mNAT-PMP: Initialized on gateway 172.17.0.1[0m
[22;36m[1725953008.124|52158] [0m[01;33mNAT-PMP: Read response on IGD 172.17.0.1 failed - NOGATEWAYSUPPORT[0m
[22;36m[1725953008.124|52158] [0mNAT-PMP: Start search for IGDs. Attempt 1[0m
[22;36m[1725953008.124|52158] [0mSuccessfully registered controller 0x55bb5b5ce950[0m
[22;36m[1725953008.142|52162|sipvoiplink.cpp         :777 ] [0musername = 695, server = 192.168.50.31, from = 192.168.50.31[0m
[22;36m[1725953008.142|52162|sipaccount.cpp          :1523] [0mMatching account id in request with hostname 192.168.50.31[0m
[22;36m[1725953008.142|52162|sipaccount.cpp          :1516] [0mMatching account id in request is a fullmatch 695@192.168.50.31[0m
[22;36m[1725953008.142|52162|sipvoiplink.cpp         :119 ] [0mProcessing out-of-dialog option request[0m
[22;36m[1725953008.142|52162|sipvoiplink.cpp         :158 ] [0mSent out-of-dialog response for option request[0m
[22;36m[1725953008.142|52162|sipaccount.cpp          :1565] [0m[Account ea32b8f5402e300b] Checking IP route after the registration[0m
[22;36m[1725953008.142|52162|sipaccount.cpp          :1590] [0mChecking received VIA address: 192.168.51.59[0m
[22;36m[1725953008.142|52162|sipaccount.cpp          :1666] [0m[01;33m[account ea32b8f5402e300b] Contact address changed: (172.17.0.2:5060 --> 192.168.51.59:5060). Updating registration.[0m
[22;36m[1725953008.142|52162|sipaccount.cpp          :889 ] [0m[01;33mNew contact: "ALICE" <sip:695@192.168.51.59:5060>[0m
[22;36m[1725953008.143|52162|message_engine.cpp      :236 ] [0m[Account ea32b8f5402e300b] couldn't load messages from /foo/.cache/jami/ea32b8f5402e300b/messages: basic_ios::clear: iostream error[0m
[22;36m[1725953008.143|52162|sipvoiplink.cpp         :777 ] [0musername = 694, server = 192.168.50.31, from = 192.168.50.31[0m
[22;36m[1725953008.143|52162|sipaccount.cpp          :1516] [0mMatching account id in request is a fullmatch 694@192.168.50.31[0m
[22;36m[1725953008.143|52162|sipvoiplink.cpp         :119 ] [0mProcessing out-of-dialog option request[0m
[22;36m[1725953008.144|52162|sipvoiplink.cpp         :158 ] [0mSent out-of-dialog response for option request[0m
[22;36m[1725953008.144|52162|sipaccount.cpp          :1565] [0m[Account 96057b7e51ed0173] Checking IP route after the registration[0m
[22;36m[1725953008.144|52162|sipaccount.cpp          :1590] [0mChecking received VIA address: 192.168.51.59[0m
[22;36m[1725953008.144|52162|sipaccount.cpp          :1666] [0m[01;33m[account 96057b7e51ed0173] Contact address changed: (172.17.0.2:5060 --> 192.168.51.59:5060). Updating registration.[0m
[22;36m[1725953008.144|52162|sipaccount.cpp          :889 ] [0m[01;33mNew contact: "BOB" <sip:694@192.168.51.59:5060>[0m
[22;36m[1725953008.144|52162|message_engine.cpp      :236 ] [0m[Account 96057b7e51ed0173] couldn't load messages from /foo/.cache/jami/96057b7e51ed0173/messages: basic_ios::clear: iostream error[0m
[22;36m[1725953008.144|52157|common.cpp              :98  ] [0m2 account announced![0m
[22;36m[1725953008.624|52158] [0mIGD Discovery ended[0m
[22;36m[1725953008.625|52158] [0m[01;33mRequest for mapping JAMI-TCP:12652 failed, no IGD available[0m
[22;36m[1725953008.625|52158] [0m[01;33mRequest for mapping JAMI-TCP:12815 failed, no IGD available[0m
[22;36m[1725953008.625|52158] [0m[01;33mRequest for mapping JAMI-TCP:14291 failed, no IGD available[0m
[22;36m[1725953008.625|52158] [0m[01;33mRequest for mapping JAMI-TCP:14445 failed, no IGD available[0m
[22;36m[1725953008.625|52158|sipaccount.cpp          :307 ] [0mRemoving old transport [0x55bb5b5cb4c0] from account[0m
[22;36m[1725953008.625|52158|sipaccount.cpp          :316 ] [0mSet new transport [0x0][0m
[22;36m[1725953008.625|52158|sipaccount.cpp          :568 ] [0mdoRegister 192.168.50.31[0m
[22;36m[1725953008.625|52158|sipaccount.cpp          :572 ] [0mUPnP: waiting for IGD to register SIP account[0m
[22;36m[1725953008.625|52158] [0mTry to find mapping for port 5060 [UDP][0m
[22;36m[1725953008.626|52162|sipaccount.cpp          :880 ] [0mUnregistration success[0m
[22;36m[1725953008.626|52162|sipaccount.cpp          :921 ] [0mRegistrar returned EXPIRE value [0 s] different from the requested [3600 s][0m
[22;36m[1725953018.145|52157|sipcall.cpp             :124 ] [0mStart call between alice and Bob[0m
[22;36m[1725953018.145|52157|manager.cpp             :1106] [0mtry outgoing call to '694' with account 'ea32b8f5402e300b'[0m
[22;36m[1725953018.145|52157|sipaccount.cpp          :167 ] [0m[Account ea32b8f5402e300b] Calling SIP peer 694[0m
Sending interrupt signal to process
Terminated
script returned exit code 143

    Happened again on September 11, 12.

    Edited

    Designs

    Child items ...

    • Activity

    • François-Simon Fauteux-Chapleau added severitymedium typetest labels

      added severitymedium typetest labels

    • François-Simon Fauteux-Chapleau changed the description

      changed the description

    • François-Simon Fauteux-Chapleau changed the description

      changed the description

    • François-Simon Fauteux-Chapleau
      François-Simon Fauteux-Chapleau @ffauteux-chapleau ·
      Author Developer

      It looks like this issue was caused by a thread attempting to lock the same mutex twice:

      Thread 2 (Thread 0x7ffff6200640 (LWP 711753) "ut_sipcall"):
#0  futex_wait (private=0, expected=2, futex_word=0x5555587b5548) at ../sysdeps/nptl/futex-internal.h:146
#1  __GI___lll_lock_wait (futex=futex@entry=0x5555587b5548, private=0) at ./nptl/lowlevellock.c:49
#2  0x00007ffff6a98002 in lll_mutex_lock_optimized (mutex=0x5555587b5548) at ./nptl/pthread_mutex_lock.c:48
#3  ___pthread_mutex_lock (mutex=0x5555587b5548) at ./nptl/pthread_mutex_lock.c:93
#4  0x0000555555db788c in __gthread_mutex_lock (__mutex=0x5555587b5548) at /usr/include/x86_64-linux-gnu/c++/11/bits/gthr-default.h:749
#5  std::mutex::lock() (this=0x5555587b5548) at /usr/include/c++/11/bits/std_mutex.h:100
#6  std::lock_guard<std::mutex>::lock_guard(std::mutex&) (__m=..., this=<synthetic pointer>) at /usr/include/c++/11/bits/std_mutex.h:229
#7  dhtnet::upnp::UPnPContext::reserveMapping(dhtnet::upnp::Mapping&) (this=0x5555587b5260, requestedMap=...) at /home/fsimon/jami-client-qt/daemon/contrib/native-x86_64-linux-gnu/dhtnet/src/upnp/upnp_context.cpp:338
#8  0x0000555555dc728e in dhtnet::upnp::Controller::reserveMapping(dhtnet::upnp::Mapping&) (this=0x55555882b1e0, requestedMap=<optimized out>) at /usr/include/c++/11/bits/shared_ptr_base.h:1295
#9  0x00005555559fc442 in jami::SIPAccount::mapPortUPnP() (this=0x555558805850) at /home/fsimon/jami-client-qt/daemon/src/sip/sipaccount.cpp:519
#10 0x00005555559fca7c in jami::SIPAccount::doRegister() (this=0x555558805850) at /home/fsimon/jami-client-qt/daemon/src/sip/sipaccount.cpp:574
#11 0x00005555559fdbdc in operator()(bool) const (__closure=0x7ffff0004080) at /home/fsimon/jami-client-qt/daemon/src/sip/sipaccount.cpp:726
#12 0x0000555555a09f6a in std::__invoke_impl<void, jami::SIPAccount::connectivityChanged()::<lambda(bool)>&, bool>(std::__invoke_other, struct {...} &) (__f=...) at /usr/include/c++/11/bits/invoke.h:61
#13 0x0000555555a0980d in std::__invoke_r<void, jami::SIPAccount::connectivityChanged()::<lambda(bool)>&, bool>(struct {...} &) (__fn=...) at /usr/include/c++/11/bits/invoke.h:111
#14 0x0000555555a08b41 in std::_Function_handler<void(bool), jami::SIPAccount::connectivityChanged()::<lambda(bool)> >::_M_invoke(const std::_Any_data &, bool &&) (__functor=..., __args#0=@0x7ffff61ff384: true) at /usr/include/c++/11/bits/std_function.h:290
#15 0x00005555557b2f70 in std::function<void (bool)>::operator()(bool) const (this=0x7ffff61ff440, __args#0=true) at /usr/include/c++/11/bits/std_function.h:590
#16 0x00005555559fdabb in jami::SIPAccount::doUnregister(std::function<void (bool)>) (this=0x555558805850, released_cb=...) at /home/fsimon/jami-client-qt/daemon/src/sip/sipaccount.cpp:713
#17 0x00005555559fdc77 in jami::SIPAccount::connectivityChanged() (this=0x555558805850) at /home/fsimon/jami-client-qt/daemon/src/sip/sipaccount.cpp:724
#18 0x00005555559fc2b6 in operator()(dhtnet::upnp::Mapping::sharedPtr_t) const (__closure=0x7ffff0004060, mapRes=std::shared_ptr<dhtnet::upnp::Mapping> (use count 2, weak count 0) = {...}) at /home/fsimon/jami-client-qt/daemon/src/sip/sipaccount.cpp:512
#19 0x0000555555a09ac4 in std::__invoke_impl<void, jami::SIPAccount::mapPortUPnP()::<lambda(dhtnet::upnp::Mapping::sharedPtr_t)>&, std::shared_ptr<dhtnet::upnp::Mapping> >(std::__invoke_other, struct {...} &) (__f=...) at /usr/include/c++/11/bits/invoke.h:61
#20 0x0000555555a0906f in std::__invoke_r<void, jami::SIPAccount::mapPortUPnP()::<lambda(dhtnet::upnp::Mapping::sharedPtr_t)>&, std::shared_ptr<dhtnet::upnp::Mapping> >(struct {...} &) (__fn=...) at /usr/include/c++/11/bits/invoke.h:111
#21 0x0000555555a08586 in std::_Function_handler<void(std::shared_ptr<dhtnet::upnp::Mapping>), jami::SIPAccount::mapPortUPnP()::<lambda(dhtnet::upnp::Mapping::sharedPtr_t)> >::_M_invoke(const std::_Any_data &, std::shared_ptr<dhtnet::upnp::Mapping> &&) (__functor=..., __args#0=...) at /usr/include/c++/11/bits/std_function.h:290
#22 0x0000555555db2520 in std::function<void (std::shared_ptr<dhtnet::upnp::Mapping>)>::operator()(std::shared_ptr<dhtnet::upnp::Mapping>) const (__args#0=std::shared_ptr<dhtnet::upnp::Mapping> (empty) = {...}, this=0x7ffff61ff5c0) at /usr/include/c++/11/bits/std_function.h:590
#23 dhtnet::upnp::UPnPContext::updateMappingState(std::shared_ptr<dhtnet::upnp::Mapping> const&, dhtnet::upnp::MappingState, bool) (this=<optimized out>, map=std::shared_ptr<dhtnet::upnp::Mapping> (use count 2, weak count 0) = {...}, newState=<optimized out>, notify=<optimized out>) at /home/fsimon/jami-client-qt/daemon/contrib/native-x86_64-linux-gnu/dhtnet/src/upnp/upnp_context.cpp:1286
#24 0x0000555555db26c7 in dhtnet::upnp::UPnPContext::_endIgdDiscovery() (this=0x5555587b5260) at /home/fsimon/jami-client-qt/daemon/contrib/native-x86_64-linux-gnu/dhtnet/src/upnp/upnp_context.cpp:1130
#25 0x0000555555db2a93 in operator() (ec=std::error_code = { }, __closure=0x7ffff61ff720) at /home/fsimon/jami-client-qt/daemon/contrib/native-x86_64-linux-gnu/dhtnet/src/upnp/upnp_context.cpp:1110

      More precisely, UPnPContext::reserveMapping attempts to lock mappingMutex_ after UPnPContext::_endIgdDiscovery has already done so. This got fixed by the following patch: https://review.jami.net/c/dhtnet/+/29012

    • François-Simon Fauteux-Chapleau added sprintdone label

      added sprintdone label

    • François-Simon Fauteux-Chapleau closed

      closed

    Please register or sign in to reply