[Feb 8 13:04:56] -- Executing [037373xxx@zamestnanci:4] Dial("Skinny/515@KIDLI-1", "SIP/cube-gw/*303737xxx") in new stack [Feb 8 13:04:56] == Using SIP RTP CoS mark 5 [Feb 8 13:04:56] -- Called cube-gw/*303737xxx [Feb 8 13:04:58] -- SIP/cube-gw-085f3460 is making progress passing it to Skinny/515@KIDLI-1 [Feb 8 13:05:00] -- SIP/cube-gw-085f3460 is making progress passing it to Skinny/515@KIDLI-1 [Feb 8 13:05:09] WARNING[27501]: pbx.c:4146 __ast_pbx_run: Skinny/515@KIDLI-1 already has PBX structure?? [Feb 8 13:05:09] -- Executing [0373730651@zamestnanci:4] Dial("Skinny/515@KIDLI-1", "SIP/cube-gw/*303737xxx") in new stack [Feb 8 13:05:09] WARNING[27501]: app_dial.c:1730 dial_exec_full: Skipping dialing interface 'SIP/cube-gw/*303737xxx' again since it has already been dialed [Feb 8 13:05:09] == Spawn extension (zamestnanci, 037371, 4) exited non-zero on 'Skinny/515@KIDLI-1' [Feb 8 13:05:09] WARNING[27501]: channel.c:2086 ast_hangup: Hard hangup called by thread -1224983664 on Skinny/515@KIDLI-1, while fd is blocked by thread -1224737904 in procedure ast_waitfor_nandfds! Expect a failure [Feb 8 13:05:09] > Killing only sub 1 [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:588 __ast_pthread_mutex_lock: channel.c line 2325 (ast_waitfor_nandfds): Error obtaining mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:692 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): mutex '(channel lock)' freed more times than we've locked! [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:720 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): Error releasing mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:588 __ast_pthread_mutex_lock: channel.c line 2325 (ast_waitfor_nandfds): Error obtaining mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:692 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): mutex '(channel lock)' freed more times than we've locked! [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:720 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): Error releasing mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:588 __ast_pthread_mutex_lock: channel.c line 2325 (ast_waitfor_nandfds): Error obtaining mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:692 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): mutex '(channel lock)' freed more times than we've locked! [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:720 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): Error releasing mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:588 __ast_pthread_mutex_lock: channel.c line 2325 (ast_waitfor_nandfds): Error obtaining mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:692 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): mutex '(channel lock)' freed more times than we've locked! [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:720 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): Error releasing mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:588 __ast_pthread_mutex_lock: channel.c line 2325 (ast_waitfor_nandfds): Error obtaining mutex: Invalid argument [Feb 8 13:05:09] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:692 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): mutex '(channel lock)' freed more times than [Feb 8 13:05:10] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:720 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): Error releasing mutex: Invalid argument [Feb 8 13:05:10] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:588 __ast_pthread_mutex_lock: channel.c line 2325 (ast_waitfor_nandfds): Error obtaining mutex: Invalid argument [Feb 8 13:05:10] ERROR[27500]: /root/src/as:-1218194132 �,���Sq��Xq��㨷^�з: channel.[Feb 8 13:05:10] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:720 __ast_pthread_mutex_unlock: channel.c line 2345 (ast_waitfor_nandfds): Error releasing mutex: Invalid argument [Feb 8 13:05:10] ERROR[27500]: /root/src/asterisk-173554/include/asterisk/lock.h:588 __ast_pthread_mutex_: channel.c line 2325 (ast_waitfor_nandfds): Error obtaining mutex: Invalid argument [Feb 8 13:05:10] WARNING[27500]: app_dial.c:1044 wait_for_answer: Unable to write frame #0 0x0809c85b in ast_channel_datastore_remove (chan=0x85ec668, datastore=0x85b4428) at channel.c:1887 curelm = (struct ast_datastore *) 0x31203820 __res = (struct ast_datastore *) 0x0 #1 0xb763a4b6 in dial_exec_full (chan=0x85ec668, data=0xb6ffcd98, peerflags=0xb6ffac0c, continue_exec=0x0) at app_dial.c:1921 res = 0 rest = 0x0 cur = 0x0 outgoing = (struct chanlist *) 0x85b4370 peer = (struct ast_channel *) 0x0 to = 0 num = {chan = 0x85ec668, busy = 0, congestion = 0, nochan = 0} cause = 0 numsubst = "cube-gw/*303737xxx\000�\036\b\000\000\000\000\000\000\000\000\004���\000\000\000\000���������O���M\020\b\000���\000\000\000\000\000\000\000\000@����\vҷ\000\000\000\000�������P\vҷ", '\0' , "46��\000\000\000\000\000\000\n�\004�����׷L�\037\bH�������G\nҷ����\005\000\000\000��׷\005\000\000\000����8����Y������H���x������G\nҷ���H����\tҷ\005\000"... cid_num = 0x0 cid_name = 0x0 config = {features_caller = {flags = 0}, features_callee = {flags = 0}, start_time = {tv_sec = 0, tv_usec = 0}, feature_timer = 0, timelimit = 0, play_warning = 0, warning_freq = 0, warning_sound = 0x0, end_sound = 0x0, start_sound = 0x0, firstpass = 0, flags = 0, end_bridge_callback = 0, end_bridge_callback_data = 0x0, end_bridge_callback_data_fixup = 0} calldurationlimit = {tv_sec = 0, tv_usec = 0} dtmfcalled = 0x0 dtmfcalling = 0x0 pa = {sentringing = 0, privdb_val = 0, privcid = '\0' , privintro = '\0' , status = "CONGESTION", '\0' } sentringing = 0 moh = 0 outbound_group = 0x0 result = 0 parse = 0xb6ff9cf0 "SIP" opermode = 0 args = {argc = 1, argv = 0xb6ffa29c, peers = 0xb6ff9cf0 "SIP", timeout = 0x0, options = 0x0, url = 0x0} opts = {flags = 0} opt_args = {0xb7a69420 "\224����\r", 0xb7a69188 "�h��$\004", 0xb7a6594d "�\215\225����\211\225\234���\215�", 0xb6ffa970 "", 0xb7a90bcc "\201�(�", 0xb7d7eff4 "|�\024", 0x6b6c
, 0x0, 0x1
, 0xb8
, 0x80
, 0xb7d7eff4 "|�\024"} datastore = (struct ast_datastore *) 0x85b4428 fulldial = 0 num_dialed = 1 __PRETTY_FUNCTION__ = "dial_exec_full" #2 0xb763d52c in dial_exec (chan=0x85ec668, data=0xb6ffcd98) at app_dial.c:2319 peerflags = {flags = 0} #3 0x081174cd in pbx_exec (c=0x85ec668, app=0x84f5438, data=0xb6ffcd98) at pbx.c:1328 res = -1224758352 u = (struct ast_module_user *) 0x85fcba8 saved_c_appl = 0x0 saved_c_data = 0x0 #4 0x0811fe2c in pbx_extension_helper (c=0x85ec668, con=0x0, context=0x85ecf2a "", exten=0x85ecf7a "", priority=4, label=0x0, callerid=0x85ed0f8 "515", action=E_SPAWN, found=0xb6fff1f0, combined_find_spawn=1) at pbx.c:3650 e = (struct ast_exten *) 0x8541da0 app = (struct ast_app *) 0x84f5438 res = 445 q = {incstack = {0x0 }, stacklen = 0, status = 5, swo = 0x0, data = 0x0, foundcontext = 0x85ecf2a ""} passdata = "SIP/cube-gw/*303737xxx\000i ENUM zaznamu\000\000\000\000\000\000\000\000\000\033[1;35mSIP/324-085f59a0\033[0m", '\0' , "\033[1;36mCongestion\033[0m", '\0' , "�\0311�", '\0' , "\n�", '\0' , "�7�\000\000\n��7�\230���371���������\001\000\000\000\002\000\000\000]�Ϸ\"\000\000\000\000\000\000\000�7�\"\000\000\000��"... matching_action = 0 __PRETTY_FUNCTION__ = "pbx_extension_helper" #5 0x08121422 in ast_spawn_extension (c=0x85ec668, context=0x85ecf2a "", exten=0x85ecf7a "", priority=4, callerid=0x85ed0f8 "515", found=0xb6fff1f0, combined_find_spawn=1) at pbx.c:4092 No locals. #6 0x08121afe in __ast_pbx_run (c=0x85ec668, args=0x0) at pbx.c:4182 digit = 0 invalid = 0 timeout = 0 dst_exten = '\0' , "<���\000\000\000\000H���@���D���L���", '\0' , "~�\000\000\000\000\000\000\000\000P���\000\000\000\000�*���\v��\000\000\000\000lk\000\000\000\---Type to continue, or q to quit--- 000\000\000\001\000\000\000\037�\027\b\000\000\000\000��׷\000\000\000\000\000\017=\000\030����ѷ�\v��\220���H���\000\000\000\000\001\000\000\000(\t\000\0008�����׷\000\000\000\000\000\017=\000H����ѷ" pos = 0 found = 1 res = 0 autoloopflag = 0 error = 0 __PRETTY_FUNCTION__ = "__ast_pbx_run" #7 0x0812389a in ast_pbx_run_args (c=0x85ec668, args=0x0) at pbx.c:4507 res = AST_PBX_SUCCESS #8 0x081238c6 in ast_pbx_run (c=0x85ec668) at pbx.c:4516 No locals. #9 0xb77153e8 in skinny_newcall (data=0x85ec668) at chan_skinny.c:3298 c = (struct ast_channel *) 0x85ec668 sub = (struct skinny_subchannel *) 0x85edfe8 l = (struct skinny_line *) 0x8420378 d = (struct skinny_device *) 0x8427b40 res = 0 __PRETTY_FUNCTION__ = "skinny_newcall" #10 0xb77158e5 in skinny_ss (data=0x85ec668) at chan_skinny.c:3365 c = (struct ast_channel *) 0x85ec668 sub = (struct skinny_subchannel *) 0x85edfe8 l = (struct skinny_line *) 0x8420378 d = (struct skinny_device *) 0x8427b40 len = 10 timeout = 0 res = 1 loop_pause = 100 __PRETTY_FUNCTION__ = "skinny_ss" #11 0x0817cc8d in dummy_start (data=0x85c4a70) at utils.c:968 __cancel_buf = {__cancel_jmp_buf = {{__cancel_jmp_buf = {-1213607948, 0, 4001536, -1224739912, 452446593, -897077508}, __mask_was_saved = 0}}, __pad = {0xb6fff480, 0x0, 0x81cc2bc, 0xb7c9debe}} __cancel_routine = (void (*)(void *)) 0x807711a __cancel_arg = (void *) 0xb6fffb90 not_first_call = 0 ret = (void *) 0xb7d50df4 a = {start_routine = 0xb771545d , data = 0x85ec668, name = 0x85c4b08 "skinny_ss", ' ' , "started at [ 4744] chan_skinny.c handle_stimulus_message()"} lock_info = (struct thr_lock_info *) 0x85ee6d8 mutex_attr = {__size = "\001\000\000", __align = 1} __PRETTY_FUNCTION__ = "dummy_start" #12 0xb7a8e315 in start_thread () from /lib/i686/libpthread.so.0 No symbol table info available. #13 0xb7d0d25e in clone () from /lib/i686/libc.so.6 No symbol table info available.