Error in CallList TR064 Binding in case of IP-Phone

Add-ons Bindings
,
1

Hello together,

using TR064 Binding with AVM Fritzbox 7490 showing active calls and last finished calls.

Averything works fine most time. But when using my IP-Telephone for an outbound call, rules do not work because of an error:

2021-08-23 09:19:24.085 [ERROR] [l.script.AVM Fritzbox 1 - Anrufliste] - JSON TYPE not defined: 11JSON komplett : [{"localNumber":null,"remoteNumber":"Büro","date":"2021-08-23T08:58:00+02","type":11,"duration":21}]

In Admin-Interface of Fritzbox the local number is shown (but in CallList null) and remoteNumber should be the called number is the internal name of my local Number configured in Fritzbox.

After Call is finished, the call listed as following (first entry) with (here anonymized) numbers like all other calls.

2021-08-23 12:53:49.154 [ERROR] [l.script.AVM Fritzbox 1 - Anrufliste] - JSON TYPE not defined: 9JSON komplett : [{"localNumber":"123456","remoteNumber":"069987654321","date":"2021-08-23T08:58:00+02","type":3,"duration":22},{"localNumber":"23456","remoteNumber":"05287654321","date":"2021-08-23T12:53:00+02","type":9,"duration":1}]

Hours later the Calllist shows correct numbers, but still gives an error of the mornings call:

2021-08-23 17:24:32.061 [ERROR] [l.script.AVM Fritzbox 1 - Anrufliste] - JSON TYPE not defined: 11JSON komplett : [{"localNumber":"123456","remoteNumber":"06123456","date":"2021-08-23T16:01:00+02","type":1,"duration":58},{"localNumber":"23456","remoteNumber":"05287654321","date":"2021-08-23T12:53:00+02","type":1,"duration":1},{"localNumber":"123456","remoteNumber":"069987654321","date":"2021-08-23T08:58:00+02","type":3,"duration":22},{"localNumber":null,"remoteNumber":"Büro","date":"2021-08-23T17:24:00+02","type":11,"duration":1}]

This null entry is interesting, because changing times over the day.

Here the calls from Fritzbox interface listed above:

||23.08.21 08:58 |069987654321 |IP-OG-Büro Büro |123456 |22 Min ||
||23.08.21 12:53 |05287654321 |DECT Wohnung |23456 |< 1 Min ||
||23.08.21 16:01 |06123456 |IP-OG-Büro Büro |123456 |58 Min ||

Question is: Is it a failure from binding? Or in Implementation of TR064 from AVM?

2

Set the binding to TRACE logging and show the raw answer received from the FritzBox.

3

Today I only got examples with short time errors.

From privacy Reasons I searched and replaced the Numbers like [MSN NR1] or [REMOTE NR1].

Here a log with the error like yesterday (inclusive rule Entries with INFO)

Because Numbers this Time allways filled, failure is only temporarily, but maybe it helps:

2021-08-24 15:12:02.925 [INFO ] [t.AVM Fritzbox 12 - Calllist refresh] - TRIGGER CallState changed or ActiveCall changed
2021-08-24 15:12:02.926 [INFO ] [pt.AVM Fritzbox 2 - New Inbound Call] - TRIGGER AFB_Call_Status changed to Ringing
2021-08-24 15:12:02.926 [INFO ] [pt.AVM Fritzbox 2 - New Inbound Call] - ...Not UNDEF -> Value: [MSN NR1],[REMOTE NR1]
2021-08-24 15:12:02.927 [INFO ] [pt.AVM Fritzbox 2 - New Inbound Call] - ......Call 1 ist frei -> [MSN NR1],[REMOTE NR1]
2021-08-24 15:12:02.928 [INFO ] [pt.AVM Fritzbox 2 - New Inbound Call] - ......Call 1 Timestamp -> 1629810722
2021-08-24 15:12:02.929 [INFO ] [pt.AVM Fritzbox 2 - New Inbound Call] - ......Suche internen Namen 
2021-08-24 15:12:02.930 [INFO ] [VM Fritzbox 9 - Call Lines-Übersicht] - TRIGGER AFB_Call1_Status or Call2_Status changed
2021-08-24 15:12:02.930 [INFO ] [pt.AVM Fritzbox 2 - New Inbound Call] - ...Suche Name zu Rufnummer [REMOTE NR1]
2021-08-24 15:12:02.931 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:02.931 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:02.932 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:02.932 [INFO ] [pt.AVM Fritzbox 2 - New Inbound Call] - ......found : [REMOTE NR1]
2021-08-24 15:12:02.933 [TRACE] [ng.tr064.internal.soap.SOAPConnector] - Request: <SOAP-ENV:Envelope xmlns:SOAP-ENV="http://schemas.xmlsoap.org/soap/envelope/" SOAP-ENV:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><SOAP-ENV:Header/><SOAP-ENV:Body><u:GetCallList xmlns:u="urn:dslforum-org:service:X_AVM-DE_OnTel:1"/></SOAP-ENV:Body></SOAP-ENV:Envelope>
2021-08-24 15:12:02.933 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:02.933 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:02.934 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:02.966 [TRACE] [ng.tr064.internal.soap.SOAPConnector] - Received response: <?xml version="1.0"?>
 <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
<s:Body>
<u:GetCallListResponse xmlns:u="urn:dslforum-org:service:X_AVM-DE_OnTel:1">
<NewCallListURL>https://192.168.10.8:49443/calllist.lua?sid=47995b0c99f583bc</NewCallListURL>
</u:GetCallListResponse>
</s:Body>
</s:Envelope>
2021-08-24 15:12:02.967 [TRACE] [ng.tr064.internal.soap.SOAPConnector] - Storing in cache: com.sun.xml.messaging.saaj.soap.ver1_1.Message1_1Impl@71c08e7a
2021-08-24 15:12:02.967 [TRACE] [ng.tr064.internal.soap.SOAPConnector] - Returning from cache: com.sun.xml.messaging.saaj.soap.ver1_1.Message1_1Impl@71c08e7a
2021-08-24 15:12:02.967 [TRACE] [hab.binding.tr064.internal.util.Util] - Refreshing cache for 'https://192.168.10.8:49443/calllist.lua?sid=47995b0c99f583bc&days=2'
2021-08-24 15:12:03.511 [TRACE] [hab.binding.tr064.internal.util.Util] - XML = <?xml version="1.0" encoding="UTF-8"?> 
<root>
<!-- days:2 -->
<!-- max:999 -->
<!-- id:nil -->
<!-- timestamp:nil -->
<!-- calls:400 -->
<timestamp>1444989601</timestamp>
<Call><Id>12280</Id><Type>3</Type><Called>[REMOTE NR1]</Called><Caller>Wohnung</Caller><CallerNumber>[MSN NR1]</CallerNumber><Name></Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 14:34</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
<Call><Id>12279</Id><Type>3</Type><Called>[REMOTE NR2]</Called><Caller>Wohnung</Caller><CallerNumber>[MSN NR1]</CallerNumber><Name>[Vorname Nachname1]</Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 12:36</Date><Duration>0:09</Duration><Count></Count><Path /></Call>
<Call><Id>12278</Id><Type>1</Type><Caller>[REMOTE NR2]</Caller><Called>Wohnung</Called><CalledNumber>[MSN NR1]</CalledNumber><Name>[Vorname Nachname1]</Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 10:14</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
<Call><Id>12277</Id><Type>3</Type><Called>[REMOTE NR2]</Called><Caller>Wohnung</Caller><CallerNumber>[MSN NR1]</CallerNumber><Name>[Vorname Nachname1]</Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 10:07</Date><Duration>0:06</Duration><Count></Count><Path /></Call>
<Call><Id>12276</Id><Type>1</Type><Caller>[REMOTE NR3]</Caller><Called>Wohnung</Called><CalledNumber>[MSN NR1]</CalledNumber><Name></Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 07:18</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
<Call><Id>12275</Id><Type>3</Type><Called>03020212311</Called><Caller>Büro</Caller><CallerNumber>[MSN NR2]</CallerNumber><Name></Name><Numbertype>sip</Numbertype><Device>IP-OG-Büro Büro</Device><Port>21</Port><Date>23.08.21 17:24</Date><Duration>0:09</Duration><Count></Count><Path /></Call>
<Call><Id>12274</Id><Type>1</Type><Caller>069505077400</Caller><Called>Büro</Called><CalledNumber>[MSN NR2]</CalledNumber><Name></Name><Numbertype>sip</Numbertype><Device>IP-OG-Büro Büro</Device><Port>21</Port><Date>23.08.21 16:01</Date><Duration>0:58</Duration><Count></Count><Path /></Call>
<Call><Id>12273</Id><Type>1</Type><Caller>[REMOTE NR1]</Caller><Called>Wohnung</Called><CalledNumber>[MSN NR1]</CalledNumber><Name></Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>23.08.21 12:53</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
<Call><Id>12272</Id><Type>3</Type><Called>06925499395</Called><Caller>Büro</Caller><CallerNumber>[MSN NR2]</CallerNumber><Name></Name><Numbertype>sip</Numbertype><Device>IP-OG-Büro Büro</Device><Port>21</Port><Date>23.08.21 08:58</Date><Duration>0:22</Duration><Count></Count><Path /></Call>
<!-- calls:0 -->
</root>

2021-08-24 15:12:03.514 [TRACE] [hab.binding.tr064.internal.util.Util] - Storing in cache org.openhab.binding.tr064.internal.dto.additions.Root@2f4c72d1
2021-08-24 15:12:03.514 [TRACE] [hab.binding.tr064.internal.util.Util] - Returning from cache: org.openhab.binding.tr064.internal.dto.additions.Root@2f4c72d1
2021-08-24 15:12:03.934 [INFO ] [t.AVM Fritzbox 2 - New Inbound Call1] - ...send Telegram Message
2021-08-24 15:12:08.640 [INFO ] [he_Licht.rules - Küchenlicht Auto an] - Bewegung gemeldet, Prüfe auf AutoModus
2021-08-24 15:12:08.640 [INFO ] [he_Licht.rules - Küchenzeile Auto an] - Bewegung gemeldet, Prüfe AutoModus, ob einschalten
2021-08-24 15:12:08.640 [INFO ] [e_Licht.rules - Küchenzeile Auto aus] - Küchenzeile bleibt trotz Bewegung aus
2021-08-24 15:12:10.351 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing 'upnpcontrol:upnpserver:4D454930-0000-1000-8001-A813747470D2' to inbox.
2021-08-24 15:12:11.296 [INFO ] [l.script.API EG_Flur_Sensor_Bewegung] - API		 sent: ON
2021-08-24 15:12:15.929 [INFO ] [t.AVM Fritzbox 12 - Calllist refresh] - TRIGGER CallState changed or ActiveCall changed
2021-08-24 15:12:15.929 [INFO ] [t.AVM Fritzbox 12 - Calllist refresh] - TRIGGER CallState changed or ActiveCall changed
2021-08-24 15:12:15.929 [INFO ] [ritzbox 4 - Inbound Call jetzt aktiv] - TRIGGER AFB_Active_Call changed (muss != UNDEF)
2021-08-24 15:12:15.930 [INFO ] [ritzbox 4 - Inbound Call jetzt aktiv] - ...Suche nun richtigen Anruf Call 1 oder 2
2021-08-24 15:12:15.930 [INFO ] [ritzbox 4 - Inbound Call jetzt aktiv] - ...(Extrahiere IDs Call 1)
2021-08-24 15:12:15.931 [INFO ] [ritzbox 4 - Inbound Call jetzt aktiv] - ...Entferne Kommata von Active Call ID
2021-08-24 15:12:15.932 [INFO ] [ritzbox 4 - Inbound Call jetzt aktiv] - ...Es ist Call 1
2021-08-24 15:12:15.933 [TRACE] [ng.tr064.internal.soap.SOAPConnector] - Request: <SOAP-ENV:Envelope xmlns:SOAP-ENV="http://schemas.xmlsoap.org/soap/envelope/" SOAP-ENV:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><SOAP-ENV:Header/><SOAP-ENV:Body><u:GetCallList xmlns:u="urn:dslforum-org:service:X_AVM-DE_OnTel:1"/></SOAP-ENV:Body></SOAP-ENV:Envelope>
2021-08-24 15:12:15.933 [INFO ] [VM Fritzbox 9 - Call Lines-Übersicht] - TRIGGER AFB_Call1_Status or Call2_Status changed
2021-08-24 15:12:15.958 [TRACE] [ng.tr064.internal.soap.SOAPConnector] - Received response: <?xml version="1.0"?>
 <s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
<s:Body>
<u:GetCallListResponse xmlns:u="urn:dslforum-org:service:X_AVM-DE_OnTel:1">
<NewCallListURL>https://192.168.10.8:49443/calllist.lua?sid=47995b0c99f583bc</NewCallListURL>
</u:GetCallListResponse>
</s:Body>
</s:Envelope>
2021-08-24 15:12:15.959 [TRACE] [ng.tr064.internal.soap.SOAPConnector] - Storing in cache: com.sun.xml.messaging.saaj.soap.ver1_1.Message1_1Impl@6f18b091
2021-08-24 15:12:15.959 [TRACE] [ng.tr064.internal.soap.SOAPConnector] - Returning from cache: com.sun.xml.messaging.saaj.soap.ver1_1.Message1_1Impl@6f18b091
2021-08-24 15:12:15.960 [TRACE] [hab.binding.tr064.internal.util.Util] - Refreshing cache for 'https://192.168.10.8:49443/calllist.lua?sid=47995b0c99f583bc&days=2'
2021-08-24 15:12:16.390 [TRACE] [hab.binding.tr064.internal.util.Util] - XML = <?xml version="1.0" encoding="UTF-8"?> 
<root>
<!-- days:2 -->
<!-- max:999 -->
<!-- id:nil -->
<!-- timestamp:nil -->
<!-- calls:399 -->
<timestamp>1444989601</timestamp>
<Call><Id>12280</Id><Type>3</Type><Called>[REMOTE NR1]</Called><Caller>Wohnung</Caller><CallerNumber>[MSN NR1]</CallerNumber><Name></Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 14:34</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
<Call><Id>12279</Id><Type>3</Type><Called>[REMOTE NR2]</Called><Caller>Wohnung</Caller><CallerNumber>[MSN NR1]</CallerNumber><Name>[Vorname Nachname1]</Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 12:36</Date><Duration>0:09</Duration><Count></Count><Path /></Call>
<Call><Id>12278</Id><Type>1</Type><Caller>[REMOTE NR2]</Caller><Called>Wohnung</Called><CalledNumber>[MSN NR1]</CalledNumber><Name>[Vorname Nachname1]</Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 10:14</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
<Call><Id>12277</Id><Type>3</Type><Called>[REMOTE NR2]</Called><Caller>Wohnung</Caller><CallerNumber>[MSN NR1]</CallerNumber><Name>[Vorname Nachname1]</Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 10:07</Date><Duration>0:06</Duration><Count></Count><Path /></Call>
<Call><Id>12276</Id><Type>1</Type><Caller>[REMOTE NR3]</Caller><Called>Wohnung</Called><CalledNumber>[MSN NR1]</CalledNumber><Name></Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 07:18</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
<Call><Id>12275</Id><Type>3</Type><Called>[REMOTE NR4]</Called><Caller>Büro</Caller><CallerNumber>[MSN NR2]</CallerNumber><Name></Name><Numbertype>sip</Numbertype><Device>IP-OG-Büro Büro</Device><Port>21</Port><Date>23.08.21 17:24</Date><Duration>0:09</Duration><Count></Count><Path /></Call>
<Call><Id>12274</Id><Type>1</Type><Caller>[REMOTE NR5]</Caller><Called>Büro</Called><CalledNumber>[MSN NR2]</CalledNumber><Name></Name><Numbertype>sip</Numbertype><Device>IP-OG-Büro Büro</Device><Port>21</Port><Date>23.08.21 16:01</Date><Duration>0:58</Duration><Count></Count><Path /></Call>
<Call><Id>12273</Id><Type>1</Type><Caller>[REMOTE NR1]</Caller><Called>Wohnung</Called><CalledNumber>[MSN NR1]</CalledNumber><Name></Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>23.08.21 12:53</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
<Call><Id>12272</Id><Type>3</Type><Called>[REMOTE NR6]</Called><Caller>Büro</Caller><CallerNumber>[MSN NR2]</CallerNumber><Name></Name><Numbertype>sip</Numbertype><Device>IP-OG-Büro Büro</Device><Port>21</Port><Date>23.08.21 08:58</Date><Duration>0:22</Duration><Count></Count><Path /></Call>
<!-- calls:1 -->
<Call><Id>12281</Id><Type>9</Type><Caller>[REMOTE NR1]</Caller><Called>Wohnung</Called><CalledNumber>[MSN NR1]</CalledNumber><Name></Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 15:12</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
</root>

2021-08-24 15:12:16.393 [TRACE] [hab.binding.tr064.internal.util.Util] - Storing in cache org.openhab.binding.tr064.internal.dto.additions.Root@607f01c9
2021-08-24 15:12:16.393 [TRACE] [hab.binding.tr064.internal.util.Util] - Returning from cache: org.openhab.binding.tr064.internal.dto.additions.Root@607f01c9
2021-08-24 15:12:16.395 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - TRIGGER - New CallList
2021-08-24 15:12:16.396 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...LastCall: Letzter begonnener Anruf der beendet wurde
2021-08-24 15:12:16.398 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...Suche Name zu Rufnummer (8) |[REMOTE NR1]|
2021-08-24 15:12:16.399 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.399 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.399 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.400 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ......found : [REMOTE NR1]
2021-08-24 15:12:16.400 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.400 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.401 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.402 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...LastFinishedCall: zuletzt beendeter Anruf
2021-08-24 15:12:16.402 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 0
2021-08-24 15:12:16.415 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 1
2021-08-24 15:12:16.425 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 2
2021-08-24 15:12:16.436 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 3
2021-08-24 15:12:16.446 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 4
2021-08-24 15:12:16.456 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 5
2021-08-24 15:12:16.467 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 6
2021-08-24 15:12:16.477 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 7
2021-08-24 15:12:16.488 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 8
2021-08-24 15:12:16.498 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Check Index: 9
2021-08-24 15:12:16.508 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...... Index: 9 changed! Treffer!
2021-08-24 15:12:16.511 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ...Suche Name zu Rufnummer (8) |[REMOTE NR1]|
2021-08-24 15:12:16.511 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.511 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.511 [TRACE] [nternal.phonebook.Tr064PhonebookImpl] - Normalized '[REMOTE NR1]' to '[REMOTE NR1]', matchString is '[SHORT REMOTE NR1]'
2021-08-24 15:12:16.512 [INFO ] [l.script.AVM Fritzbox 1 - Anrufliste] - ......found : [REMOTE NR1]
2021-08-24 15:12:16.513 [ERROR] [l.script.AVM Fritzbox 1 - Anrufliste] - JSON TYPE not defined: 9JSON komplett : [{"localNumber":"[MSN NR1]","remoteNumber":"[REMOTE NR1]","date":"2021-08-24T14:34:00+02","type":3,"duration":1},{"localNumber":"[MSN NR1]","remoteNumber":"[REMOTE NR2]","date":"2021-08-24T12:36:00+02","type":3,"duration":9},{"localNumber":"[MSN NR1]","remoteNumber":"[REMOTE NR2]","date":"2021-08-24T10:14:00+02","type":1,"duration":1},{"localNumber":"[MSN NR1]","remoteNumber":"[REMOTE NR2]","date":"2021-08-24T10:07:00+02","type":3,"duration":6},{"localNumber":"[MSN NR1]","remoteNumber":"[REMOTE NR3]","date":"2021-08-24T07:18:00+02","type":1,"duration":1},{"localNumber":"[MSN NR2]","remoteNumber":"[REMOTE NR4]","date":"2021-08-23T17:24:00+02","type":3,"duration":9},{"localNumber":"[MSN NR2]","remoteNumber":"[REMOTE NR5]","date":"2021-08-23T16:01:00+02","type":1,"duration":58},{"localNumber":"[MSN NR1]","remoteNumber":"[REMOTE NR1]","date":"2021-08-23T12:53:00+02","type":1,"duration":1},{"localNumber":"[MSN NR2]","remoteNumber":"[REMOTE NR6]","date":"2021-08-23T08:58:00+02","type":3,"duration":22},{"localNumber":"[MSN NR1]","remoteNumber":"[REMOTE NR1]","date":"2021-08-24T15:12:00+02","type":9,"duration":1}]

I think, still active Calls get new TYPES not interpretable due to the binding (nearly to the end):

<!-- calls:1 -->
<Call><Id>12281</Id><Type>9</Type><Caller>[REMOTE NR1]</Caller><Called>Wohnung</Called><CalledNumber>[MSN NR1]</CalledNumber><Name></Name><Numbertype>sip</Numbertype><Device>DECT Wohnung</Device><Port>0</Port><Date>24.08.21 15:12</Date><Duration>0:01</Duration><Count></Count><Path /></Call>
</root>

With TYPE 11 I didn’t find an example today, but I think it is the same but with an outbound call.

4

The type not defined error is from your script. There is nothing the binding can do, it just reports what it gets from the FritzBox. You need to enhance your script to deal with type 9 and 11.

The JSON just reports what the FritzBox sends, so if you get a null, the FritzBox did not provide a value. There is no way for us to find out which additional information might be available if it is not reported.

5

Looks like I really need some vacation.

I looked twice and really oversaw that.

Please excuse, taken your time and many thanks for finding my mistake

1 Like