-- Executing [8503028993@from-outside:1] Set("SIP/8503028993-00000000", "__NUMBER=8503028993") in new stack [Jun 20 11:34:57] DEBUG[19410][C-00000000]: pbx_variables.c:381 ast_str_retrieve_variable: Result of 'EXTEN' is '8503028993' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: pbx_variables.c:505 ast_str_substitute_variables_full: Evaluating 'SQL_ESC(${ARG1})' (from 'SQL_ESC(${ARG1})}')' len 16) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: pbx_variables.c:505 ast_str_substitute_variables_full: Evaluating 'ARG1' (from 'ARG1})' len 4) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: pbx_variables.c:381 ast_str_retrieve_variable: Result of 'ARG1' is '8503028993' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: pbx_variables.c:544 ast_str_substitute_variables_full: Function SQL_ESC(8503028993) result is '8503028993' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: res_odbc.c:982 _ast_odbc_request_obj2: Reusing ODBC handle 0x298ad38 from class 'pbxconf1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 2 and maxcol of 10 for column 'xx' (offset 0) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '13626' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 6 and maxcol of 3 for column 'xx' (offset 1) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 6 and maxcol of 64 for column 'xx' (offset 2) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '8503028993' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 8 and maxcol of 10 for column 'xx' (offset 3) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '100' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 10 and maxcol of 10 for column 'xx-in' (offset 4) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '300' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 11 and maxcol of 10 for column 'xx-out' (offset 5) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '50' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 8 and maxcol of 10 for column 'xx' (offset 6) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '55' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 5 and maxcol of 3 for column 'xx' (offset 7) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55,1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 9 and maxcol of 3 for column 'xx' (offset 8) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55,1,1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 8 and maxcol of 10 for column 'xx' (offset 9) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55,1,1,1' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 10 and maxcol of 10 for column 'xx' (offset 10) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '29' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55,1,1,1,29' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 9 and maxcol of 3 for column 'xx' (offset 11) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '0' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55,1,1,1,29,0' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 6 and maxcol of 10 for column 'xx' (offset 12) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '172134' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55,1,1,1,29,0,172134' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:928 acf_odbc_read: Got collength of 7 and maxcol of 3 for column 'xx' (offset 13) [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:975 acf_odbc_read: Got coldata of '13' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:999 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55,1,1,1,29,0,172134,13' [Jun 20 11:34:57] DEBUG[19410][C-00000000]: func_odbc.c:1001 acf_odbc_read: buf is now set to '13626,1,8503028993,100,300,50,55,1,1,1,29,0,172134,13' [Jun 20 11:34:59] DEBUG[19392]: chan_sip.c:9432 __find_call: = Looking for Call ID: 1e18d5533e8be93c3b2aed9f00ab499d@185.88.7.189 (Checking From) --From tag as7a76a33a --To-tag [Jun 20 11:34:59] DEBUG[19392][C-00000000]: chan_sip.c:28855 handle_incoming: **** Received CANCEL (14) - Command in SIP CANCEL [Jun 20 11:34:59] DEBUG[19392][C-00000000]: netsock2.c:172 ast_sockaddr_split_hostport: Splitting '185.88.7.189' into... [Jun 20 11:34:59] DEBUG[19392][C-00000000]: netsock2.c:226 ast_sockaddr_split_hostport: ...host '185.88.7.189' and port ''. [Jun 20 11:34:59] DEBUG[19392][C-00000000]: chan_sip.c:3407 sip_alreadygone: Setting SIP_ALREADYGONE on dialog 1e18d5533e8be93c3b2aed9f00ab499d@185.88.7.189