FJ Software

Environment:
MPE Client 1.034
MPE 1.8.6
Android 4.1.2
TB 38.2.0
TB Lightning 4.0.2.1 last updated 17.9.2015
TB MPE Extension 2.0.17 last updated 18.9.2015 (reinstalled MPE)

Vor zwei Tagen hat noch alles funktioniert. Heute nur noch Telefonbuchabgleich. Habe MPE heute neu installiert. Kein Effekt.
Vielleicht hat es was mit dem Lightning Update vom 17.9.2015 zu tun.

Debug output:
Logdatei MyPhoneExplorer
************************
Programmversion: 1.8.6
Datum: 18.09.2015

18:50:47.09 Setting Port: 999
18:50:47.09 Setting Baud: 115200
18:50:47.09 Avaiable Ports: COM1=\Device\Serial0; COM6=\Device\ssudmdm0000; COM7=\Device\ssudserd0000;
18:50:47.10 Main Load frmSplash
18:50:47.11 Load frmSplash...
18:50:47.38 Hauptfenster wird geladen
18:50:47.56 Sidebar fertig geladen
18:50:47.75 UC SMS wird geladen
18:50:47.77 UC Phonebook wird geladen
18:50:47.84 UC Phonebook fertig geladen
18:50:47.84 UC Calls wird geladen
18:50:47.88 UC Organizer wird geladen
18:50:47.93 Grid sorted: 0 Rows, Time: 0
18:50:47.95 Organizer initiated
18:50:47.95 Startpage=1
18:50:47.95 UC Filebrowser wird geladen
18:50:47.98 Cleardetails...
18:50:47.98 Cleardetails fertig
18:50:47.98 UC Filebrowser fertig geladen
18:50:47.98 UC AppBrowser wird geladen
18:50:47.99 UC Notes wird geladen
18:50:48.00 UC Calls wird geladen
18:50:48.03 Setting Lastuser: samsung GT-S6312 [354655055393865]
18:50:48.04 Lade Userdatenbank: samsung GT-S6312 [354655055393865]
18:50:48.18 Before loading Phonebook.dat
18:50:48.19 LoadDatafile: pb_metadata.xml(2106 Bytes)
18:50:48.20 LoadDatafile: Phonebook.dat(27592 Bytes)
18:50:48.20 Splitted and reformated contactdata (1032 lines)
18:50:48.23 Contactdata imported, 135 Items added
18:50:48.23 TempLuids reassigned
18:50:48.23 CheckGroups
18:50:48.23 CheckGroups ende
18:50:48.23 Phonebook.dat was loaded
18:50:48.23 Grid sorted: 0 Rows, Time: 0
18:50:48.23 SIM Contacts were loaded
18:50:48.23 RefreshSearchArray (ExactCompare=False)
18:50:48.23 RefreshSearchArray completed
18:50:48.23 Searcharray was refreshed
18:50:48.35 Grid sorted: 135 Rows, Time: 15
18:50:48.37 Contactlist was refreshed
18:50:48.37 Phonebook was loaded for User
18:50:48.37 Kontakte geladen
18:50:48.37 LoadDatafile: Calls.dat(38532 Bytes)
18:50:48.41 ParseDialedCalls needed 16ms
18:50:48.62 Grid sorted: 864 Rows, Time: 0
18:50:48.64 Grid sorted: 501 Rows, Time: 0
18:50:48.65 Grid sorted: 315 Rows, Time: 0
18:50:48.66 Grid sorted: 60 Rows, Time: 15
18:50:48.66 Anrufe geladen
18:50:48.66 Organizer LoadUser DefaultTimeColWidth=113
18:50:48.68 LoadDatafile: Organizer.dat(198628 Bytes)
18:50:48.90 LoadDatafile: cal_metadata.xml(343 Bytes)
18:50:49.03 Grid sorted: 638 Rows, Time: 15
18:50:49.04 Grid sorted: 0 Rows, Time: 0
18:50:49.04 Organizer geladen
18:50:49.04 LoadDatafile: notes_metadata.xml(114 Bytes)
18:50:49.04 Grid sorted: 0 Rows, Time: 0
18:50:49.04 Notizen geladen
18:50:49.04 Load SMS Data...
18:50:49.04 LoadDatafile: SMS.dat(40996 Bytes)
18:50:49.04 SMS - Datenbank wird geladen...
18:50:49.09 SMS Laden - Readfile: 0 Split: 0 Parse: 47 HandleMultiSMS: 0 Nachrichten: 197
18:50:49.09 LoadDatafile: SMSArchive.dat(2552 Bytes)
18:50:49.09 SMS Archiv laden - Parse: 0
18:50:49.10 Grid sorted: 78 Rows, Time: 15
18:50:49.12 Grid sorted: 0 Rows, Time: 0
18:50:49.12 Grid sorted: 87 Rows, Time: 0
18:50:49.13 Grid sorted: 0 Rows, Time: 0
18:50:49.14 Grid sorted: 6 Rows, Time: 0
18:50:49.14 RefreshList (Archive): Addrows=0 Sort=0 MenuUpdate=0 Redraw=0
18:50:49.15 Grid sorted: 181 Rows, Time: 0
18:50:49.16 Grid sorted: 181 Rows, Time: 16
18:50:49.16 RebuildThreads: AssignName=0 FirstSort=0 SetNewGroups=0 SecondSort=16 RestoreFolders=0 WholeWork=16
18:50:49.18 SMS Data Loaded...
18:50:49.18 SMS geladen
18:50:49.25 Hauptfenster fertig geladen
18:50:49.26 GotAppCommand: debug


18:50:49.36 Downloader: RC=6 BytesMax=5 URL=http://www.fjsoft.at/myphoneexplorer/version.txt
18:50:49.42 Init Android Connection for future connect via USB
18:50:49.42 RunADBCommand: start-server
18:50:53.86 ADB CommandResponse: * daemon not running. starting it now on port 5037 *
* daemon started successfully *
18:50:53.86 Run DeviceTracker
18:50:53.87 Init Tracker
18:50:53.88 Device Tracker Message: OKAY001069082e82 device

18:51:05.31 DoItemUpdate
18:51:05.35 DoItemUpdate fertig
18:51:10.06 fSync.DoSync Operation=7
18:51:10.06 fSync: Wait for frmSplash.bChecking=False
18:51:10.06 fSync Check Connection
18:51:10.08 RunADBCommand: start-server
18:51:10.25 ADB CommandResponse:
18:51:10.25 RunADBCommand: devices
18:51:10.41 ADB CommandResponse: List of devices attached
69082e82 device
18:51:10.46 RunADBCommand: -s "69082e82" forward tcp:5210 tcp:5210
18:51:10.65 ADB CommandResponse:
18:51:10.65 Try connecting to 127.0.0.1...
18:51:10.77 Connect to Android OK (127.0.0.1)
18:51:10.77 Settimeout: RT=2000 WT=500
18:51:10.77 bOpened=True
18:51:10.77 [TX]: AT+CGSN
18:51:10.86 [RX]: AT+CGSN
18:51:10.86 [RX]: 354655055393865
18:51:10.86 [RX]: OK
18:51:10.86 Settimeout: RT=15000 WT=1000
18:51:10.86 [TX]: AT*PIN?
18:51:10.88 [RX]: AT*PIN?
18:51:10.88 [RX]: *PIN: ACCESS OK,10
18:51:10.88 [RX]: OK
18:51:10.88 [TX]: ATI
18:51:10.90 [RX]: ATI
18:51:10.90 [RX]: samsung GT-S6312
18:51:10.90 [RX]: OK
18:51:10.90 [TX]: AT*APPVERSION=1.8.6
18:51:10.92 [RX]: AT*APPVERSION=1.8.6
18:51:10.92 [RX]: 16,1.0.34
18:51:10.92 [RX]: OK
18:51:10.92 [TX]: AT+CSCS="UTF-8"
18:51:10.94 [RX]: AT+CSCS="UTF-8"
18:51:10.94 [RX]: OK
18:51:10.94 [TX]: AT*ECAM=1
18:51:10.96 [RX]: AT*ECAM=1
18:51:10.96 [RX]: OK
18:51:10.96 [TX]: AT+CBC
18:51:10.98 [RX]: AT+CBC
18:51:10.98 [RX]: +CBC: 1,90
18:51:10.98 [RX]: OK
18:51:10.98 [TX]: AT+CSQ
18:51:11.00 [RX]: AT+CSQ
18:51:11.00 [RX]: +CSQ: 10,99
18:51:11.00 [RX]: OK
18:51:11.00 Alle Verbindungsaktionen beendet
18:51:11.08 fSync Show Window
18:51:11.10 Form_Activate fSync Operation=7
18:51:11.10 pSyncOrgWithApp...
18:51:11.10 Sync MPE<>Phone...
18:51:11.11 [TX]: AT+CPROT=0
18:51:11.16 [RX]: AT+CPROT=0
18:51:11.16 [RX]: CONNECT
18:51:11.16 OBEX Connect: 16384 Bytes Paketgröße, Target: IRMC-SYNC
18:51:11.16 [TX]: 80 00 13 10 00 40 00 46 00 0C 49 52 4D 43 2D 53 59 4E 43
18:51:11.80 [RX]: A0 00 18 10 00 FF FF CB 00 00 00 01 4A 00 0C 49 52 4D 43 2D 53 59 4E 43
18:51:11.80 Connection ID:1
18:51:11.80 Paketgröße: 16384, maximal möglich:65535
18:51:11.80 OBEX Connected...
18:51:11.80 Ermittle und verarbeite info.log
18:51:11.80 Settimeout: RT=20000 WT=10000
18:51:11.80 OBEX Get: telecom/cal/info.log
18:51:11.80 [TX]: 83 00 35 CB 00 00 00 01 01 00 2D 00 74 00 65 00 6C 00 65 00 63 00 6F 00 6D 00 2F 00 63 00 61 00 6C 00 2F 00 69 00 6E 00 66 00 6F 00 2E 00 6C 00 6F 00 67 00 00
18:51:12.08 [RX]: A0 00 17 49 00 14 54 6F 74 61 6C 2D 52 65 63 6F 72 64 73 3A 36 33 38
18:51:12.08 ObexGet Fertig, Returncode=A0
18:51:12.08 Info.log:
Total-Records:638
18:51:12.08 Settimeout: RT=90000 WT=10000
18:51:12.08 OBEX Get: telecom/cal/initsync
18:51:12.08 [TX]: 83 00 35 CB 00 00 00 01 01 00 2D 00 74 00 65 00 6C 00 65 00 63 00 6F 00 6D 00 2F 00 63 00 61 00 6C 00 2F 00 69 00 6E 00 69 00 74 00 73 00 79 00 6E 00 63 00 00
18:51:17.33 [RX]: 90 00 0F 48 00 0C 0D 0A 33 30 30 2F 36 33 38
18:51:17.33 [TX]: 83 00 03
18:51:18.19 [RX]: 90 00 0F 48 00 0C 0D 0A 36 33 38 2F 36 33 38
18:51:18.19 [TX]: 83 00 03
18:51:18.25 [RX]: 90 00 0F 48 00 0C 0D 0A 36 33 38 2F 36 33 38
18:51:18.25 [TX]: 83 00 03
18:51:18.75 [RX]: A0 00 03
18:51:18.75 ObexGet Fertig, Returncode=A0
18:51:18.75 Settimeout: RT=20000 WT=10000
18:51:18.75 OBEX Get: telecom/cal/metadata.xml
18:51:18.75 [TX]: 83 00 3D CB 00 00 00 01 01 00 35 00 74 00 65 00 6C 00 65 00 63 00 6F 00 6D 00 2F 00 63 00 61 00 6C 00 2F 00 6D 00 65 00 74 00 61 00 64 00 61 00 74 00 61 00 2E 00 78 00 6D 00 6C 00 00
18:51:18.77 [RX]: A0 01 5D 49 01 5A 3C 3F 78 6D 6C 20 76 65 72 73 69 6F 6E 3D 22 31 2E 30 22 20 65 6E 63 6F 64 69 6E 67 3D 22 55 54 46 2D 38 22 3F 3E 0D 0A 3C 6D 65 74 61 64 61 74 61 20 76 65 72 73 69 6F 6E 3D 22 31 2E 30 22 3E 0D 0A 3C 63 61 6C 65 6E 64 61 72 73 20 66 69 6C 74 65 72 5F 64 69 73 61 62 6C 65 64 3D 22 31 22 3E 0D 0A 3C 63 61 6C 65 6E 64 61 72 20 73 65 6C 65 63 74 65 64 3D 22 31 22 20 64 65 66 61 75 6C 74 3D 22 31 22 20 75 72 6C 3D 22 4D 79 20 63 61 6C 65 6E 64 61 72 40 4C 4F 43 41 4C 2F 4E 55 4C 4C 22 20 74 69 74 6C 65 3D 22 4D 79 20 63 61 6C 65 6E 64 61 72 22 20 63 6F 6C 6F 72 3D 22 46 46 30 34 42 35 46 46 22 20 68 69 64 64 65 6E 3D 22 30 22 20 74 69 6D 65 7A 6F 6E 65 3D 22 6E 75 6C 6C 22 20 61 63 63 65 73 73 5F 6C 65 76 65 6C 3D 22 37 30 30 22 2F 3E 0D 0A 3C 2F 63 61 6C 65 6E 64 61 72 73 3E 0D 0A 3C 74 61 73 6B 73 75 70 70 6F 72 74 3E 31 3C 2F 74 61 73 6B 73 75 70 70 6F 72 74 3E 0D 0A 3C 74 61 73 6B 5F 63 61 74 65 67 6F 72 69 65 73 3E 0D 0A 3C 2F 74 61 73 6B 5F 63 61 74 65 67 6F 72 69 65 73 3E 0D 0A 3C 2F 6D 65 74 61 64 61 74 61 3E
18:51:18.77 ObexGet Fertig, Returncode=A0
18:51:18.77 SaveDatafile: cal_metadata.xml (343 Bytes)
18:51:18.78 LoadDatafile: cal_metadata.xml(343 Bytes)
18:51:18.79 OBEX Get: telecom/cal/luid/cc.Log
18:51:18.79 [TX]: 83 00 3B CB 00 00 00 01 01 00 33 00 74 00 65 00 6C 00 65 00 63 00 6F 00 6D 00 2F 00 63 00 61 00 6C 00 2F 00 6C 00 75 00 69 00 64 00 2F 00 63 00 63 00 2E 00 4C 00 6F 00 67 00 00
18:51:18.81 [RX]: A0 00 0A 49 00 07 31 31 38 36
18:51:18.81 ObexGet Fertig, Returncode=A0
18:51:18.81 OldChangeCounter=1186, CurrentChangeCounter=1186
18:51:18.81 Download Changelog...
18:51:18.81 OBEX Get: telecom/cal/luid/1186.log
18:51:18.81 [TX]: 83 00 3F CB 00 00 00 01 01 00 37 00 74 00 65 00 6C 00 65 00 63 00 6F 00 6D 00 2F 00 63 00 61 00 6C 00 2F 00 6C 00 75 00 69 00 64 00 2F 00 31 00 31 00 38 00 36 00 2E 00 6C 00 6F 00 67 00 00
18:51:18.88 [RX]: A0 00 19 49 00 16 54 6F 74 61 6C 2D 52 65 63 6F 72 64 73 3A 36 33 38 0D 0A
18:51:18.88 ObexGet Fertig, Returncode=A0
18:51:18.88 Changelog:
Total-Records:638

18:51:18.88 Current ChangeCounter:1186 Old ChangeCounter:1186
18:51:18.88 Sync MPE<>Phone fertig
18:51:18.88 SO.InitApplication...
18:51:18.88 SyncObject.InitApplication (Thunderbird)...
18:51:18.88 MozillaApp InitApplication...
18:51:18.89 Path to MozillaApp-Profiles = C:\Users\hpcraith\AppData\Roaming\Thunderbird\profiles.ini
18:51:18.89 Path to MozillaApp = C:\Program Files (x86)\Mozilla Thunderbird\thunderbird.exe
18:51:18.89 CheckNewExtensionManager=True 38.2.0esrpre C:\Program Files (x86)\Mozilla Thunderbird\thunderbird.exe
18:51:18.89 SyncObject.InitApplication OK, Return=True
18:51:18.89 SO.InitApplication OK
18:51:18.89 MozillaApp GetAllEvents...
18:51:18.89 MozillaApp CheckProfile...
18:51:18.89 MozillaApp Checkrunning...
18:51:18.90 MozillaApp CheckPluginVersion...
18:51:18.90 GetPluginVersion from C:\Users\hpcraith\AppData\Roaming\Thunderbird\Profiles\iqrib9ui.default\extensions\myphoneexplorer@fjsoft.at\install.rdf
18:51:18.90 GetPluginVersion=2000017
18:51:18.90 MozillaApp Edit INI-File: C:\Users\hpcraith\AppData\Roaming\Thunderbird\profiles.ini
18:51:18.91 MozillaApp CheckProfile = True
18:51:18.91 Checking Settings...
18:51:18.91 DoMozillaCommand, Argument=export-items
18:51:18.91 Timeout=10000ms Setting Timeout=10s
18:51:18.91 Shell call: "C:\Program Files (x86)\Mozilla Thunderbird\thunderbird.exe" -mpe export-items
18:51:19.13 "C:\Program Files (x86)\Mozilla Thunderbird\thunderbird.exe" -mpe export-items executed...
18:51:29.13 Loop Finished, Success=False
18:51:29.13 MozillaApp Restore Old Settings
18:51:29.13 MozillaApp Old Settings restored
18:51:29.13 ErrMsg: Einträge konnten nicht aus Thunderbird gelesen werden!
18:51:34.01 OBEX Disconnect
18:51:34.01 Settimeout: RT=10000 WT=10000
18:51:34.01 [TX]: 81 00 08 CB 00 00 00 01
18:51:34.06 [RX]: A0 00 03
18:51:34.06 Disconnect answered...
18:51:34.06 Disconnect hat funktioniert
18:51:34.06 Grid sorted: 0 Rows, Time: 0
18:51:34.06 DoItemUpdate
18:51:34.10 DoItemUpdate fertig
18:51:38.14 Terminate Subclass
18:51:38.15 Terminate ADO
18:51:38.15 Unload Iconlib
18:51:38.15 Terminate Tray
18:51:38.15 Killing temporary Files
18:51:38.15 Terminate: Calls
18:51:38.15 Terminate: PB
18:51:38.16 SaveDatafile: Phonebook.dat (27592 Bytes)
18:51:38.17 Terminate: Notes
18:51:38.17 Terminate: Organizer
18:51:38.25 SaveDatafile: Organizer.dat (198628 Bytes)
18:51:38.26 Terminate: SMS
18:51:38.26 ClosePort
18:51:38.26 Androidsocket wird geschlossen 7
18:51:38.26 Port wurde geschlossen
18:51:38.27 Form_QueryUnload -> Ende
18:51:38.27 Unload: frmSplash
18:51:38.27 Unload: fSocket
18:51:38.28 RunADBCommand: kill-server
18:51:38.46 ADB CommandResponse:
18:51:38.46 Form_Unload -> Ende

Ich hatte bisher nie ein Problem.

Gruß
Dieter

Hallo,
versuche mal Thunderbird neu in MPE einzubinden!
Eine Neuinstllation von Thunderbird könnte ebenso helfen.

Gruß icke

Habe das alles schon versucht. Ohne Erfolg.
Gibts da eine Debugmöglichkeit? Man müßte doch herausfinden können,
was nicht gelesen werden kann.
Gruß

Hallo,
Hier beginnt der Fehler... korrekt wäre... und dann fehlen bei Dir 4 Zeilen Ich kann Dir nicht helfen, wende Dich bitte per Mail (mit einem Link auf diesen Thread)an FJ .

Gruß icke

Danke für den Hinweis. Ich habe eine Mail an fj.wechselberger@gmx.at
geschickt.
Gruß
Dieter

Hallo Dieter,
versuche mal folgendes :
MPE => F2 => Synchronisierung=> Termine un Aufgaben/Erweitert=> "Interface-Timeout" => statt 10 auf 30 sec setzen

Falls das auch nichts bringt sende bitte FJ, nachdem der Fehler aufgetreten ist, den Inhalt der Thunderbird-Fehlerkonsole (STRG +Shift+ J) noch zu.
Beziehe Dich bitte wieder auf diesenThread, damit FJ das eindeutig zuordnen kann.

Gruß icke

Das hochsetzen des Timeouts brachte nix.
Die Thunderbird Fehlerkonsole zeigte keine Fehler.
Ich habe dann in meiner Verzweiflung folgendes probiert:
Ich habe 9 Kalender, die alle von meinem caldav Server bedient werden.
Ich nehme aber an, daß MPE nur die lokale Kopie ausliest.
Ich habe dann in MPE->Einstellungen->Termine und Aufgaben->Thunderbird->Erweitert Alle Kalender bis auf einen deselektiert.
Und siehe da, es funktionierte wieder. Dann habe ich Kalender für Kalender wieder eingeschaltet und es funktionierte, bis ich den vorletzten (calendar) wieder selektierte. Dann gabs wieder den Fehler. Dieser ist aber bedeutungslos.
Heute habe ich alle Kalender (auch calendar) eingeschaltet und die Synchronisierung funktioniert.
Fazit: Der Fehler ist verschwunden und ich weiß nicht warum.
Kann einem etwas schlimmeres passieren?! Dieser Thread muß also pausieren, bis der Fehler wieder auftritt. Wenn es weitere Debug Möglichkeiten gäbe, wäre das natürlich hilfreich.
Wenn es Sinn macht, meine Antwort an FJ weiterzuleiten, würde ich das dann noch tun.
Gruß
Dieter

Hi Dieter,

hpcraith hat geschrieben:Ich habe 9 Kalender, die alle von meinem caldav Server bedient werden.

Schön, dass Du uns das noch mitteilst

hpcraith hat geschrieben:Ich nehme aber an, daß MPE nur die lokale Kopie ausliest.

Na ja, ich nehme an, dass MPE alle Kalender ausliest und synchronisiert, die Du unter MPE => F2 => Sychronisation => Termine und Aufgaben / Synchronisieren mit => Erweitert => "Zu synchronisierender Ordner" aktiviert hast.
Bitte kontrolliere auch die Kalender unter Handy => MPE-Client => Einstellungen =>Zu Synchronisierende Kalender, die Du aktviert hast

Sind mehrere Kalender aktiviert sollten die auch eindeutig zugeordnet werden => Kalenderzuordnung mit mehreren Kalendern

Beachte bitte, dass es zu keiner rekursiven Synchronisation kommen kann.
D.h. Onlinekalender die in Thunderbird über den Server synchronisiert werden, auf keinen Fall Online mit dem Handy und mit MPE synchronisieren! Dann ist das von Dir beschriebene Fehlverhalten temporär vorprogrammiert

Schönes WE
Gruß icke