Closed NightShift21 closed 6 years ago
NightShift21
commented
7 years ago Also when adding an SCCP extension via the SCCP Phone Manager it completes and saves the extension in the extensions correctly but when I return to SCCP Phone Manager there is nothing listed in the Extensions (Line) panel also there is nothing saved in the sccpline table in mySQL. Sorry I'd love to help get this running and I love your work on it so far but I know just enough about scripting to stuff things up 😆
PhantomVl
commented
7 years ago I suppose first you need to create internal numbers (lines, extensions). Available extensions are displayed on the Extensions (Line). Some errors were corrected by me in the last update.
NightShift21
commented
7 years ago Ok I tried creating the extension first but there's still nothing showing up in the Extensions (Line) tab. I'm using: extconfig.conf
; [alias] => [driver],[dbsection],[dbtablename]
sccpdevice => odbc,asterisk,sccpdeviceconfig ; Please note use the '=>' instead of '='
sccpline => odbc,asterisk,sccplinesccp.conf
[general]
...
devicetable=sccpdevice
linetable=sccplineextconfig.conf - needed to work chain_sccp realtime, I use freepbx's built-in functionality. Likely problems that you do not overwrite the driver file... You can delete the file /var/www/html/admin/modules/core/functions.inc/drivers/Sccp.class.php. then try to add again the extension (line). if this doesn't help I need more information: version of asterisk, chain_sccp, mysql (v. 5 or hight ?), php ... odbc I am concerned, I have not tested how this will work if the whole system is configured via odbc..
NightShift21
commented
7 years ago Mine doesn't have the /var/www/html/admin/modules/core/functions.inc/drivers/Sccp.class.php file. I've installed FreePBX 14 direct from the distro then followed the instructions here (https://github.com/chan-sccp/chan-sccp/wiki/Realtime-Configuration) to set-up realtime configuration PBX Firmware:12.7.4-1710-1.sng7 PBX Service Pack:1.0.0.0 Asterisk 13.17.2 built by mockbuild @ jenkins7 on a x86_64 running Linux MySQL version: 5.5.56-MariaDB MariaDB Server Chan_sccp: 4.3.0
PhantomVl
commented
7 years ago Chain_sccp installed from source or from binary package ? Sccp_manader you have is /var/www/html/admin/modules/sccp_manager ?
NightShift21
commented
7 years ago Chain_sccp installed from source or from binary package ?
Installed from source
Sccp_manader you have is /var/www/html/admin/modules/sccp_manager ?
Yes
PhantomVl
commented
7 years ago After opening the page settings SCCP tested and created the required dependencies, including /var/www/html/admin/modules/core/functions.inc/drivers/Sccp.class.php file. Maybe not enough rights to the directory or not all the necessary pre-configuration.
NightShift21
commented
7 years ago I've used SCCP Phone Manager to create the Extensions (Line) and that all seems OK. I then added Device Phone and it is showing the phone with the correct Device SEP ID, Device type and IP address but it's showing Line = 5 (I've only created 1 line)
Problem is, nothing is displaying on the phone, no device label or lines buttons. I can add feature buttons and they display on the phone but no lines
I don't know if this helps any?
[2017-10-28 20:14:46] NOTICE[5835]: sccp_utils.c:841 apply_netmask: == SCCP: (apply_netmask) applying netmask to 120.xxx.x.xx/0.0.0.0
[2017-10-28 20:14:46] NOTICE[5835]: sccp_utils.c:867 apply_netmask: == SCCP: (apply_netmask) result applied netmask 0.0.0.0
[2017-10-28 20:14:46] NOTICE[5835]: sccp_utils.c:841 apply_netmask: == SCCP: (apply_netmask) applying netmask to 120.xxx.x.xx/0.0.0.0
[2017-10-28 20:14:46] NOTICE[5835]: sccp_utils.c:867 apply_netmask: == SCCP: (apply_netmask) result applied netmask 0.0.0.0
[2017-10-28 20:14:46] NOTICE[5835]: sccp_session.c:578 recalc_wait_time: > 43.xxx.xx.xx:56854: keepalive:31, keepaliveinterval:31
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SCCP: set poll timeout 31 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- 43.xxx.xx.xx:56854: >> Got message Alarm Message (0x20)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: 43.xxx.xx.xx:56854: SCCP Handle Message: Alarm Message(0x0020) 104 bytes length
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SCCP: set poll timeout 31 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:252 session_buffer2msg: -- SCCP: (session_dissect_msg) Incoming message is smaller(64) than known size(184).
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- 43.xxx.xx.xx:56854: >> Got message Register Message (0x1)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: 43.xxx.xx.xx:56854: SCCP Handle Message: Register Message(0x0001) 64 bytes length
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:813 handle_register: SEPXXXXXXXXXXXX: is registering, Instance: 1, UserId: 0, Type: Cisco 7960 (7), Version: 6 (loadinfo '')
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:3267 __sccp_device_find_realtime: -- SCCP: Device 'SEPXXXXXXXXXXXX' found in realtime table 'sccpdevice'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:559 sccp_device_create: -- SCCP: Create Device
[2017-10-28 20:14:46] NOTICE[30914]: sccp_refcount.c:244 sccp_refcount_object_alloc: SCCP: (alloc_obj) Creating new device SEPXXXXXXXXXXXX (0x2f400f0) inside 0x2f400b0 at hash: 296
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:497 sccp_device_setDeviceState: -- SEPXXXXXXXXXXXX: Device State is 'On Hook'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:604 sccp_device_create: -- Init MessageStack
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: button = 'line,5,default' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token button/button
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (button=line,5,default)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1798 sccp_config_parse_button: == buttonconfig status before check
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1854 sccp_config_parse_button: == buttonconfig status after check
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1864 sccp_config_parse_button: -- Any Previous ButtonConfig will be discared during post-process
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:2034 sccp_config_addButton: > SCCP: Loading New Button Config
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:2050 sccp_config_addButton: > New Line Button '5' at : 0:0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:2070 sccp_config_addButton: > SCCP: Line Button Definition
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:2071 sccp_config_addButton: > SCCP: ComposedId extension: 5, subscriptionId[number:, name:, label:, aux:]
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1880 sccp_config_parse_button: > Added button: line,5,default
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1888 sccp_config_parse_button: == buttonconfig status after adding new buttons
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1891 sccp_config_parse_button: -- index:0, type:Line (0), pendingDelete:False, pendingUpdate:False
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[45] = TRUE for button
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: type = '7960' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: addon = '7914' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token addon/addon
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (addon=7914)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1633 sccp_config_parse_addons: add new addon: 124
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[44] = TRUE for addon
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: description = 'Office' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[4] = TRUE for description
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: tzoffset = '10' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[6] = TRUE for tzoffset
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: deny = '0.0.0.0/0.0.0.0' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token deny/deny
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (deny=0.0.0.0/0.0.0.0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token deny/permit
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:301 createVariableSetForMultiEntryParameters: > Add to variable set (permit=0.0.0.0/0.0.0.0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_netsock.c:268 sccp_netsock_split_hostport: > Splitting '0.0.0.0' into...
[2017-10-28 20:14:46] NOTICE[30914]: sccp_netsock.c:321 sccp_netsock_split_hostport: > ...host '0.0.0.0' and port ''.
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1024 sccp_sockaddr_storage_parse: == SCCP: (sccp_sockaddr_storage_parse) addr:0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1158 sccp_append_ha: == SCCP: (sccp_append_ha) mask:0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_netsock.c:268 sccp_netsock_split_hostport: > Splitting '0.0.0.0' into...
[2017-10-28 20:14:46] NOTICE[30914]: sccp_netsock.c:321 sccp_netsock_split_hostport: > ...host '0.0.0.0' and port ''.
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1024 sccp_sockaddr_storage_parse: == SCCP: (sccp_sockaddr_storage_parse) addr:0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1167 sccp_append_ha: == SCCP: (sccp_append_ha) strmask:0.0.0.0, netmask:0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:841 apply_netmask: == SCCP: (apply_netmask) applying netmask to 0.0.0.0/0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:867 apply_netmask: == SCCP: (apply_netmask) result applied netmask 0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1219 sccp_append_ha: == 0.0.0.0/0.0.0.0 sense 0 appended to acl for peer
[2017-10-28 20:14:46] NOTICE[30914]: sccp_netsock.c:268 sccp_netsock_split_hostport: > Splitting '0.0.0.0' into...
[2017-10-28 20:14:46] NOTICE[30914]: sccp_netsock.c:321 sccp_netsock_split_hostport: > ...host '0.0.0.0' and port ''.
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1024 sccp_sockaddr_storage_parse: == SCCP: (sccp_sockaddr_storage_parse) addr:0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1158 sccp_append_ha: == SCCP: (sccp_append_ha) mask:0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_netsock.c:268 sccp_netsock_split_hostport: > Splitting '0.0.0.0' into...
[2017-10-28 20:14:46] NOTICE[30914]: sccp_netsock.c:321 sccp_netsock_split_hostport: > ...host '0.0.0.0' and port ''.
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1024 sccp_sockaddr_storage_parse: == SCCP: (sccp_sockaddr_storage_parse) addr:0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1167 sccp_append_ha: == SCCP: (sccp_append_ha) strmask:0.0.0.0, netmask:0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:841 apply_netmask: == SCCP: (apply_netmask) applying netmask to 0.0.0.0/0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:867 apply_netmask: == SCCP: (apply_netmask) result applied netmask 0.0.0.0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:1219 sccp_append_ha: == 0.0.0.0/0.0.0.0 sense 1 appended to acl for peer
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[17] = TRUE for deny|permit
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: permit = '0.0.0.0/0.0.0.0' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:408 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[17] = TRUE for MultiEntry deny|permit -> SKIPPING
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: earlyrtp = 'none' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:650 sccp_config_object_setValue: SCCP: Parse Other Value: none -> 5
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[25] = TRUE for earlyrtp
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: mwilamp = 'wink' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:650 sccp_config_object_setValue: SCCP: Parse Other Value: wink -> 3
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[28] = TRUE for mwilamp
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: mwioncall = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[29] = TRUE for mwioncall
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: directed_pickup = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[34] = TRUE for pickupexten
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[37] = TRUE for directed_pickup
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: directed_pickup_modeanswer = 'off' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[36] = TRUE for pickupmodeanswer
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[39] = TRUE for directed_pickup_modeanswer
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: dndFeature = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[13] = TRUE for dndFeature
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: transfer = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[8] = TRUE for transfer
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: cfwdall = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[10] = TRUE for cfwdall
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: cfwdbusy = 'off' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[11] = TRUE for cfwdbusy
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: private = 'off' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[26] = TRUE for private
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: privacy = 'full' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token privacy/privacy
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (privacy=full)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[27] = TRUE for privacy
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: nat = 'auto' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:650 sccp_config_object_setValue: SCCP: Parse Other Value: auto -> 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[23] = TRUE for nat
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: softkeyset = 'default' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[32] = TRUE for softkeyset
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: audio_tos = '0xB8' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token audio_tos/audio_tos
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (audio_tos=0xB8)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[18] = TRUE for audio_tos
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: audio_cos = '6' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token audio_cos/audio_cos
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (audio_cos=6)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[19] = TRUE for audio_cos
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: video_tos = '0x88' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token video_tos/video_tos
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (video_tos=0x88)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[20] = TRUE for video_tos
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: video_cos = '5' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token video_cos/video_cos
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (video_cos=5)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[21] = TRUE for video_cos
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: conf_allow = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[47] = TRUE for conf_allow
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: conf_play_general_announce = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[48] = TRUE for conf_play_general_announce
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: conf_play_part_announce = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[49] = TRUE for conf_play_part_announce
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: conf_mute_on_entry = 'off' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[50] = TRUE for conf_mute_on_entry
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: conf_music_on_hold_class = 'default' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[51] = TRUE for conf_music_on_hold_class
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: conf_show_conflist = 'on' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[52] = TRUE for conf_show_conflist
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: disallow = 'all' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token disallow/disallow
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:294 createVariableSetForMultiEntryParameters: > Create new variable set (disallow=all)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:290 createVariableSetForMultiEntryParameters: > Token disallow/allow
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:301 createVariableSetForMultiEntryParameters: > Add to variable set (allow=alaw)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:301 createVariableSetForMultiEntryParameters: > Add to variable set (allow=g723)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:301 createVariableSetForMultiEntryParameters: > Add to variable set (allow=g729)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1423 sccp_config_parse_codec_preferences: sccp_config_parse_codec preference: name: disallow, value:all
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1423 sccp_config_parse_codec_preferences: sccp_config_parse_codec preference: name: allow, value:alaw
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1423 sccp_config_parse_codec_preferences: sccp_config_parse_codec preference: name: allow, value:g723
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:1423 sccp_config_parse_codec_preferences: sccp_config_parse_codec preference: name: allow, value:g729
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[7] = TRUE for disallow|allow
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: allow = 'alaw' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:408 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[7] = TRUE for MultiEntry disallow|allow -> SKIPPING
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: allow = 'g723' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:408 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[7] = TRUE for MultiEntry disallow|allow -> SKIPPING
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: allow = 'g729' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:408 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[7] = TRUE for MultiEntry disallow|allow -> SKIPPING
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: name = 'SEPXXXXXXXXXXXX' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: _hwlang = 'en_GB:en_GB' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: useRedialMenu = 'off' (line: 0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[33] = TRUE for useRedialMenu
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter name looking for defaultValue (flags: 1, type: 8)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'name' defaultValue direct lookup
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter device looking for defaultValue (flags: 2, type: 8)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'device' defaultValue direct lookup
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter devicetype looking for defaultValue (flags: 2, type: 8)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'devicetype' defaultValue direct lookup
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter type looking for defaultValue (flags: 1, type: 8)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'type' defaultValue direct lookup
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:820 sccp_config_set_defaults: -- Set parameter 'type' to own default, being:'device'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: type = 'device' (line: 821)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[4] = TRUE for description)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter keepalive looking for defaultValue (flags: 128, type: 2)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'keepalive' defaultValue referred lookup via general
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:800 sccp_config_set_defaults: == Found name:'keepalive', value:'60', use referred config-file value from segment 'general'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:808 sccp_config_set_defaults: -- Refer default value lookup for parameter:'keepalive' through 'general' segment
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: keepalive = '60' (line: 809)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[5] = TRUE for keepalive
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[6] = TRUE for tzoffset)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[7] = TRUE for disallow|allow)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[8] = TRUE for transfer)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter park looking for defaultValue (flags: 2, type: 1)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'park' defaultValue direct lookup
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:820 sccp_config_set_defaults: -- Set parameter 'park' to own default, being:'yes'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: park = 'yes' (line: 821)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[9] = TRUE for park
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[10] = TRUE for cfwdall)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[11] = TRUE for cfwdbusy)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter cfwdnoanswer looking for defaultValue (flags: 128, type: 1)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'cfwdnoanswer' defaultValue referred lookup via general
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:814 sccp_config_set_defaults: -- Set parameter 'cfwdnoanswer' to segment default, being:'no'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: cfwdnoanswer = 'yes' (line: 815)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[12] = TRUE for cfwdnoanswer
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[13] = TRUE for dndFeature)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter dnd looking for defaultValue (flags: 2, type: 128)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'dnd' defaultValue direct lookup
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[0] = TRUE for name)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter force_dtmfmode looking for defaultValue (flags: 2, type: 128)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'force_dtmfmode' defaultValue direct lookup
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:820 sccp_config_set_defaults: -- Set parameter 'force_dtmfmode' to own default, being:'auto'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: force_dtmfmode = 'auto' (line: 821)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:650 sccp_config_object_setValue: SCCP: Parse Other Value: auto -> 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:701 sccp_config_object_setValue: -- SCCP: (sccp_config_object_setValue) Set Entry[16] = TRUE for force_dtmfmode
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[17] = TRUE for deny|permit)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[18] = TRUE for audio_tos)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[19] = TRUE for audio_cos)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[20] = TRUE for video_tos)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[21] = TRUE for video_cos)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[22] = TRUE for trustphoneip)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:753 sccp_config_set_defaults: == SCCP: (sccp_config_set_defaults) skip setting default (SetEntry[23] = TRUE for nat)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:765 sccp_config_set_defaults: parsing device parameter directrtp looking for defaultValue (flags: 128, type: 1)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:782 sccp_config_set_defaults: == config parameter:'directrtp' defaultValue referred lookup via general
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:814 sccp_config_set_defaults: -- Set parameter 'directrtp' to segment default, being:'(null)'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_config.c:371 sccp_config_object_setValue: -- SCCP: parsing device parameter: directrtp = 'no' (line: 815)
[2017-10-28 20:14:46] NOTICE[5833]: sccp_threadpool.c:232 sccp_threadpool_thread_do: -- (sccp_threadpool_thread_do) Let's work. num_jobs: 0, thread: 0x7f4356b74700, num_threads: 2
[2017-10-28 20:14:46] NOTICE[5833]: sccp_threadpool.c:245 sccp_threadpool_thread_do: -- (sccp_threadpool_thread_do) executing 0x2e58fc0 in thread: 0x7f4356b74700
sccp_event.c :0081 (sccp_event_destroy ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[5833]: sccp_threadpool.c:164 sccp_threadpool_check_size: -- (sccp_threadpool_check_resize) in thread: 0x7f4356b74700
[2017-10-28 20:14:46] NOTICE[5833]: sccp_threadpool.c:180 sccp_threadpool_check_size: -- (sccp_threadpool_check_resize) Number of threads: 2, job_high_water_mark: 0
[2017-10-28 20:14:46] NOTICE[5833]: sccp_threadpool.c:219 sccp_threadpool_thread_do: -- (sccp_threadpool_thread_do) num_jobs: 0, thread: 0x7f4356b74700, num_threads: 2
[2017-10-28 20:14:46] NOTICE[5833]: sccp_threadpool.c:224 sccp_threadpool_thread_do: -- (sccp_threadpool_thread_do) Thread 0x7f4356b74700 Waiting for New Work Condition
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Headset Status Message (0x2B)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Headset Status Message(0x002B) 16 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:252 session_buffer2msg: -- SEPXXXXXXXXXXXX: (session_dissect_msg) Incoming message is smaller(128) than known size(304).
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Capabilities Response Message (0x10)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Capabilities Response Message(0x0010) 128 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2568 handle_capabilities_res: -- SEPXXXXXXXXXXXX: Device has 7 Capabilities
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Headset Status Message (0x2B)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Headset Status Message(0x002B) 16 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:252 session_buffer2msg: -- SEPXXXXXXXXXXXX: (session_dissect_msg) Incoming message is smaller(12) than known size(16).
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Button Template Request (0xE)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Button Template Request(0x000E) 12 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:837 sccp_dev_build_buttontemplate: -- SEPXXXXXXXXXXXX: Building button template Cisco 7960(7), user config
[2017-10-28 20:14:46] NOTICE[30914]: sccp_utils.c:129 sccp_addons_taps: -- SEPXXXXXXXXXXXX: Found (14) taps on device addon (124)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1196 sccp_dev_build_buttontemplate: -- SEPXXXXXXXXXXXX: Allocated '20' buttons.
[2017-10-28 20:14:46] NOTICE[30914]: sccp_line.c:893 __sccp_line_find_realtime_byname: -- SCCP: Line '5' not found in realtime table 'sccpline'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_line.c:831 sccp_line_find_byname: -- SCCP: Line '5' not found.
[2017-10-28 20:14:46] WARNING[30914]: sccp_actions.c:1051 sccp_make_button_template: SEPXXXXXXXXXXXX: line 5 does not exists
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message Button Template Message
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Button Template Message(0x0097) 128 bytes length
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message SoftKey Template Request (0x28)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: SoftKey Template Request(0x0028) 12 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message SoftKey Template Response
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: SoftKey Template Response(0x0108) 676 bytes length
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message SoftKey Set Request (0x25)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: SoftKey Set Request(0x0025) 12 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2687 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: searching for softkeyset: default!
[2017-10-28 20:14:46] NOTICE[30914]: sccp_line.c:831 sccp_line_find_byname: -- SCCP: Line '5' not found.
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: ONHOOK => |0 :Redial |1 :NewCall |2 :CFwdALL |3 :DND |4 :PickUp |6 :Private |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: CONNECTED => |0 :Hold |1 :EndCall |2 :Park |4 :Select |5 :CFwdALL |8 :Record |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: ONHOLD => |0 :Resume |1 :NewCall |2 :EndCall |3 :Transfer |4 :ConfList |5 :Select |6 :DirTrfr |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: RINGIN => |0 :Answer |1 :EndCall |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: OFFHOOK => |0 :Redial |1 :EndCall |2 :Private |3 :CFwdALL |5 :PickUp |8 :Barge |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: CONNTRANS => |0 :Hold |1 :EndCall |2 :Transfer |3 :Confrn |4 :Park |5 :Select |6 :DirTrfr |9 :CFwdALL |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: DIGITSFOLL => |0 :<< |1 :EndCall |2 :Dial |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: CONNCONF => |0 :ConfList |1 :NewCall |2 :EndCall |3 :Hold |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: RINGOUT => |1 :EndCall |2 :Transfer |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: OFFHOOKFEAT => |0 :Resume |1 :NewCall |2 :EndCall |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: INUSEHINT => |0 :Redial |1 :NewCall |2 :PickUp |4 :Barge |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: ONHOOKSTEALABLE => |0 :Redial |1 :NewCall |2 :CFwdALL |3 :PickUp |5 :DND |6 :Intercept|
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:2850 handle_soft_key_set_req: -- SEPXXXXXXXXXXXX: HOLDCONF => |0 :Resume |1 :NewCall |2 :EndCall |3 :Join |
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on ONHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on ONHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on CONNECTED to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on CONNECTED to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on ONHOLD to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on ONHOLD to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on RINGIN to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on RINGIN to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on OFFHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on OFFHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on CONNTRANS to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on CONNTRANS to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on DIGITSFOLL to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on DIGITSFOLL to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on CONNCONF to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on CONNCONF to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on RINGOUT to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on RINGOUT to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on OFFHOOKFEAT to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on OFFHOOKFEAT to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Video Mode' on INUSEHINT to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on INUSEHINT to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message SoftKey Set Response
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: SoftKey Set Response(0x0109) 784 bytes length
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Redial' on ONHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1165 sccp_softkey_setSoftkeyState: > SEPXXXXXXXXXXXX: found softkey 'Redial' at 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Confrn' on ONHOOK to on
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on ONHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'ConfList' on ONHOOK to on
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Record' on ONHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1380 sccp_dev_set_keyset: -- SEPXXXXXXXXXXXX: Set softkeyset to ONHOOK(0) on line 0 and call 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1381 sccp_dev_set_keyset: -- SEPXXXXXXXXXXXX: validKeyMask 4294967294
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message Select SoftKeys Message
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Select SoftKeys Message(0x0110) 20 bytes length
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Line State Request (0xB)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Line State Request(0x000B) 16 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:1485 handle_line_number: -- SEPXXXXXXXXXXXX: Configuring line number 0
[2017-10-28 20:14:46] ERROR[30914]: sccp_actions.c:1494 handle_line_number: SEPXXXXXXXXXXXX: requested a line configuration for unknown line/speeddial 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message Line State Message
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Line State Message(0x0092) 116 bytes length
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Register Available Lines Message (0x2D)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Register Available Lines Message(0x002D) 16 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Time Date Request (0xD)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Time Date Request(0x000D) 12 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message Define Time Date
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Define Time Date(0x0094) 40 bytes length
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1271 sccp_dev_set_registered: -- SEPXXXXXXXXXXXX: (sccp_dev_set_registered) Setting Registered Status for Device from Progress to OK
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:544 sccp_device_setRegistrationState: -- SEPXXXXXXXXXXXX: Registration State is 'OK'
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:2125 sccp_dev_postregistration: -- SEPXXXXXXXXXXXX: Device registered; performing post registration tasks...
sccp_device.c :2129 (sccp_dev_postregistration ) ---> refcount increased 03 +> 04 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_threadpool.c:368 sccp_threadpool_jobqueue_add: -- (sccp_threadpool_jobqueue_add) tp_p: 0x2f1c9c0, jobCount: 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:2133 sccp_dev_postregistration: -- SEPXXXXXXXXXXXX: Getting Database Settings...
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message Clear Prompt Status Message
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Clear Prompt Status Message(0x0113) 12 bytes length
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1647 sccp_dev_clearprompt: -- SEPXXXXXXXXXXXX: Clear the status prompt on line 0 and callid 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1668 sccp_dev_displayprompt_debug: -- SEPXXXXXXXXXXXX: ( sccp_device.c:2012:sccp_dev_check_displayprompt ) sccp_dev_displayprompt '?' for line 0 (0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message Display Prompt Status Message
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Display Prompt Status Message(0x0112) 48 bytes length
[2017-10-28 20:14:46] NOTICE[30914]: sccp_protocol.c:282 sccp_protocol_sendStaticDisplayprompt: -- SEPXXXXXXXXXXXX: Display prompt on line 0, callid 0, timeout 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Redial' on ONHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1165 sccp_softkey_setSoftkeyState: > SEPXXXXXXXXXXXX: found softkey 'Redial' at 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Confrn' on ONHOOK to on
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Join' on ONHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'ConfList' on ONHOOK to on
[2017-10-28 20:14:46] NOTICE[30914]: sccp_softkeys.c:1161 sccp_softkey_setSoftkeyState: -- SEPXXXXXXXXXXXX: softkey 'Record' on ONHOOK to off
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1380 sccp_dev_set_keyset: -- SEPXXXXXXXXXXXX: Set softkeyset to ONHOOK(0) on line 0 and call 0
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1381 sccp_dev_set_keyset: -- SEPXXXXXXXXXXXX: validKeyMask 4294967294
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message Select SoftKeys Message
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Select SoftKeys Message(0x0110) 20 bytes length
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:2015 sccp_dev_check_displayprompt: -- SEPXXXXXXXXXXXX: Finish DisplayPrompt
sccp_mwi.c :0617 (sccp_mwi_check ) ----> refcount increased 04 +> 05 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_mwi.c:687 sccp_mwi_check: -- SEPXXXXXXXXXXXX: (mwi_check) Remove Have Voicemail from Display
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:2987 sccp_device_clearMessageFromStack: > SEPXXXXXXXXXXXX: clear message stack 1
sccp_mwi.c :0617 (sccp_mwi_check ) <---- refcount decreased 04 <- 05 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:2214 sccp_dev_postregistration: -- SEPXXXXXXXXXXXX: Post registration process... done!
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1765 sccp_dev_displaynotify_debug: -- SEPXXXXXXXXXXXX: ( sccp_actions.c:258:sccp_handle_message ) sccp_dev_displaynotify 'VPBXSCCP ?' (5)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1237 sccp_dev_send: -- SEPXXXXXXXXXXXX: >> Send message Display Notify Message
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Display Notify Message(0x0114) 40 bytes length
[2017-10-28 20:14:46] NOTICE[30914]: sccp_protocol.c:320 sccp_protocol_sendStaticDisplayNotify: -- SEPXXXXXXXXXXXX: Display notify timeout 5
[2017-10-28 20:14:46] NOTICE[30914]: sccp_device.c:1774 sccp_dev_displaynotify_debug: -- SEPXXXXXXXXXXXX: Display notify with timeout 5
sccp_actions.c :0216 (sccp_handle_message ) <--- refcount decreased 03 <- 04 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:14:46] NOTICE[5834]: sccp_threadpool.c:232 sccp_threadpool_thread_do: -- (sccp_threadpool_thread_do) Let's work. num_jobs: 0, thread: 0x7f4356af8700, num_threads: 2
[2017-10-28 20:14:46] NOTICE[5834]: sccp_threadpool.c:245 sccp_threadpool_thread_do: -- (sccp_threadpool_thread_do) executing 0x38e50f0 in thread: 0x7f4356af8700
sccp_devstate.c:0098 (sccp_devstate_deviceRegistered ) ---> refcount increased 03 +> 04 for device: SEPXXXXXXXXXXXX (0x2f400b0)
sccp_devstate.c:0098 (sccp_devstate_deviceRegistered ) <--- refcount decreased 03 <- 04 for device: SEPXXXXXXXXXXXX (0x2f400b0)
sccp_hint.c :0443 (sccp_hint_deviceRegistered ) ---> refcount increased 03 +> 04 for device: SEPXXXXXXXXXXXX (0x2f400b0)
sccp_hint.c :0443 (sccp_hint_deviceRegistered ) <--- refcount decreased 03 <- 04 for device: SEPXXXXXXXXXXXX (0x2f400b0)
sccp_event.c :0081 (sccp_event_destroy ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:14:46] NOTICE[5834]: sccp_threadpool.c:219 sccp_threadpool_thread_do: -- (sccp_threadpool_thread_do) num_jobs: 0, thread: 0x7f4356af8700, num_threads: 2
[2017-10-28 20:14:46] NOTICE[5834]: sccp_threadpool.c:224 sccp_threadpool_thread_do: -- (sccp_threadpool_thread_do) Thread 0x7f4356af8700 Waiting for New Work Condition
[2017-10-28 20:15:00] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Register Available Lines Message (0x2D)
[2017-10-28 20:15:00] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Register Available Lines Message(0x002D) 16 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:15:00] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27
[2017-10-28 20:15:01] NOTICE[30914]: sccp_actions.c:241 sccp_handle_message: -- SEPXXXXXXXXXXXX: >> Got message Keep Alive Message (0x0)
[2017-10-28 20:15:01] NOTICE[30914]: sccp_actions.c:123 check_session_message_device: SEPXXXXXXXXXXXX: SCCP Handle Message: Keep Alive Message(0x0000) 12 bytes length
sccp_session.c :1224 (sccp_session_getDevice ) --> refcount increased 02 +> 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:15:01] NOTICE[30914]: sccp_session.c:1035 sccp_session_send2: SEPXXXXXXXXXXXX: Send Message: Keep Alive Acknowledge(0x0100) 4 bytes length
sccp_actions.c :0216 (sccp_handle_message ) <-- refcount decreased 02 <- 03 for device: SEPXXXXXXXXXXXX (0x2f400b0)
[2017-10-28 20:15:01] NOTICE[30914]: sccp_session.c:633 sccp_session_device_thread: > SEPXXXXXXXXXXXX: set poll timeout 48 for session 27On the configuration page buttons shows all the possible configuration button. They can be assigned to a line or empty. I may not be able now to comment on the error log chain_sccp. But we could look through CLI> sccp show devices Here you should see all devices that were able to register on the server. CLI> sccp show device SEPXXXXXX will show more details on the configuration of the device *CLI> sccp show lines It is advisable to test your settings in real-time ( chain_sccp can't get any information about the lines )
NightShift21
commented
7 years ago *CLI> sccp show devices
*CLI> sccp show device SEPXXXXXX
*CLI> sccp show lines
PhantomVl
commented
7 years ago I tried to write step by step instructions. https://github.com/PhantomVl/sccp_manager/wiki Perhaps you have something not done.
NightShift21
commented
7 years ago Ok, I think I have found the problem. In the sccpline table, every time I edit a line the "id" field increases by 1. If I manually change the "id" field to be the same as the extension number then everything seems to work. For example:
MariaDB [asterisk]> SELECT * FROM sccpline;
+----+------+-----------+-----------------+---------------+ +---------+ +------+
| id | pin | label | description | context | | mailbox | | name |
+----+------+-----------+-----------------+---------------+ +---------+ +------+
| 1 | NULL | Phone 1 | Line 1 <101> | from-internal | | 101 | | 101 |
+----+------+-----------+-----------------+---------------+ +---------+ +------+
1 row in set (0.00 sec)Does not work (No lines registered)
MariaDB [asterisk]> SELECT * FROM sccpline;
+-----+------+-----------+-----------------+---------------+ +---------+ +------+
| id | pin | label | description | context | | mailbox | | name |
+-----+------+-----------+-----------------+---------------+ +---------+ +------+
| 101 | NULL | Phone 1 | Line 1 <101> | from-internal | | 101 | | 101 |
+-----+------+-----------+-----------------+---------------+ +---------+ +------+
1 row in set (0.00 sec)Does does work (lines are registered)
PhantomVl
commented
7 years ago Today I made a page with technical information "Server Config"-> "SCCP Info". Perhaps I was also able to fix your problem. If problem not fix - send me what is displayed on the page "SCCP Info".
NightShift21
commented
7 years ago 
PhantomVl
commented
7 years ago Thanks for the help, it really was a serious bug ! I was able to understand where and what the problem is. I hope now I fixed all the dependencies associated with use of Id fields
When using Phone Manager to create a new device I get an error when saving:
In the Device Buttons tab, Buttons 0 Default is set to DEF LINE (can't be changed)