1.make a video call from A to B
2.B answered the call
3.B press hold key
4.A and B press the hold key at almost same time
5.repeat step 4 until call sticks
according to the gdb trace, the dead lock happened, two threads stuck at “switch_core_session_perform_receive_message”, and they are all waiting for a mutex, which has been acquired by the other thread
hello,
What version of FreeSWITCH and can you attach the backtrace?
the version is:FreeSWITCH Version 1.10.12-dev~64bit ( 64bit)
GDB track:
Id Target Id Frame
1 Thread 0x7ff58c8cc0c0 (LWP 770091) “freeswitch” 0x00007ff58e5fae23 in __GI___select (nfds=nfds@entry=0, readfds=readfds@entry=0x0,
writefds=writefds@entry=0x0, exceptfds=exceptfds@entry=0x0, timeout=timeout@entry=0x7ffc1efc58d0) at …/sysdeps/unix/sysv/linux/select.c:41
2 Thread 0x7ff58c802700 (LWP 770093) “freeswitch” 0x00007ff58e5fae23 in __GI___select (nfds=nfds@entry=0, readfds=readfds@entry=0x0,
writefds=writefds@entry=0x0, exceptfds=exceptfds@entry=0x0, timeout=timeout@entry=0x7ff58c801c30) at …/sysdeps/unix/sysv/linux/select.c:41
3 Thread 0x7ff58c601700 (LWP 770094) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x55ac092069dc)
at …/sysdeps/nptl/futex-internal.h:186
4 Thread 0x7ff58c525700 (LWP 770096) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x55ac09206cf0)
at …/sysdeps/nptl/futex-internal.h:186
5 Thread 0x7ff587fff700 (LWP 770097) “freeswitch” futex_abstimed_wait_cancelable (private=0, abstime=0x7ff587ffebf0, clockid=-2013271168, expected=0,
futex_word=0x55ac094180c8) at …/sysdeps/nptl/futex-internal.h:323
6 Thread 0x7ff58c239700 (LWP 770098) “freeswitch” 0x00007ff58e5f896f in __GI___poll (fds=fds@entry=0x7ff570000b60, nfds=nfds@entry=2,
timeout=timeout@entry=100) at …/sysdeps/unix/sysv/linux/poll.c:29
7 Thread 0x7ff58c1fc700 (LWP 770100) “freeswitch” 0x00007ff58e6ef1bf in __libc_accept (fd=5, addr=…, len=0x7ff568000f58)
at …/sysdeps/unix/sysv/linux/accept.c:26
8 Thread 0x7ff58c1bf700 (LWP 770101) “freeswitch” 0x00007ff58e6ef1bf in __libc_accept (fd=7, addr=…, len=0x7ff56c000f58)
at …/sysdeps/unix/sysv/linux/accept.c:26
9 Thread 0x7ff586dae700 (LWP 770102) “freeswitch” 0x00007ff58e5cb1a1 in __GI___clock_nanosleep (clock_id=clock_id@entry=1, flags=flags@entry=0,
req=req@entry=0x7ff586dadb80, rem=rem@entry=0x0) at …/sysdeps/unix/sysv/linux/clock_nanosleep.c:48
10 Thread 0x7ff586d71700 (LWP 770103) “freeswitch” 0x00007ff58e5fae23 in __GI___select (nfds=nfds@entry=0, readfds=readfds@entry=0x0,
writefds=writefds@entry=0x0, exceptfds=exceptfds@entry=0x0, timeout=timeout@entry=0x7ff586d70c40) at …/sysdeps/unix/sysv/linux/select.c:41
11 Thread 0x7ff586cc3700 (LWP 770104) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x7ff564065b48)
at …/sysdeps/nptl/futex-internal.h:186
12 Thread 0x7ff5322bc700 (LWP 770114) “freeswitch” 0x00007ff58e5f896f in __GI___poll (fds=fds@entry=0x7ff52c000c40, nfds=nfds@entry=3,
timeout=timeout@entry=100) at …/sysdeps/unix/sysv/linux/poll.c:29
13 Thread 0x7ff53205a700 (LWP 770115) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x55ac0962d8d0)
at …/sysdeps/nptl/futex-internal.h:186
14 Thread 0x7ff53201d700 (LWP 770116) “freeswitch” 0x00007ff58e5fae23 in __GI___select (nfds=nfds@entry=0, readfds=readfds@entry=0x0,
writefds=writefds@entry=0x0, exceptfds=exceptfds@entry=0x0, timeout=timeout@entry=0x7ff53201cbc0) at …/sysdeps/unix/sysv/linux/select.c:41
15 Thread 0x7ff531e06700 (LWP 770117) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x55ac0969c328)
at …/sysdeps/nptl/futex-internal.h:186
16 Thread 0x7ff531c55700 (LWP 770118) “freeswitch” __libc_read (nbytes=8, buf=0x7ff531c54028, fd=46) at …/sysdeps/unix/sysv/linux/read.c:26
17 Thread 0x7ff531c18700 (LWP 770119) “freeswitch” __libc_read (nbytes=8, buf=0x7ff531c17028, fd=48) at …/sysdeps/unix/sysv/linux/read.c:26
18 Thread 0x7ff531bdb700 (LWP 770123) “freeswitch” 0x00007ff58e5f896f in __GI___poll (fds=fds@entry=0x7ff531bda8d0, nfds=nfds@entry=2,
timeout=timeout@entry=-1) at …/sysdeps/unix/sysv/linux/poll.c:29
19 Thread 0x7ff531b9e700 (LWP 770125) “freeswitch” 0x00007ff58e6ef1bf in __libc_accept (fd=51, addr=…, len=0x7ff5140480e8)
at …/sysdeps/unix/sysv/linux/accept.c:26
20 Thread 0x7ff531b24700 (LWP 770126) “freeswitch” __libc_read (nbytes=8, buf=0x7ff531b23be0, fd=49) at …/sysdeps/unix/sysv/linux/read.c:26
21 Thread 0x7ff531ae7700 (LWP 770127) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x55ac0970f7b8)
at …/sysdeps/nptl/futex-internal.h:186
22 Thread 0x7ff531aaa700 (LWP 770128) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x55ac0971d030)
at …/sysdeps/nptl/futex-internal.h:186
23 Thread 0x7ff585d46700 (LWP 770131) “freeswitch” 0x00007ff58e604d56 in epoll_wait (epfd=14, events=0x7ff585d458f0, maxevents=4, timeout=1000)
at …/sysdeps/unix/sysv/linux/epoll_wait.c:30
24 Thread 0x7ff5877fe700 (LWP 770132) “freeswitch” 0x00007ff58e604d56 in epoll_wait (epfd=17, events=0x7ff5877fdb00, maxevents=4, timeout=1000)
at …/sysdeps/unix/sysv/linux/epoll_wait.c:30
25 Thread 0x7ff586a8f700 (LWP 770133) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x7ff54006b754)
at …/sysdeps/nptl/futex-internal.h:186
26 Thread 0x7ff586865700 (LWP 770134) “freeswitch” futex_abstimed_wait_cancelable (private=0, abstime=0x7ff586864bc0, clockid=-2038019248, expected=0,
futex_word=0x7ff508257a88) at …/sysdeps/nptl/futex-internal.h:323
27 Thread 0x7ff5867eb700 (LWP 770135) “freeswitch” 0x00007ff58e604d56 in epoll_wait (epfd=23, events=0x7ff5867ea8f0, maxevents=4, timeout=1000)
at …/sysdeps/unix/sysv/linux/epoll_wait.c:30
28 Thread 0x7ff5867ae700 (LWP 770136) “freeswitch” 0x00007ff58e604d56 in epoll_wait (epfd=27, events=0x7ff5867adb00, maxevents=4, timeout=1000)
at …/sysdeps/unix/sysv/linux/epoll_wait.c:30
29 Thread 0x7ff585dc0700 (LWP 770137) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x7ff53c06b7bc)
at …/sysdeps/nptl/futex-internal.h:186
30 Thread 0x7ff586828700 (LWP 770138) “freeswitch” futex_abstimed_wait_cancelable (private=0, abstime=0x7ff586827bc0, clockid=-2038269104, expected=0,
futex_word=0x7ff508257a88) at …/sysdeps/nptl/futex-internal.h:323
31 Thread 0x7ff585d83700 (LWP 770139) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x7ff5082b9a98)
at …/sysdeps/nptl/futex-internal.h:186
32 Thread 0x7ff531b61700 (LWP 770142) “freeswitch” futex_wait_cancelable (private=0, expected=0, futex_word=0x7ff50804c438)
at …/sysdeps/nptl/futex-internal.h:186
Thread 33 (id:770208 )
#4 0x00007ff586b6c6d4 in sofia_receive_message (session=0x7ff4fc41c458, msg=0x7ff531898360) at mod_sofia.c:1526
1526 switch_mutex_lock(tech_pvt->sofia_mutex);
(gdb) p *tech_pvt->sofia_mutex
$7 = {pool = 0x7ff4fc3e7728, mutex = pthread_mutex_t = {Type = Recursive, Status = Acquired, possibly with waiters, Owner ID = 770225, Robust = No,
Shared = No, Protocol = None, Times acquired by the owner = 2}}
thread 39 (id:770225):
(gdb) up
#4 0x00007ff586b6c6d4 in sofia_receive_message (session=0x7ff5400d80d8, msg=0x7ff58694b7d0) at mod_sofia.c:1526
1526 switch_mutex_lock(tech_pvt->sofia_mutex);
(gdb) p *tech_pvt->sofia_mutex
$9 = {pool = 0x7ff5400a16b8, mutex = pthread_mutex_t = {Type = Recursive, Status = Acquired, possibly with waiters, Owner ID = 770208, Robust = No,
Shared = No, Protocol = None, Times acquired by the owner = 2}}
Where info:
Thread 33:
(gdb) thread 33
[Switching to thread 33 (Thread 0x7ff5318a1700 (LWP 770208))]
#0 __lll_lock_wait (futex=futex@entry=0x7ff4fc3f7838, private=0) at lowlevellock.c:52
52 lowlevellock.c: No such file or directory.
(gdb) where
#0 __lll_lock_wait (futex=futex@entry=0x7ff4fc3f7838, private=0) at lowlevellock.c:52
#1 0x00007ff58e6e78d1 in __GI___pthread_mutex_lock (mutex=0x7ff4fc3f7838) at …/nptl/pthread_mutex_lock.c:115
#2 0x00007ff58eaab989 in fspr_thread_mutex_lock (mutex=) at locks/unix/thread_mutex.c:92
#3 0x00007ff58e764625 in switch_mutex_lock (lock=) at src/switch_apr.c:310
#4 0x00007ff586b6c6d4 in sofia_receive_message (session=0x7ff4fc41c458, msg=0x7ff531898360) at mod_sofia.c:1526
#5 0x00007ff58e796d06 in switch_core_session_perform_receive_message (session=session@entry=0x7ff4fc41c458, message=,
message@entry=0x7ff531898360, file=file@entry=0x7ff58ead0dd9 “src/switch_core_media.c”,
func=func@entry=0x7ff58ead5fe0 <func.19> “_switch_core_session_request_video_refresh”, line=line@entry=14541) at src/switch_core_session.c:931
#6 0x00007ff58e7c759c in _switch_core_session_request_video_refresh (session=0x7ff4fc41c458, force=force@entry=0,
file=file@entry=0x7ff58ead0dd9 “src/switch_core_media.c”, func=func@entry=0x7ff58ead6e90 <func.104> “switch_core_media_toggle_hold”,
line=line@entry=6636) at src/switch_core_media.c:14541
#7 0x00007ff58e7c775f in switch_core_media_toggle_hold (session=session@entry=0x7ff5400d80d8, sendonly=sendonly@entry=1) at src/switch_core_media.c:6636
#8 0x00007ff58e7cc3f8 in switch_core_media_negotiate_sdp (session=session@entry=0x7ff5400d80d8,
r_sdp=r_sdp@entry=0x7ff55402ae72 "v=0\r\no=1010 3345031538 2619013678 IN IP4 192.168.1.21\r\ns=A conversation\r\nc=IN IP4 192.168.1.21\r\nt=0 0\r\nm=audio 10004 RTP/AVP 0 101\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:101 telephone-event/8000\r\na=fmtp:101 "…,
proceed=proceed@entry=0x7ff53189be8f “\001\210t?\374\364\177”, sdp_type=sdp_type@entry=SDP_OFFER) at src/switch_core_media.c:5342
#9 0x00007ff586bd16a5 in sofia_media_negotiate_sdp (session=session@entry=0x7ff5400d80d8,
r_sdp=0x7ff55402ae72 "v=0\r\no=1010 3345031538 2619013678 IN IP4 192.168.1.21\r\ns=A conversation\r\nc=IN IP4 192.168.1.21\r\nt=0 0\r\nm=audio 10004 RTP/AVP 0 101\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:101 telephone-event/8000\r\na=fmtp:101 "…, type=type@entry=SDP_OFFER) at sofia_media.c:42
#10 0x00007ff586ba68eb in sofia_handle_sip_i_state (tags=0x7ff55402aa70, de=0x7ff540001a80, sip=0x0, sofia_private=, nh=0x7ff55405eed0,
profile=0x7ff5083424e0, nua=0x7ff540008810, phrase=0x7ff55402afbe “Trying”, status=, session=0x7ff5400d80d8) at sofia.c:8423
#11 our_sofia_event_callback (event=nua_i_state, status=, phrase=0x7ff55402afbe “Trying”, nua=0x7ff540008810, profile=0x7ff5083424e0,
nh=0x7ff55405eed0, sofia_private=, sip=0x0, de=0x7ff540001a80, tags=0x7ff55402aa70) at sofia.c:1813
#12 0x00007ff586ba9548 in sofia_process_dispatch_event (dep=dep@entry=0x7ff53189c8b0) at sofia.c:2253
#13 0x00007ff586b6c6a0 in sofia_receive_message (session=0x7ff5400d80d8, msg=0x7ff53189d020) at mod_sofia.c:1347
#14 0x00007ff58e796cc6 in switch_core_session_perform_receive_message (session=session@entry=0x7ff5400d80d8, message=,
message@entry=0x7ff53189d020, file=file@entry=0x7ff58eaeaef5 “src/switch_ivr.c”,
func=func@entry=0x7ff58eaebf70 <func.47> “switch_ivr_parse_signal_data”, line=line@entry=895) at src/switch_core_session.c:854
#15 0x00007ff58e860de8 in switch_ivr_parse_signal_data (session=0x7ff5400d80d8, all=all@entry=SWITCH_FALSE,
only_session_thread=only_session_thread@entry=SWITCH_TRUE) at src/switch_ivr.c:895
#16 0x00007ff58e76a7e1 in switch_channel_check_signal (channel=channel@entry=0x7ff5400a17a0, in_thread_only=in_thread_only@entry=SWITCH_TRUE)
at src/switch_channel.c:2266
#17 0x00007ff58e76a99f in switch_channel_test_ready (channel=0x7ff5400a17a0, check_ready=check_ready@entry=SWITCH_TRUE,
check_media=check_media@entry=SWITCH_TRUE) at src/switch_channel.c:2276
#18 0x00007ff58e7da9ec in switch_core_session_write_frame (session=session@entry=0x7ff5400d80d8, frame=frame@entry=0x7ff53189d4e0, flags=flags@entry=0,
stream_id=stream_id@entry=0) at src/switch_core_media.c:15889
#19 0x00007ff58e8591d4 in switch_ivr_play_file (session=session@entry=0x7ff5400d80d8, fh=, fh@entry=0x7ff53189dbc0,
file=file@entry=0x7ff4fc36f148 “local_stream://default”, args=args@entry=0x7ff53189db80) at src/switch_ivr_play_say.c:1978
#20 0x00007ff53220af83 in playback_function (session=0x7ff5400d80d8, data=) at mod_dptools.c:3055
#21 0x00007ff58e79ae45 in switch_core_session_exec (session=session@entry=0x7ff5400d80d8,
application_interface=application_interface@entry=0x55ac0961e978, arg=0x7ff4f01ecf20 “local_stream://default”) at src/switch_core_session.c:2965
#22 0x00007ff58e79b650 in switch_core_session_execute_application_get_flags (session=session@entry=0x7ff5400d80d8,
app=app@entry=0x7ff4f01ecea0 “playback”, arg=, arg@entry=0x7ff4f01ecf20 “local_stream://default”, flags=flags@entry=0x0)
at src/switch_core_session.c:2825
#23 0x00007ff58e862e9a in switch_ivr_parse_event (session=0x7ff5400d80d8, event=) at src/switch_ivr.c:647
#24 0x00007ff58e863a65 in switch_ivr_parse_next_event (session=session@entry=0x7ff5400d80d8) at src/switch_ivr.c:804
#25 0x00007ff58e830a6d in audio_bridge_thread (obj=obj@entry=0x7ff4f84a0708, thread=0x0) at src/switch_ivr_bridge.c:565
#26 0x00007ff58e832e36 in switch_ivr_multi_threaded_bridge (session=session@entry=0x7ff5400d80d8, peer_session=0x7ff4fc41c458,
input_callback=, session_data=session_data@entry=0x0, peer_session_data=peer_session_data@entry=0x0) at src/switch_ivr_bridge.c:1794
#27 0x00007ff53221b040 in audio_bridge_function (session=, data=) at mod_dptools.c:3673
#28 0x00007ff58e79ae45 in switch_core_session_exec (session=session@entry=0x7ff5400d80d8,
application_interface=application_interface@entry=0x55ac0961ff88,
arg=0x7ff54009eb90 “{fire_asr_events=true,execute_on_answer=‘detect_speech vosk default default’}user/${destination_number}”)
at src/switch_core_session.c:2965
#29 0x00007ff58e79b650 in switch_core_session_execute_application_get_flags (session=session@entry=0x7ff5400d80d8, app=0x7ff54009eb88 “bridge”,
arg=, flags=flags@entry=0x0) at src/switch_core_session.c:2825
#30 0x00007ff58e79fab2 in switch_core_standard_on_execute (session=0x7ff5400d80d8) at src/switch_core_state_machine.c:350
#31 switch_core_session_run (session=0x7ff5400d80d8) at src/switch_core_state_machine.c:647
#32 0x00007ff58e798840 in switch_core_session_thread (thread=, obj=0x7ff5400d80d8) at src/switch_core_session.c:1727
#33 0x00007ff58e793ede in switch_core_session_thread_pool_worker (thread=0x7ff5400a7a10, obj=) at src/switch_core_session.c:1791
#34 0x00007ff58e6e4ea7 in start_thread (arg=) at pthread_create.c:477
#35 0x00007ff58e604a2f in clone () at …/sysdeps/unix/sysv/linux/x86_64/clone.S:95
(gdb)
Thread 39:
(gdb) where
#0 __lll_lock_wait (futex=futex@entry=0x7ff54009dc18, private=0) at lowlevellock.c:52
#1 0x00007ff58e6e78d1 in __GI___pthread_mutex_lock (mutex=0x7ff54009dc18) at …/nptl/pthread_mutex_lock.c:115
#2 0x00007ff58eaab989 in fspr_thread_mutex_lock (mutex=) at locks/unix/thread_mutex.c:92
#3 0x00007ff58e764625 in switch_mutex_lock (lock=) at src/switch_apr.c:310
#4 0x00007ff586b6c6d4 in sofia_receive_message (session=0x7ff5400d80d8, msg=0x7ff58694b7d0) at mod_sofia.c:1526
#5 0x00007ff58e796d06 in switch_core_session_perform_receive_message (session=session@entry=0x7ff5400d80d8, message=,
message@entry=0x7ff58694b7d0, file=file@entry=0x7ff58ead0dd9 “src/switch_core_media.c”,
func=func@entry=0x7ff58ead5fe0 <func.19> “_switch_core_session_request_video_refresh”, line=line@entry=14541) at src/switch_core_session.c:931
#6 0x00007ff58e7c759c in _switch_core_session_request_video_refresh (session=0x7ff5400d80d8, force=force@entry=0,
file=file@entry=0x7ff58ead0dd9 “src/switch_core_media.c”, func=func@entry=0x7ff58ead6e90 <func.104> “switch_core_media_toggle_hold”,
line=line@entry=6636) at src/switch_core_media.c:14541
#7 0x00007ff58e7c775f in switch_core_media_toggle_hold (session=session@entry=0x7ff4fc41c458, sendonly=sendonly@entry=0) at src/switch_core_media.c:6636
#8 0x00007ff58e7cc3f8 in switch_core_media_negotiate_sdp (session=session@entry=0x7ff4fc41c458,
r_sdp=r_sdp@entry=0x7ff554006f92 “v=0\r\no=sdp_admin 915664953 1777111780 IN IP4 192.168.1.27\r\ns=A conversation\r\nc=IN IP4 192.168.1.27\r\nt=0 0\r\nm=audio 10028 RTP/AVP 0 8 101\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:101 telep”…, proceed=proceed@entry=0x7ff58694f2ff “\001”,
sdp_type=sdp_type@entry=SDP_OFFER) at src/switch_core_media.c:5342
#9 0x00007ff586bd16a5 in sofia_media_negotiate_sdp (session=session@entry=0x7ff4fc41c458,
r_sdp=0x7ff554006f92 “v=0\r\no=sdp_admin 915664953 1777111780 IN IP4 192.168.1.27\r\ns=A conversation\r\nc=IN IP4 192.168.1.27\r\nt=0 0\r\nm=audio 10028 RTP/AVP 0 8 101\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:101 telep”…, type=type@entry=SDP_OFFER) at sofia_media.c:42
#10 0x00007ff586ba68eb in sofia_handle_sip_i_state (tags=0x7ff554006b50, de=0x7ff540089ae0, sip=0x0, sofia_private=, nh=0x7ff4f0004370,
profile=0x7ff5083424e0, nua=0x7ff540008810, phrase=0x7ff5540070d1 “Trying”, status=, session=0x7ff4fc41c458) at sofia.c:8423
#11 our_sofia_event_callback (event=nua_i_state, status=, phrase=0x7ff5540070d1 “Trying”, nua=0x7ff540008810, profile=0x7ff5083424e0,
nh=0x7ff4f0004370, sofia_private=, sip=0x0, de=0x7ff540089ae0, tags=0x7ff554006b50) at sofia.c:1813
#12 0x00007ff586ba9548 in sofia_process_dispatch_event (dep=dep@entry=0x7ff58694fd20) at sofia.c:2253
#13 0x00007ff586b6c6a0 in sofia_receive_message (session=0x7ff4fc41c458, msg=0x7ff586950490) at mod_sofia.c:1347
#14 0x00007ff58e796cc6 in switch_core_session_perform_receive_message (session=session@entry=0x7ff4fc41c458, message=,
message@entry=0x7ff586950490, file=file@entry=0x7ff58eaeaef5 “src/switch_ivr.c”,
func=func@entry=0x7ff58eaebf70 <func.47> “switch_ivr_parse_signal_data”, line=line@entry=895) at src/switch_core_session.c:854
#15 0x00007ff58e860de8 in switch_ivr_parse_signal_data (session=session@entry=0x7ff4fc41c458, all=all@entry=SWITCH_TRUE,
only_session_thread=only_session_thread@entry=SWITCH_FALSE) at src/switch_ivr.c:895
#16 0x00007ff58e860e2c in switch_ivr_parse_all_signal_data (session=session@entry=0x7ff4fc41c458) at src/switch_ivr.c:908
#17 0x00007ff58e860e4b in switch_ivr_parse_all_messages (session=session@entry=0x7ff4fc41c458) at src/switch_ivr.c:854
#18 0x00007ff58e830338 in audio_bridge_thread (obj=obj@entry=0x7ff4f01c6608, thread=0x0) at src/switch_ivr_bridge.c:572
#19 0x00007ff58e831b22 in audio_bridge_on_exchange_media (session=0x7ff4fc41c458) at src/switch_ivr_bridge.c:979
#20 0x00007ff58e79fbc9 in switch_core_session_run (session=0x7ff4fc41c458) at src/switch_core_state_machine.c:650
#21 0x00007ff58e798840 in switch_core_session_thread (thread=, obj=0x7ff4fc41c458) at src/switch_core_session.c:1727
#22 0x00007ff58e793ede in switch_core_session_thread_pool_worker (thread=0x7ff4fc3f8ed0, obj=) at src/switch_core_session.c:1791
#23 0x00007ff58e6e4ea7 in start_thread (arg=) at pthread_create.c:477
#24 0x00007ff58e604a2f in clone () at …/sysdeps/unix/sysv/linux/x86_64/clone.S:95
INVITE sip:mod_sofia@192.168.1.102:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.27:5060;branch=z9hG4bK294581348734616676;rport
From: sip:1009@192.168.1.27:5060;tag=1913649718
To: “1010” sip:1010@192.168.1.102;tag=FcyK14tQgrX6S
Call-ID: e1e577e1-7d80-123d-0c9b-4cd71784200e
CSeq: 6 INVITE
Contact: sip:1009@192.168.1.27:5060
Max-Forwards: 70
Supported: replaces, join, path
User-Agent: VoIP IP Phone 2.6.0.980 00a859ef0b4e
Allow-Events: talk
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Type: application/sdp
Content-Length: 342
v=0
o=sdp_admin 915664953 1777111780 IN IP4 192.168.1.27
s=A conversation
c=IN IP4 192.168.1.27
t=0 0
m=audio 10028 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=sendrecv
m=video 10030 RTP/AVP 102
a=rtpmap:102 H264/90000
a=fmtp:102 profile-level-id=42801e; max-br=2000
a=sendrecv
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.27:5060;branch=z9hG4bK294581348734616676;rport=5060
From: sip:1009@192.168.1.27:5060;tag=1913649718
To: “1010” sip:1010@192.168.1.102;tag=FcyK14tQgrX6S
Call-ID: e1e577e1-7d80-123d-0c9b-4cd71784200e
CSeq: 6 INVITE
User-Agent: ECOM
Content-Length: 0
INVITE sip:1009@192.168.1.102:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.1.21:5060;branch=z9hG4bK9004133581362120546
From: 1010 sip:1010@192.168.1.102;tag=2125517641
To: sip:1009@192.168.1.102;tag=e34tZ99KKF7Ke
Call-ID: 287971462949371-252433840922044@192.168.1.21
CSeq: 7 INVITE
Contact: sip:1010@192.168.1.21:5060
Max-Forwards: 70
Supported: replaces, join, path
User-Agent: VoIP IP Phone 2.6.0.128 00a859eed0bd
Allow-Events: talk
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Type: application/sdp
Content-Length: 331
v=0
o=1010 3345031538 2619013678 IN IP4 192.168.1.21
s=A conversation
c=IN IP4 192.168.1.21
t=0 0
m=audio 10004 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendonly
m=video 10006 RTP/AVP 117
a=rtpmap:117 H264/90000
a=fmtp:117 profile-level-id=42801e; max-br=2000
a=sendonly
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.21:5060;branch=z9hG4bK9004133581362120546
From: 1010 sip:1010@192.168.1.102;tag=2125517641
To: sip:1009@192.168.1.102;tag=e34tZ99KKF7Ke
Call-ID: 287971462949371-252433840922044@192.168.1.21
CSeq: 7 INVITE
User-Agent: ECOM
Content-Length: 0
f00c9828-9bfa-4913-8f6d-cbea05057411 2024-04-25 16:30:36.294793 98.70% [DEBUG] sofia.c:7493 Channel sofia/192.168.1.102/1010@192.168.1.102 entering state [received][100]
f00c9828-9bfa-4913-8f6d-cbea05057411 2024-04-25 16:30:36.294793 98.70% [DEBUG] sofia.c:7503 Remote SDP:
f00c9828-9bfa-4913-8f6d-cbea05057411 v=0
f00c9828-9bfa-4913-8f6d-cbea05057411 o=1010 3345031538 2619013678 IN IP4 192.168.1.21
f00c9828-9bfa-4913-8f6d-cbea05057411 s=A conversation
f00c9828-9bfa-4913-8f6d-cbea05057411 c=IN IP4 192.168.1.21
f00c9828-9bfa-4913-8f6d-cbea05057411 t=0 0
f00c9828-9bfa-4913-8f6d-cbea05057411 m=audio 10004 RTP/AVP 0 101
f00c9828-9bfa-4913-8f6d-cbea05057411 a=rtpmap:0 PCMU/8000
f00c9828-9bfa-4913-8f6d-cbea05057411 a=rtpmap:101 telephone-event/8000
f00c9828-9bfa-4913-8f6d-cbea05057411 a=fmtp:101 0-15
f00c9828-9bfa-4913-8f6d-cbea05057411 a=sendonly
f00c9828-9bfa-4913-8f6d-cbea05057411 m=video 10006 RTP/AVP 117
f00c9828-9bfa-4913-8f6d-cbea05057411 a=rtpmap:117 H264/90000
f00c9828-9bfa-4913-8f6d-cbea05057411 a=fmtp:117 profile-level-id=42801e; max-br=2000
f00c9828-9bfa-4913-8f6d-cbea05057411 a=sendonly
f00c9828-9bfa-4913-8f6d-cbea05057411
f00c9828-9bfa-4913-8f6d-cbea05057411 2024-04-25 16:30:36.294793 98.70% [ERR] switch_core_media.c:5341 wokao switch_core_media_negotiate_sdp switch_core_media_toggle_hold start tid:00000bc0a0
f00c9828-9bfa-4913-8f6d-cbea05057411 2024-04-25 16:30:36.294793 98.70% [ERR] switch_core_media.c:6464 wokao switch_core_media_toggle_hold tid:000bc0a0 enter
f00c9828-9bfa-4913-8f6d-cbea05057411 2024-04-25 16:30:36.294793 98.70% [DEBUG] switch_channel.c:1994 (sofia/192.168.1.102/1010@192.168.1.102) Callstate Change ACTIVE → HELD
f00c9828-9bfa-4913-8f6d-cbea05057411 2024-04-25 16:30:36.534853 98.70% [ERR] switch_core_media.c:14540 wokao _switch_core_session_request_video_refresh switch_core_session_receive_message tid:000bc0a0 start
f00c9828-9bfa-4913-8f6d-cbea05057411 2024-04-25 16:30:36.534853 98.70% [ERR] switch_core_media.c:14542 wokao _switch_core_session_request_video_refresh switch_core_session_receive_message tid:000bc0a0 end
d1d4d124-9373-4c5f-ada2-1398a70aa10e 2024-04-25 16:30:36.534853 98.70% [ERR] switch_core_media.c:14540 wokao _switch_core_session_request_video_refresh switch_core_session_receive_message tid:000bc0a0 start
d1d4d124-9373-4c5f-ada2-1398a70aa10e 2024-04-25 16:30:41.394851 98.73% [DEBUG] switch_channel.c:2179 (sofia/192.168.1.102/1009@192.168.1.27:5060) Callstate Change HELD → UNHELD
d1d4d124-9373-4c5f-ada2-1398a70aa10e 2024-04-25 16:30:41.394851 98.73% [ERR] switch_core_media.c:14540 wokao _switch_core_session_request_video_refresh switch_core_session_receive_message tid:000bc0b1 start
d1d4d124-9373-4c5f-ada2-1398a70aa10e 2024-04-25 16:30:41.394851 98.73% [ERR] switch_core_media.c:14542 wokao _switch_core_session_request_video_refresh switch_core_session_receive_message tid:000bc0b1 end
f00c9828-9bfa-4913-8f6d-cbea05057411 2024-04-25 16:30:41.394851 98.73% [ERR] switch_core_media.c:14540 wokao _switch_core_session_request_video_refresh switch_core_session_receive_message tid:000bc0b1 start