tr-064 v3.1.x (Latest Repo) Diskussion

[apollon77]

@crunchip Hast Du mal den tr-064 auf Debug log gestellt und das dann gecheckt wenn es dazu kommt? Steht dann noch was im Log oder nicht? Steht was im Log bevor er aufhört zu funktionieren?

[crunchip]

@apollon77 nein, Debug hatte ich noch nicht getestet, einzigste was ich in der Zeit zwischen 12.02 und heute gemacht hatte, war

• Adapter neu gestartet
• Fritzbox neu gestartet ( aktuellste beta drauf) das aktualisieren ging aber auch schon in den Vorversionen nicht richtig
• IoBroker neu gestartet
• Proxmox neu gestartet
  also mehr geht nicht mit Neustart`s, hätte ja mal aktualisieren sollen/müssen

[apollon77]

@crunchip Wäre interessant ob es nicht ggf daran lag das die FB neu gestartet wurde und der Adapter damit die Verbindung verloren hat und obwohl er sollte nicht neu aufgebaut hat oder so

[crunchip]

@apollon77 also Fritzbox Neustart zu dieser Uhrzeit schließe ich aus, habe aber mal das log vom 12.02 durchgesehen.
um 12:14Uhr lief Iobroker gar nicht, da hatte ich updates gemacht.
Was ich aber nicht verstehe, das aktuell gar nicht mehr aktualisiert wird.

@apollon77 sagte in tr-064 v3.1.x (Latest Repo) Diskussion:

nicht neu aufgebaut

sollte er aber doch, wenn der Adapter/Iobroker neu gestartet wird!?
was ich noch sehe, weil auch keine Sprachansage kam, ringing wird ebenfalls nicht aktualisiert (zeitstempel 12.02), jedoch
callists/inbound/json ist aktualisiert worden Zeitstempel 18.02/0:01(ist die Uhrzeit cronjob für neustart)
also, so zu sagen, werden die Anruflisten nur durch (neustart/cronjob aktualisiert), Anrufe werden nicht wahr genommen

[apollon77]

@crunchip Und wenn DU jetzt neu startest? Geht es dann wieder?

[crunchip]

@apollon77 den Adapter?
hab ich grad mal neu gestartet, Werte/Zeitstempel bleiben unverändert
ausser, wie gesagt ...json/html aus der calllists, werden dadurch aktuallisiert

[dslraser]

@crunchip
@apollon77
irgendwann zwischendurch (ist schon einige Monate her) hatte ich dieses Verhalten auch mal. Irgendwann hat einfach der DP/Adapter, ohne irgendwelche Meldungen im Log, nicht mehr aktualisiert. Auch nur aufgefallen, weil keine Ansage am ECHO mehr kam. Nach Neustart des Adapters ging es dann meistens für einige Tage, dann ging das wieder los. Ich weiß nicht mehr welche Adapterversion das war und auch nicht, ob ich seit dem ein Firmwareupdate an der Fritte gemacht habe. Den Grund konnte ich dafür auch nie finden und habe dann, genau wie Du jetzt, einen alten FritzBox Adapter benutzt, der ging immer. Dann irgendwann bin ich wieder auf die Comunity Version und nun auf der 3.1.4 und habe das Verhalten nicht mehr, aber woran es lag/liegt ?
Vielleicht noch eins, ich hatte meistens beide Versionen drauf, also auch den alten soef, aber nicht gleichzeitig laufen, nur installiert. Zu der Zeit hatte ich dieses Verhalten. Die soef Version habe ich nun nicht mehr installiert. Keine Ahnung ob es da einen Zusammenhang giebt.

[crunchip]

@dslraser
Ich hatte ja den Fritzbox Adapter laufen, jedoch damals, glaub bei Umstellung auf den js-controller 2.x, warf der Fritzbox Adapter einige Fehler und bekam ihn nicht mehr zum laufen und da ich ihn eigentlich eh nicht in Verwendung hatte, habe ich ihn gelöscht.
Das gleich, mit dem alten (soef) tr-64, dieser lief ohne Probleme, bekam ich auch nicht mehr zum laufen, mit dem Controller Update, daher der Wechsel auf den Community. Dieser lief genauso bescheiden, wie der Jetzige tr-64.
Zeitgleich hatte ich diese nicht laufen.

[apollon77]

Okj, dann bitte mal Debug Log vom Start des Adapters

[crunchip]

@apollon77
phonebook entfernt

tr-064.0	2020-02-18 23:17:40.588	info	(11366) starting. Version 3.1.4 in /opt/iobroker/node_modules/iobroker.tr-064, node: v10.19.0
tr-064.0	2020-02-18 23:17:34.891	info	(10885) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason
tr-064.0	2020-02-18 23:17:34.889	info	(10885) terminating
tr-064.0	2020-02-18 23:17:34.885	info	(10885) Got terminate signal TERMINATE_YOURSELF
tr-064.0	2020-02-18 23:17:33.381	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:17:22.779	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:17:12.179	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:17:01.580	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:17:01.370	debug	(10885) system.adapter.admin.0: logging false
tr-064.0	2020-02-18 23:16:50.968	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:16:40.372	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:16:29.763	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:16:19.142	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:16:08.556	debug	(10885) in updateAll
tr-064.0	2020-02-18 23:16:06.585	debug	(10885) callmonitor connected
tr-064.0	2020-02-18 23:16:06.553	debug	(10885) starting callmonitor

tr-064.0	2020-02-18 23:16:06.142	debug	(10885) Result Callist JSON: {"root":{"timestamp":"1463936401"}}
tr-064.0	2020-02-18 23:16:06.073	debug	(10885) Phonebook 0: {"NewPhonebookName":"Telefonbuch","NewPhonebookExtraID":"","NewPhonebookURL":"http://192.168.178.1:49000/phonebook.lua?sid=xxxxxxxxxxxxx&pbid=0"} / err=null
tr-064.0	2020-02-18 23:16:06.013	debug	(10885) Phonebook.read: NewPhonebookList=0
tr-064.0	2020-02-18 23:16:05.894	debug	(10885) Phonebook.read
tr-064.0	2020-02-18 23:16:05.893	debug	(10885) getVoIPCommonAreaCode: xxxxx
tr-064.0	2020-02-18 23:16:05.831	debug	(10885) getVoIPCommonCountryCode: 0049
tr-064.0	2020-02-18 23:16:05.742	debug	(10885) forEachConfiguredDevice
tr-064.0	2020-02-18 23:16:05.740	debug	(10885) createConfiguredDevices
tr-064.0	2020-02-18 23:16:04.372	debug	(10885) Calllist Config after normalizing: {"all":{"generateJson":true,"generateHtml":true,"maxEntries":"10","generateJSON":true,"generateHTML":true},"missed":{"generateJson":true,"generateHtml":true
tr-064.0	2020-02-18 23:16:04.345	debug	(10885) Schedule restart: 1 0 * * *
tr-064.0	2020-02-18 23:16:04.181	info	(10885) starting. Version 3.1.4 in /opt/iobroker/node_modules/iobroker.tr-064, node: v10.19.0
tr-064.0	2020-02-18 23:16:03.206	debug	(10885) statesDB connected
tr-064.0	2020-02-18 23:16:03.205	debug	(10885) States connected to redis: 127.0.0.1:9000
tr-064.0	2020-02-18 23:16:03.153	debug	(10885) States create System PubSub Client
tr-064.0	2020-02-18 23:16:03.150	debug	(10885) States create User PubSub Client
tr-064.0	2020-02-18 23:16:03.118	debug	(10885) Redis States: Use Redis connection: 127.0.0.1:9000
tr-064.0	2020-02-18 23:16:03.116	debug	(10885) objectDB connected
tr-064.0	2020-02-18 23:16:03.110	debug	(10885) Objects connected to redis: 127.0.0.1:9001
tr-064.0	2020-02-18 23:16:03.082	debug	(10885) Objects client initialize lua scripts
tr-064.0	2020-02-18 23:16:03.081	debug	(10885) Objects create User PubSub Client
tr-064.0	2020-02-18 23:16:03.079	debug	(10885) Objects create System PubSub Client
tr-064.0	2020-02-18 23:16:03.063	debug	(10885) Objects client ready ... initialize now
tr-064.0	2020-02-18 23:16:03.012	debug	(10885) Redis Objects: Use Redis connection: 127.0.0.1:9001
tr-064.0	2020-02-18 23:15:58.853	warn	(10866) Terminated (NO_ADAPTER_CONFIG_FOUND): Without reason
tr-064.0	2020-02-18 23:15:58.672	error	(10866) adapter disabled
tr-064.0	2020-02-18 23:15:57.139	debug	(10866) statesDB connected
tr-064.0	2020-02-18 23:15:57.138	debug	(10866) States connected to redis: 127.0.0.1:9000
tr-064.0	2020-02-18 23:15:57.049	debug	(10866) States create System PubSub Client
tr-064.0	2020-02-18 23:15:57.046	debug	(10866) States create User PubSub Client
tr-064.0	2020-02-18 23:15:57.021	debug	(10866) Redis States: Use Redis connection: 127.0.0.1:9000
tr-064.0	2020-02-18 23:15:57.019	debug	(10866) objectDB connected
tr-064.0	2020-02-18 23:15:57.013	debug	(10866) Objects connected to redis: 127.0.0.1:9001
tr-064.0	2020-02-18 23:15:56.983	debug	(10866) Objects client initialize lua scripts
tr-064.0	2020-02-18 23:15:56.982	debug	(10866) Objects create User PubSub Client
tr-064.0	2020-02-18 23:15:56.981	debug	(10866) Objects create System PubSub Client
tr-064.0	2020-02-18 23:15:56.975	debug	(10866) Objects client ready ... initialize now
tr-064.0	2020-02-18 23:15:56.925	debug	(10866) Redis Objects: Use Redis connection: 127.0.0.1:9001
tr-064.0	2020-02-18 23:15:52.981	info	(24440) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason
tr-064.0	2020-02-18 23:15:52.980	info	(24440) terminating
tr-064.0	2020-02-18 23:15:52.977	info	(24440) Got terminate signal TERMINATE_YOURSELF
tr-064.0	2020-02-18 22:17:44.834	info	(24440) starting. Version 3.1.4 in /opt/iobroker/node_modules/iobroker.tr-064, node: v10.19.0
tr-064.0	2020-02-18 22:17:39.232	info	(21176) Terminated (START_IMMEDIATELY_AFTER_STOP): Without reason
tr-064.0	2020-02-18 22:17:39.230	info	(21176) terminating
tr-064.0	2020-02-18 22:17:39.224	info	(21176) Got terminate signal TERMINATE_YOURSELF

[apollon77]

@crunchip Ok, er verbindet sich erfolgreich mit dem Callmonitor ... Jetzt wäre mal cool das Debug Log zu sehen wenn da ein Anruf reinkommt oder rausgeht

[crunchip]

@apollon77
ist das korrekt?

tr-064.0	2020-02-18 23:15:58.853	warn	(10866) Terminated (NO_ADAPTER_CONFIG_FOUND): Without reason

eingehend is grad bisserl ungünstig
ich teste mal ausgehend

[apollon77]

@crunchip Wenns danach tat keine Ahnung warum das kam. Kam es als DU von info auf Debug umgestellt hast?

[crunchip]

@apollon77 kann sein, das es durch umstellen/neustarten war

durchs (auf debug) stellen, wurden nun auch die DP wieder aktualisiert

hier das log
ausgehender Anruf und Gespräch angenommen

tr-064.0	2020-02-18 23:35:50.179	debug	(16737) in updateAll
tr-064.0	2020-02-18 23:35:48.796	debug	(16737) system.adapter.admin.0: logging false
tr-064.0	2020-02-18 23:35:41.757	debug	(16737) Processing call ID5631 (call.type = 3)
tr-064.0	2020-02-18 23:35:41.757	debug	(16737) Result Callist JSON: {"root":{"timestamp":"1463936401","call":{"id":"5631","type":"3","called":"xxxxxxxx","caller":"SIP: xxxxx","callernumber":"xxxxx","name":"xxxxxxx ","numbertype"
tr-064.0	2020-02-18 23:35:41.581	debug	(16737) State changed: tr-064.0.calllists.outbound.html = {"val":"<div>The last call was from at from </div><div>outbound: 216<table><tr><td>10.02.20 08:41</td><td>Isolde Unzeitig</td><td>SIP: xxxx
tr-064.0	2020-02-18 23:35:41.580	debug	(16737) State changed: tr-064.0.calllists.outbound.count = {"val":216,"ack":true,"ts":1582065341554,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065341554}
tr-064.0	2020-02-18 23:35:41.575	debug	(16737) State changed: tr-064.0.calllists.outbound.json = {"val":"[{\"id\":5631,\"type\":\"3\",\"called\":\"xxxxxxx\",\"caller\":\"SIP: xxxxx\",\"callernumber\":\"xxxxx\",\"name\":\"xxxxxx
tr-064.0	2020-02-18 23:35:41.568	debug	(16737) State changed: tr-064.0.calllists.all.html = {"val":"<div>The last call was from at from </div><div>all: 455<table><tr><td>17.02.20 13:45</td><td>xxxxxx</td><td>SIP: xxxxx</td></tr><
tr-064.0	2020-02-18 23:35:41.566	debug	(16737) State changed: tr-064.0.calllists.all.count = {"val":455,"ack":true,"ts":1582065341553,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065341553}
tr-064.0	2020-02-18 23:35:41.561	debug	(16737) State changed: tr-064.0.calllists.all.json = {"val":"[{\"id\":5631,\"type\":\"3\",\"called\":\"xxxxxxxxxxx\",\"caller\":\"SIP: xxxxx\",\"callernumber\":\"xxxxx\",\"name\":\"xxxxxxx \",
tr-064.0	2020-02-18 23:35:41.544	debug	(16737) Processing call ID5631 (call.type = 3)
tr-064.0	2020-02-18 23:35:41.543	debug	(16737) Result Callist JSON: {"root":{"timestamp":"1463936401","call":{"id":"5631","type":"3","called":"xxxxxxxxxx","caller":"SIP: xxxx","callernumber":"xxxxx","name":"xxxx ","numbertype"
tr-064.0	2020-02-18 23:35:41.238	debug	(16737) State changed: tr-064.0.callmonitor.toPauseState-0 = {"val":"end","ack":true,"ts":1582065341189,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065341189}
tr-064.0	2020-02-18 23:35:41.234	debug	(16737) State changed: tr-064.0.callmonitor.toPauseState = {"val":"end","ack":true,"ts":1582065341189,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065341189}
tr-064.0	2020-02-18 23:35:41.229	debug	(16737) State changed: tr-064.0.callmonitor.lastCall.json = {"val":"{\"caller\":\"xxxxxxxx\",\"callee\":\"xxxxxxx\",\"extension\":\"0\",\"timestamp\":\"18.02.20 23:35:07\",\"id\":\"0\",\"_type\":\"
tr-064.0	2020-02-18 23:35:41.218	debug	(16737) State changed: tr-064.0.callmonitor.lastCall.timestamp = {"val":"18.02.20 23:35:41","ack":true,"ts":1582065341188,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":158206
tr-064.0	2020-02-18 23:35:41.217	debug	(16737) State changed: tr-064.0.callmonitor.lastCall.duration = {"val":5,"ack":true,"ts":1582065341188,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065341188}
tr-064.0	2020-02-18 23:35:41.214	debug	(16737) State changed: tr-064.0.callmonitor.lastCall.calleeName = {"val":"xxxxxx ","ack":true,"ts":1582065341188,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":158206534
tr-064.0	2020-02-18 23:35:41.207	debug	(16737) State changed: tr-064.0.callmonitor.lastCall.callerName = {"val":"","ack":true,"ts":1582065341188,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065341188}
tr-064.0	2020-02-18 23:35:41.206	debug	(16737) State changed: tr-064.0.callmonitor.lastCall.timestamp = {"val":"18.02.20 23:35:07","ack":true,"ts":1582065341187,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":158206
tr-064.0	2020-02-18 23:35:41.200	debug	(16737) State changed: tr-064.0.callmonitor.lastCall.callee = {"val":"xxxxxxx","ack":true,"ts":1582065341187,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065341187}
tr-064.0	2020-02-18 23:35:41.197	debug	(16737) State changed: tr-064.0.callmonitor.lastCall.caller = {"val":"xxxxxxxxx","ack":true,"ts":1582065341186,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065341186}
tr-064.0	2020-02-18 23:35:41.183	debug	(16737) callMonitor.set: type=lastCall caller=xxxx callee=xxxxx calleeName=xxxxx
tr-064.0	2020-02-18 23:35:41.182	debug	(16737) Search number 0049xxxxxxxx in phonebook: undefined
tr-064.0	2020-02-18 23:35:41.179	debug	(16737) New Call data lastCall: {"caller":"xxx","callee":"xxxxxxxxx","extension":"0","timestamp":"18.02.20 23:35:07","id":"0","_type":"connect","callerName":"","calleeName":"xxxxxxxx ","type
tr-064.0	2020-02-18 23:35:41.179	debug	(16737) Callmonitor Raw: 18.02.20 23:35:41;DISCONNECT;0;5;
tr-064.0	2020-02-18 23:35:39.554	debug	(16737) in updateAll
tr-064.0	2020-02-18 23:35:28.889	debug	(16737) in updateAll
tr-064.0	2020-02-18 23:35:28.452	debug	(16737) State changed: tr-064.0.callmonitor.toPauseState-0 = {"val":"connect","ack":true,"ts":1582065328404,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065328404}
tr-064.0	2020-02-18 23:35:28.450	debug	(16737) State changed: tr-064.0.callmonitor.toPauseState = {"val":"connect","ack":true,"ts":1582065328403,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065328403}
tr-064.0	2020-02-18 23:35:28.446	debug	(16737) State changed: tr-064.0.callmonitor.connect.json = {"val":"{\"caller\":\"981400\",\"callee\":\"xxxxxxx\",\"extension\":\"0\",\"timestamp\":\"18.02.20 23:35:07\",\"id\":\"0\",\"_type\":\"c
tr-064.0	2020-02-18 23:35:28.445	debug	(16737) State changed: tr-064.0.callmonitor.connect.timestamp = {"val":"18.02.20 23:35:28","ack":true,"ts":1582065328398,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065
tr-064.0	2020-02-18 23:35:28.445	debug	(16737) State changed: tr-064.0.callmonitor.connect.calleeName = {"val":"xxxxxxx ","ack":true,"ts":1582065328398,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065328
tr-064.0	2020-02-18 23:35:28.444	debug	(16737) State changed: tr-064.0.callmonitor.connect.callerName = {"val":"","ack":true,"ts":1582065328398,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065328398}
tr-064.0	2020-02-18 23:35:28.436	debug	(16737) State changed: tr-064.0.callmonitor.connect.timestamp = {"val":"18.02.20 23:35:07","ack":true,"ts":1582065328397,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065
tr-064.0	2020-02-18 23:35:28.429	debug	(16737) State changed: tr-064.0.callmonitor.connect.callee = {"val":"xxxxxxxx","ack":true,"ts":1582065328396,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065328396}
tr-064.0	2020-02-18 23:35:28.428	debug	(16737) State changed: tr-064.0.callmonitor.connect.caller = {"val":"xxxxxxx","ack":true,"ts":1582065328396,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065328396}
tr-064.0	2020-02-18 23:35:28.388	debug	(16737) callMonitor.set: type=connect caller=xxxxxxx callee=xxxxxxxxx calleeName=xxxxxxxxx
tr-064.0	2020-02-18 23:35:28.386	debug	(16737) Search number 0049xxxxxxx in phonebook: undefined
tr-064.0	2020-02-18 23:35:28.383	debug	(16737) New Call data connect: {"caller":"xxxxxx","callee":"xxxxxxxxxxxxx","extension":"0","timestamp":"18.02.20 23:35:07","id":"0","_type":"outbound","callerName":"","calleeName":"xxxxxxxxxxxxx "}
tr-064.0	2020-02-18 23:35:28.381	debug	(16737) Callmonitor Raw: 18.02.20 23:35:28;CONNECT;0;0;xxxxxxxxx;
tr-064.0	2020-02-18 23:35:18.223	debug	(16737) in updateAll
tr-064.0	2020-02-18 23:35:13.153	debug	(16737) system.adapter.admin.0: logging true
tr-064.0	2020-02-18 23:35:07.589	debug	(16737) in updateAll
tr-064.0	2020-02-18 23:35:07.047	debug	(16737) State changed: tr-064.0.callmonitor.outbound.json = {"val":"{\"caller\":\"xxxxx\",\"callee\":\"xxxxxxxxxx\",\"extension\":\"0\",\"timestamp\":\"18.02.20 23:35:07\",\"id\":\"0\",\"_type\":\"
tr-064.0	2020-02-18 23:35:07.042	debug	(16737) State changed: tr-064.0.callmonitor.outbound.calleeName = {"val":"xxxxxx ","ack":true,"ts":1582065307024,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":158206530
tr-064.0	2020-02-18 23:35:07.041	debug	(16737) State changed: tr-064.0.callmonitor.outbound.id = {"val":"0","ack":true,"ts":1582065307024,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065307024}
tr-064.0	2020-02-18 23:35:07.039	debug	(16737) State changed: tr-064.0.callmonitor.outbound.timestamp = {"val":"18.02.20 23:35:07","ack":true,"ts":1582065307023,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":158206
tr-064.0	2020-02-18 23:35:07.036	debug	(16737) State changed: tr-064.0.callmonitor.outbound.extension = {"val":"0","ack":true,"ts":1582065307023,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065307023}
tr-064.0	2020-02-18 23:35:07.033	debug	(16737) State changed: tr-064.0.callmonitor.outbound.callee = {"val":"xxxxxxxxx","ack":true,"ts":1582065307022,"q":0,"from":"system.adapter.tr-064.0","user":"system.user.admin","lc":1582065307022}
tr-064.0	2020-02-18 23:35:07.019	debug	(16737) callMonitor.set: type=outbound caller=xxxxxxxx callee=xxxxxxx calleeName=xxxxxxxxxx
tr-064.0	2020-02-18 23:35:07.018	debug	(16737) Search number 0049xxxxxxx in phonebook: {"name":"xxxxxxxxxx ","normalizedName":"xxxxxxxxx","number":"0049xxxxxxx","id":"40","phonebookId":"0"}
tr-064.0	2020-02-18 23:35:07.018	debug	(16737) Search number 0049xxxxxxxxxx in phonebook: undefined
tr-064.0	2020-02-18 23:35:07.014	debug	(16737) New Call data outbound: {"caller":"xxxx","callee":"xxxxxxxxx","extension":"0","timestamp":"18.02.20 23:35:07","id":"0"}
tr-064.0	2020-02-18 23:35:07.013	debug	(16737) Callmonitor Raw: 18.02.20 23:35:07;CALL;0;0;xxxxx;xxxxxxxxxx;SIP0;
tr-064.0	2020-02-18 23:34:57.008	debug	(16737) in updateAll
tr-064.0	2020-02-18 23:34:55.054	debug	(16737) callmonitor connected
tr-064.0	2020-02-18 23:34:55.007	debug	(16737) starting callmonitor

tr-064.0	2020-02-18 23:34:54.370	debug	(16737) getVoIPCommonAreaCode: xxxxx
tr-064.0	2020-02-18 23:34:54.307	debug	(16737) getVoIPCommonCountryCode: 0049
tr-064.0	2020-02-18 23:34:54.255	debug	(16737) forEachConfiguredDevice
tr-064.0	2020-02-18 23:34:54.254	debug	(16737) createConfiguredDevices

[apollon77]

@crunchip Hm ... verstehen muss ich das nicht das es mit Debug tut und sonst nicht ?! WTF

[crunchip]

@apollon77 frag mich mal, ich versteh gar nix mehr
mal gehts, mal nicht, fällt halt immer auf, wenn keine Ansage kommt, da der trigger im script ja DP ringing ist

warum diese Meldung?, diese ist ja eigentlich meine Tel-nr. die ich angerufen habe und ist auch im Telefonbuch eingetragen.

Search number 0049xxxxxxxx in phonebook: undefined

[apollon77]

@crunchip kannst du mal auch andere States wenigstens loggen als trigger und nicht nur Ringring? Nicht das es nur an dem state liegt.

[crunchip]

@apollon77 könnte ich theoretisch, wenn ich nen passenden DP finde zum triggern, der sich auch bei eingehendem Anruf aktualisiert. so wie es jedoch momentan überblicke, aktualisiert keiner der DP´s die in Frage kommen könnten zum triggern.
Unabhängig davon, bleibt ja dennoch das Problem...das weder ein noch ausgehende Anrufe aktualisiert werden.
Die tr-064.0.calllists.xyz.json nur aktualisieren nach einem neustart.
ich sehe es ja an den Zeitstempeln ob eine Aktualisierung stattfand, aber ich beobachte das nochmal die Tage in Ruhe

[apollon77]

@crunchip genau den json hätte ich hetzt genommen weil der an sich immer aktualisiert wird.

[Latzi]

@apollon77 ich bekomme bei meinem iPhone gelegentlich die Meldung:

2020-02-19 07:12:33.622  - warn: tr-064.0 (755) forEachConfiguredDevice: in GetSpecificHostEntry 0(Latzi-iPhone/50:A6:7F:7D:FF:E2):Error: sendSOAPActionRequest Error action=GetSpecificHostEntry serviceType=urn:dslforum-org:service:Hosts:1: 500 - {"code":500}

und dabei verschwindet kurzzeitig die Anwesenheit (im Zehntelskeunden-Bereich). Ist das bekannt und kann ich dagegen etwas tun? Die Android zeigen dieses Verhalten nicht.