Integration with Salesforce doesnt work on Server Side conf

Discussion in 'CRM / Helpdesk / App Integration' started by Mustafabozkurt, Jan 16, 2018.

Thread Status:
Not open for further replies.
  1. Mustafabozkurt

    Joined:
    Jan 16, 2018
    Messages:
    2
    Likes Received:
    0
    Hello everyone,

    We are using Client side Salesforce integration successfully on our company. But we would like to use server sided integration with Salesforce. We followed guide https://www.3cx.com/docs/salesforce-crm-integration/ but on Web interface on a client, when a call received nothing comes from Salesforce side but the caller number shows up.

    Everything looks okay on configuration and when we checked the logs it shows something like this;

    Code:
    2018/01/16 10:12:03.715|2284|0027|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:15:02.586|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:16:01.999|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:21:32.496|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:27:40.787|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:28:29.388|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:31:56.865|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:33:30.630|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:34:19.994|2284|0003|Erro|Targeting segment is not found for target 943d9c24df74
    2018/01/16 10:46:53.247|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 10:58:28.831|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 11:01:31.427|2284|0016|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/16 11:01:31.510|2284|0003|Erro|Targeting segment is not found for target 8920aa1f2e6a
    Can anyone help us to identify the issue?
    Client sided configuration works but server side configuration doenst work at all. We would like to uninstall clients and use web client.

    Thank you..
     
  2. edossantos

    edossantos Support Team
    Staff Member 3CX Support

    Joined:
    Jun 27, 2007
    Messages:
    1,355
    Likes Received:
    108
    Hello @Mustafabozkurt,

    Enable Verbose logs for the PBX, restart the services and then call again. That will add more details to the 3cxSystemService.log file.

    Kind regards.
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
  3. Mustafabozkurt

    Joined:
    Jan 16, 2018
    Messages:
    2
    Likes Received:
    0
    2018/01/17 14:39:33.631|3336|0003|Verb|Enqueue Updated.REGISTRATION.187
    2018/01/17 14:39:33.633|3336|0006|Verb|Dequeue Updated.REGISTRATION.187
    2018/01/17 14:39:55.137|3336|0003|Verb|Enqueue Updated.REGISTRATION.9
    2018/01/17 14:39:55.141|3336|0003|Verb|Enqueue Updated.REGISTRATION.8
    2018/01/17 14:39:55.142|3336|0006|Verb|Dequeue Updated.REGISTRATION.9
    2018/01/17 14:39:55.142|3336|0006|Verb|Dequeue Updated.REGISTRATION.8
    2018/01/17 14:40:10.211|3336|0003|Verb|Enqueue Updated.REGISTRATION.42
    2018/01/17 14:40:10.212|3336|0006|Verb|Dequeue Updated.REGISTRATION.42
    2018/01/17 14:40:18.993|3336|0004|Verb|WaitingEvent for updates:60000
    2018/01/17 14:40:19.665|3336|0003|Verb|Enqueue Updated.PARAMETER.610
    2018/01/17 14:40:19.668|3336|0006|Verb|Dequeue Updated.PARAMETER.610
    2018/01/17 14:40:36.185|3336|0003|Verb|Enqueue Inserted.CONNECTION.216
    2018/01/17 14:40:36.185|3336|0003|Verb|Not processed. Number=05303432353, connection=216, state=Dialing
    2018/01/17 14:40:36.185|3336|0003|Verb|Add to processing. Number=05303432353, connection=216, state=Dialing
    2018/01/17 14:40:36.185|3336|0003|Info|ProcessActiveConnections(). Attached entries to connection:
    2018/01/17 14:40:36.185|3336|0003|Verb|LocalMatches=. Number=05303432353, connection=216, state=Dialing
    2018/01/17 14:40:36.185|3336|0003|Info|CRM: Synchronize(...) called
    2018/01/17 14:40:36.187|3336|0006|Verb|Dequeue Inserted.CONNECTION.216
    2018/01/17 14:40:36.187|3336|0015|Info|CRM: maxConcurrency=2
    2018/01/17 14:40:36.187|3336|0015|Info|CRM: making request to CRM. Number=05303432353
    2018/01/17 14:40:36.187|3336|0015|Verb|Processing scenario 'Default'.
    2018/01/17 14:40:36.187|3336|0015|Verb|Creating new HttpClient for Scenario authentication.
    2018/01/17 14:40:36.188|3336|0015|Erro|Exception during number processing: Unknown expression: Url. Part: Url.
    2018/01/17 14:40:36.188|3336|0021|Info|SQL: Synchronize(...) called. processed=False
    2018/01/17 14:40:36.188|3336|0021|Info|SQL: Looking for number: 05303432353 in SQL
    2018/01/17 14:40:36.188|3336|0021|Info|Looking for 3432353 according to Minimal Matching Strategy in 3CX
    2018/01/17 14:40:36.320|3336|0003|Verb|Enqueue Inserted.CONNECTION.217
    2018/01/17 14:40:36.322|3336|0006|Verb|Dequeue Inserted.CONNECTION.217
    2018/01/17 14:40:36.362|3336|0003|Verb|Enqueue Inserted.CONNECTION.218
    2018/01/17 14:40:36.363|3336|0006|Verb|Dequeue Inserted.CONNECTION.218
    2018/01/17 14:40:36.460|3336|0003|Verb|Enqueue Inserted.CONNECTION.219
    2018/01/17 14:40:36.460|3336|0006|Verb|Dequeue Inserted.CONNECTION.219
    2018/01/17 14:40:38.603|3336|0003|Verb|Enqueue Updated.REGISTRATION.6
    2018/01/17 14:40:38.604|3336|0006|Verb|Dequeue Updated.REGISTRATION.6
    2018/01/17 14:40:47.413|3336|0003|Verb|Enqueue Deleted.CONNECTION.216
    2018/01/17 14:40:47.416|3336|0003|Verb|Enqueue Deleted.CONNECTION.218
    2018/01/17 14:40:47.418|3336|0003|Verb|Enqueue Deleted.CONNECTION.219
    2018/01/17 14:40:47.420|3336|0003|Verb|Enqueue Deleted.CONNECTION.217
    2018/01/17 14:40:47.422|3336|0006|Verb|Dequeue Deleted.CONNECTION.216
    2018/01/17 14:40:47.422|3336|0006|Verb|Dequeue Deleted.CONNECTION.218
    2018/01/17 14:40:47.422|3336|0006|Verb|Dequeue Deleted.CONNECTION.219
    2018/01/17 14:40:47.422|3336|0006|Verb|Dequeue Deleted.CONNECTION.217
    2018/01/17 14:40:47.666|3336|0009|Trac|[CHR] Receiver.OnReadyToRead()
    2018/01/17 14:40:47.666|3336|0009|Trac|[CHR] _sock.Receive == 4
    2018/01/17 14:40:47.666|3336|0009|Trac|[CHR] Received 1975 out of 1975 bytes
    2018/01/17 14:40:47.666|3336|0009|Trac|[CHR] callOnPacketReceived()
    2018/01/17 14:40:47.666|3336|0009|Trac|[CHR] Received 1975 bytes, start parsing
    2018/01/17 14:40:47.666|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:36.182|IncomingCall|00000BF834A223D2_47|467862619333/Participant DN.10000/Line dn-name='' epname='05303432353@(Ln.10000@ISNET)'
    >467862619333/Participant DN.10000/Line dn-name='' epname='05303432353@(Ln.10000@ISNET)'
    disp_name=
    number=05303432353
    sip.contact=<sip:05303432353@213.143.226.101:5060>
    sip.from=<sip:05303432353@isnetkrmsl.net>;tag=3725178040-999667
    sip.rl_uri=sip:02129874405@192.168.16.16;user=phone
    sip.src_addr=213.143.226.101:5060
    sip.to="02129874405" <sip:02129874405@10.40.11.5:5060;user=phone>
    target=4405

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:36.183|TargetAdded|00000BF834A223D2_47|df68c56c5067/Target DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405'
    >df68c56c5067/Target DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405'
    ep.dialing=
    ep.originator.caller_num=
    ep.originator.dial=
    orig.dest=4405
    orig.party.id=467862619333

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:47.415|RouteFailed|00000BF834A223D2_47|9504ec106c5c/Route DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405' [Cancelled]
    >9504ec106c5c/Route DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405' [Cancelled]
    ep.contact=sip:4405@192.168.16.35:5060;transport=udp
    ep.disp_name=
    ep.to=
    target.party.id=df68c56c5067
    target.party.type=Target

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:47.415|RouteFailed|00000BF834A223D2_47|1965e11acb48/Route DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405' [Cancelled]
    >1965e11acb48/Route DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405' [Cancelled]
    ep.contact=sip:4405@127.0.0.1:5488;rinstance=8ea55469c19e9ce0
    ep.disp_name=
    ep.to=
    target.party.id=df68c56c5067
    target.party.type=Target

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:47.415|RouteFailed|00000BF834A223D2_47|08330b13957a/Route DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405' [Cancelled]
    >08330b13957a/Route DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405' [Cancelled]
    ep.contact=sip:4405@192.168.16.56:50419;rinstance=0-35b56f9924124c4f8537803f7b120884;ob
    ep.disp_name=
    ep.to=
    target.party.id=df68c56c5067
    target.party.type=Target

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:47.415|PartyRemoved|00000BF834A223D2_47|467862619333/None
    >467862619333/None

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:47.422|PartyRemoved|00000BF834A223D2_47|9504ec106c5c/None
    >9504ec106c5c/None

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:47.422|PartyRemoved|00000BF834A223D2_47|1965e11acb48/None
    >1965e11acb48/None

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:47.422|PartyRemoved|00000BF834A223D2_47|08330b13957a/None
    >08330b13957a/None

    2018/01/17 14:40:47.667|3336|0009|Trac|[CHR] Adding event: 2018-01-17 14:40:47.665|Disconnected|00000BF834A223D2_47|Party.???
    >Party.???
    replaced_by.chid=

    2018/01/17 14:40:47.667|3336|0009|Trac|Saving joined call:
    2018/01/17 14:40:47.667|3336|0009|Trac|Executing SQL: INSERT into cl_calls (id,start_time,end_time,is_answered,ringing_dur)
    VALUES (DEFAULT,'2018-01-17 11:40:36','2018-01-17 11:40:47',FALSE,'00:00:11.233779')
    RETURNING id
    2018/01/17 14:40:47.668|3336|0009|Trac| * Participant 467862619333/Participant DN.10000/Line dn-name='' epname='05303432353'; not answered
    2018/01/17 14:40:47.669|3336|0009|Trac|Executing SQL: INSERT into cl_party_info (id,dn_type,dn,caller_number,display_name,dn_class,firstlastname)
    VALUES (DEFAULT,1,'10000','05303432353','',0,'')
    RETURNING id
    2018/01/17 14:40:47.669|3336|0009|Trac|Executing SQL: INSERT into cl_participants (id,call_id,info_id,role,is_inbound,end_status,forward_reason,failure_reason,start_time,end_time,billing_group)
    VALUES (DEFAULT,25958,104265,1,TRUE,1,0,1,'2018-01-17 11:40:36','2018-01-17 11:40:47','')
    RETURNING id
    2018/01/17 14:40:47.670|3336|0009|Trac| * Target df68c56c5067/Target DN.4405/Extension dn-name='MUSTAFA BOZKURT' epname='Ext.4405' [Cancelled]; originated by 467862619333
    2018/01/17 14:40:47.670|3336|0009|Trac|Executing SQL: INSERT into cl_party_info (id,dn_type,dn,caller_number,display_name,dn_class,firstlastname)
    VALUES (DEFAULT,0,'4405','Ext.4405','MUSTAFA BOZKURT',0,'')
    RETURNING id
    2018/01/17 14:40:47.670|3336|0009|Trac|Executing SQL: INSERT into cl_participants (id,call_id,info_id,role,is_inbound,end_status,forward_reason,failure_reason,start_time,end_time)
    VALUES (DEFAULT,25958,104266,2,FALSE,2,0,19,'2018-01-17 11:40:36','2018-01-17 11:40:47')
    RETURNING id
    2018/01/17 14:40:47.671|3336|0009|Trac| Saving Pbx call 00000BF834A223D2_47
    2018/01/17 14:40:47.671|3336|0009|Info| #1: Seg[1/#1] 467862619333(05303432353)=>df68c56c5067(Ext.4405) (14:40:36.182..14:40:47.415) Ringing Failed_Cancelled
    2018/01/17 14:40:47.671|3336|0009|Trac|Executing SQL: INSERT into cl_segments (id,call_id,seq_order,seq_group,src_part_id,dst_part_id,start_time,end_time,type,action_id)
    VALUES (DEFAULT,25958,1,1,104265,104266,'2018-01-17 11:40:36','2018-01-17 11:40:47',1,418)
    RETURNING id
    2018/01/17 14:40:47.672|3336|0009|Trac|Executing SQL: INSERT into myphone_callhistory_v14 (idmpch14,call_id,calltype,dnowner,party_dn,party_dntype,party_name,party_callerid,start_time,end_time,end_status,end_status_hint)
    VALUES (DEFAULT,25958,1,'4405','10000',128,'','05303432353','2018-01-17 11:40:36','2018-01-17 11:40:47',5,3)
    RETURNING idmpch14
    2018/01/17 14:40:47.673|3336|0009|Info|CHReceiver_NewMissedCall called
    2018/01/17 14:40:47.676|3336|0009|Info|PUSH active=True
    2018/01/17 14:40:47.677|3336|0003|Verb|Enqueue Updated.S_MISSEDCALLSSTAT.66
    2018/01/17 14:40:47.677|3336|0031|Info|PUSH type=AndroidGcm, data=
    2018/01/17 14:40:47.677|3336|0006|Verb|Dequeue Updated.S_MISSEDCALLSSTAT.66
     
  4. edossantos

    edossantos Support Team
    Staff Member 3CX Support

    Joined:
    Jun 27, 2007
    Messages:
    1,355
    Likes Received:
    108
    From the logs, we see that the issue is the authentication. When the integration makes the authentication, Salesforce returns a parameter "instance_url" with the information to perform the following requests. In this case, it seems that the authentication is failing, and then you don't have the Url. Please check your credentials configuration.
     
    Stop hovering to collapse... Click to collapse... Hover to expand... Click to expand...
Thread Status:
Not open for further replies.