I upgraded my computer from Windows 7 Pro to Windows 8.1 Pro. I'm using a RAS phone pbk file on my desktop to connect to 1 of our 300 sites. In Windows 7 the 300 entries work well and opened quickly. In Windows 8.1 when I try to open the same file, it takes about 5 minutes for the pbk file to open the dialog window. The processor is working hard to open the file. Using C# and DotRas project I regenerated the pbk file under Windows 8.1, but this made no difference. Looks like large custom pbk files are not support well in Windows 8.1.

Hi,

According to your description,let us know if the issue occured when you connected to all sites.

I suggest you try to connect to other site to check the result.

Also,please create a new PBK file to test it.

Regards,

I have the same problem here on Server 2012R2. I copied a .pbk file with about 70 entries from Server 2003 to Server 2012.

On Server 2003 it was opened in seconds, but now it takes about 1-3 minutes until rasphone.exe is opened.

Sometimes it just don't start and i have to double click the pbk file again.

What's wrong and what should help?

• Edited by steffr2 Friday, March 28, 2014 7:25 AM

takes about 1-3 minutes until rasphone.exe is opened.

Sounds like something that might be made apparent by ProcMon.  ; )

E.g. sounds like a timeout is too low and either the number of retries is high (which would be very obvious in a trace) or the wait between retries is too high.   <eg>

 

Good luck

Sounds like something that might be made apparent by ProcMon.  ; )

Hi Robert

I had a look with ProcMon and I saw, that rasphone.exe is writing logs to C:\Windows\tracing\svchost_RASAPI32.LOG

So I created a new .pbk phonebook with only one entry, sometimes it opens fast, but most of the time it takes about 15s. I made some logs, one when it was fast and one log where it was slow. Then I searched for differences with winmerge, but there aren't any. Only the timestamps from beginning of the log to the end differs between the two logs. One was fast (about 1-2s) and one extremely slow (up to 15s).

What's wrong with this phonebook on server 2012? I also have the problem, that the communication between the modem is really slow. It takes multiple seconds to open the communication port until it begins to dial the number (it's ISDN and with Srv 2003 it was really fast!). So the whole process to get up an ISDN connection is much slower than before.

In hope for a solution...

Regards

Stefan

So I created a new .pbk phonebook with only one entry, sometimes it opens fast, but most of the time it takes about 15s. I made some logs, one when it was fast and one log where it was slow. Then I searched for differences with winmerge, but there aren't any. Only the timestamps from beginning of the log to the end differs between the two logs. One was fast (about 1-2s) and one extremely slow (up to 15s).

I only suggested ProcMon because that's what I am most familiar with and it is easy.  I imagine a better diagnostic would be found in the Windows Performance Toolkit (e.g. xperf.exe etc.) but that would be a new adventure.  ; )

Oh.  Speaking of  "merge"...   <eg>

http://msdn.microsoft.com/en-us/library/hh448213.aspx

Have fun. 

Can somebody have a look at this:

I created a new phonebook with one entry. If I open it, the Phonebook reads multiple times the same entry.

Now imagine, if you have about 100 entries, that this will spend some time.

I think this comes from the lines "TESTDU:port is still not configured, set the default in ppblink" and " TESTDU:port is still not configured". Then it loads again the entry "TEST" until it gets a "Port configured". After this message, the phonebook is finished with loading.

Why is this error and how can I solve it? The log is from C:\Windows\tracing\rasphone_RASAPI32.LOG

I have a second Server 2012 where my big phonebook is loaded in an acceptable time (7s), and it doesn't write a log in C:\Windows\tracing\ ?!? They are exact the same hardware...

[2332] 04-01 14:31:12:522: RasEnumEntriesW
[2332] 04-01 14:31:12:522: IsPublicPhonebook=0
[2332] 04-01 14:31:12:524: ReadPhonebookFileEx: called for pbk c:\Phonebook\Test.pbk, flags 1032
[2332] 04-01 14:31:12:528: IsPublicPhonebook=0
[2332] 04-01 14:31:12:532: path=c:\Phonebook\Test.pbk
[2332] 04-01 14:31:12:536: full path=c:\Phonebook\Test.pbk
[2332] 04-01 14:31:12:538:  IsVirtualizationNeeded: return value = 0
[2332] 04-01 14:31:12:542: ENTRY: Reading "TEST"
[2332] 04-01 14:31:12:546: Reading media group "serial"
[2332] 04-01 14:31:12:548: New link format
[2332] 04-01 14:31:12:552:
DUPTEST:Port in this media
[2332] 04-01 14:31:12:554: Port=COM1
[2332] 04-01 14:31:12:558: TESTDU:port is still not configured by matching in the system ports
[2332] 04-01 14:31:12:560:     TESTDU: port Not configured from NT4 conversion
[2332] 04-01 14:31:12:562: TESTDU:port is still not configured, set the default in ppblink
[2332] 04-01 14:31:12:566: SetDefaultModemSettings(bps=0)=1
[2332] 04-01 14:31:12:568: TESTDU:port is still not configured
[2332] 04-01 14:31:12:572: Reading device group "modem"
[2332] 04-01 14:31:12:574: Device List after deleting dupe
[2332] 04-01 14:31:12:578: Device List after deleting dupe
[2332] 04-01 14:31:12:580: ReadRasFile: ReadEntryList returned 0
[2332] 04-01 14:31:12:582: ReadPhonebookFile returns 0
[2332] 04-01 14:31:12:586: RasEnumEntriesW
[2332] 04-01 14:31:12:588: IsPublicPhonebook=0
[2332] 04-01 14:31:12:592: ReadPhonebookFileEx: called for pbk c:\Phonebook\Test.pbk, flags 1032
[2332] 04-01 14:31:12:594: IsPublicPhonebook=0
[2332] 04-01 14:31:12:596: path=c:\Phonebook\Test.pbk
[2332] 04-01 14:31:12:600: full path=c:\Phonebook\Test.pbk
[2332] 04-01 14:31:12:602:  IsVirtualizationNeeded: return value = 0

[2332] 04-01 14:31:12:606: ENTRY: Reading "TEST"
[2332] 04-01 14:31:12:610: Reading media group "serial"
[2332] 04-01 14:31:12:612: New link format
[2332] 04-01 14:31:12:616:
DUPTEST:Port in this media
[2332] 04-01 14:31:12:618: Port=COM1
[2332] 04-01 14:31:12:620: TESTDU:port is still not configured by matching in the system ports
[2332] 04-01 14:31:12:624:     TESTDU: port Not configured from NT4 conversion
[2332] 04-01 14:31:12:628: TESTDU:port is still not configured, set the default in ppblink
[2332] 04-01 14:31:12:631: SetDefaultModemSettings(bps=0)=1
[2332] 04-01 14:31:12:635: TESTDU:port is still not configured
[2332] 04-01 14:31:12:637: Reading device group "modem"
[2332] 04-01 14:31:12:641: Device List after deleting dupe
[2332] 04-01 14:31:12:643: Device List after deleting dupe
[2332] 04-01 14:31:12:647: ReadRasFile: ReadEntryList returned 0
[2332] 04-01 14:31:12:649: ReadPhonebookFile returns 0
[2332] 04-01 14:31:12:653: RasGetEntryPropertiesW
[2332] 04-01 14:31:12:655: IsRasmanServiceRunning=1
[2332] 04-01 14:31:12:659: LoadRasmanDll
[2332] 04-01 14:31:12:663: GetPbkAndEntryName
[2332] 04-01 14:31:12:665: ReadPhonebookFileEx: called for pbk c:\Phonebook\Test.pbk, flags 8
[2332] 04-01 14:31:12:667: IsPublicPhonebook=0
[2332] 04-01 14:31:12:671: path=c:\Phonebook\Test.pbk
[2332] 04-01 14:31:12:673: full path=c:\Phonebook\Test.pbk
[2332] 04-01 14:31:12:675:  IsVirtualizationNeeded: return value = 0
[2332] 04-01 14:31:12:679: ENTRY: Reading "TEST"
[2332] 04-01 14:31:12:681:
Before LoadPortsList2 in ReadEntryList()
[2332] 04-01 14:31:12:685: LoadPortsList2
[2332] 04-01 14:31:12:687: GetRasPorts
[2332] 04-01 14:31:12:691: RasPortEnum...
[2332] 04-01 14:31:12:693: RasPortEnum=603,c=22
[2332] 04-01 14:31:12:697: RasPortEnum...
[2332] 04-01 14:31:12:699: RasPortEnum=0,c=22
[2332] 04-01 14:31:12:703: RasGetDevConfig
[2332] 04-01 14:31:12:715: RasGetDevConfig=603
[2332] 04-01 14:31:12:717: RasGetDevConfig
[2332] 04-01 14:31:12:729: RasGetDevConfig=0
[2332] 04-01 14:31:12:733: SanitizeUnimodemBlob: mdm prot=67506176
[2332] 04-01 14:31:12:735: Port=COM1,fHw=1,fEc=0,bps=115200,fSp=0,prot=4061000
[2332] 04-01 14:31:12:739: StringCchCopy failed due to error 0x8007007a
[2332] 04-01 14:31:12:743: LoadPortsList=0
[2332] 04-01 14:31:12:747: successfully finished LoadPortsList2 in ReadEntryList()
[2332] 04-01 14:31:12:749: Reading media group "serial"
[2332] 04-01 14:31:12:753: New link format
[2332] 04-01 14:31:12:755:
DUPTEST:Port in this media
[2332] 04-01 14:31:12:759: Port=COM1
[2332] 04-01 14:31:12:761:
Trying to match the phonebook port in the system ports
[2332] 04-01 14:31:12:765: Port configured
[2332] 04-01 14:31:12:767: SetDefaultModemSettings(bps=115200)=1
[2332] 04-01 14:31:12:769: Reading device group "modem"
[2332] 04-01 14:31:12:773: Device List after deleting dupe
[2332] 04-01 14:31:12:775: StringCchCopy failed due to error 0x8007007a
[2332] 04-01 14:31:12:779: Device List after deleting dupe
[2332] 04-01 14:31:12:781: ReadRasFile: ReadEntryList returned 0
[2332] 04-01 14:31:12:785: ReadPhonebookFile returns 0
[2332] 04-01 14:31:12:787: DuplicatePhoneNode
[2332] 04-01 14:31:12:791: DuplicateProtocolNode
[2332] 04-01 14:31:12:793: DuplicateProtocolNode
[2332] 04-01 14:31:12:797: DuplicateProtocolNode
[2332] 04-01 14:31:12:799: DuplicateProtocolNode
[2332] 04-01 14:31:12:803: DuplicateProtocolNode
[2332] 04-01 14:31:12:805: DuplicateProtocolNode
[2332] 04-01 14:31:12:809: DuplicateProtocolNode
[2332] 04-01 14:31:12:811: DuplicateProtocolNode
[2332] 04-01 14:31:12:815: DuplicateProtocolNode
[2332] 04-01 14:31:12:817: DuplicateProtocolNode
[2332] 04-01 14:31:12:821: DuplicateProtocolNode
[2332] 04-01 14:31:12:823: DuplicateProtocolNode
[2332] 04-01 14:31:12:827: DuplicateProtocolNode
[2332] 04-01 14:31:12:831: DuplicateProtocolNode
[2332] 04-01 14:31:12:833: DuplicateProtocolNode
[2332] 04-01 14:31:12:837: DuplicateProtocolNode
[2332] 04-01 14:31:12:839: DuplicateProtocolNode
[2332] 04-01 14:31:12:841: DuplicateProtocolNode
[2332] 04-01 14:31:12:845: DuplicateProtocolNode
[2332] 04-01 14:31:12:847: DuplicateProtocolNode
[2332] 04-01 14:31:12:851: DuplicateProtocolNode
[2332] 04-01 14:31:12:853: GetPbkAndEntryName. rc=0x0
[2332] 04-01 14:31:12:857: GetInstalledProtocolsEx=0xc.
[2332] 04-01 14:31:12:861: RasEnumConnectionsW
[2332] 04-01 14:31:12:863: IsRasmanServiceRunning=1
[2332] 04-01 14:31:12:867: IsRasmanServiceRunning=1
[2332] 04-01 14:31:12:881: RasEnumConnectionsW
[2332] 04-01 14:31:12:883: IsRasmanServiceRunning=1
[2332] 04-01 14:31:12:887: IsRasmanServiceRunning=

sometimes it opens fast, but most of the time it takes about 15s.

[2332] 04-01 14:31:12:522: RasEnumEntriesW

[2332] 04-01 14:31:12:887: IsRasmanServiceRunning=

So, that's one of the "sometimes" I suppose? What does one of the "most of the time" examples look like?

BTW this editor is giving me Text only, so I am going to have to see if I can convert it the HTML in an Edit. I don't have an Edit Toolbar now.

So, that's one of the "sometimes" I suppose? What does one of the "most of the time" examples look like?

Yes exactly. I created a new phonebook with 35 entries (TEST1 to TEST35) and when I open it, it takes about 30s to open it.

The Log size is around 1.5MB, I can't post it here. But it's almost the same as the example above, it tries to open the same entries multiple times.

Can somebody test this on a server 2012 machine?

I cutted out some entries with "Reading TEST1" and post it here. These are not all, only the first ones and the last one before the application starts. In summary there are 65 times entries for "Reading TEST1".

<-- BEGIN -->

RasEnumEntriesW
[104] 04-02 07:52:58:043: IsPublicPhonebook=0
[104] 04-02 07:52:58:043: ReadPhonebookFileEx: called for pbk C:\Phonebook\Test-Phonebook.pbk, flags 1032
[104] 04-02 07:52:58:043: IsPublicPhonebook=0
[104] 04-02 07:52:58:043: path=C:\Phonebook\Test-Phonebook.pbk
[104] 04-02 07:52:58:043: full path=C:\Phonebook\Test-Phonebook.pbk
[104] 04-02 07:52:58:043:  IsVirtualizationNeeded: return value = 0

[104] 04-02 07:52:58:043: ENTRY: Reading "TEST1"
[104] 04-02 07:52:58:045: Reading media group "serial"
[104] 04-02 07:52:58:045: New link format
[104] 04-02 07:52:58:045:
DUPTEST:Port in this media
[104] 04-02 07:52:58:045: Port=COM1
[104] 04-02 07:52:58:045: TESTDU:port is still not configured by matching in the system ports
[104] 04-02 07:52:58:045:     TESTDU: port Not configured from NT4 conversion
[104] 04-02 07:52:58:045: TESTDU:port is still not configured, set the default in ppblink
[104] 04-02 07:52:58:045: SetDefaultModemSettings(bps=0)=1
[104] 04-02 07:52:58:045: TESTDU:port is still not configured
[104] 04-02 07:52:58:045: Reading device group "modem"
[104] 04-02 07:52:58:045: Device List after deleting dupe
[104] 04-02 07:52:58:045: Device List after deleting dupe

[104] 04-02 07:52:58:077: ENTRY: Reading "TEST1"
[104] 04-02 07:52:58:079: Reading media group "serial"
[104] 04-02 07:52:58:079: New link format
[104] 04-02 07:52:58:079:
DUPTEST:Port in this media
[104] 04-02 07:52:58:079: Port=COM1
[104] 04-02 07:52:58:079: TESTDU:port is still not configured by matching in the system ports
[104] 04-02 07:52:58:079:     TESTDU: port Not configured from NT4 conversion
[104] 04-02 07:52:58:079: TESTDU:port is still not configured, set the default in ppblink
[104] 04-02 07:52:58:079: SetDefaultModemSettings(bps=0)=1
[104] 04-02 07:52:58:079: TESTDU:port is still not configured
[104] 04-02 07:52:58:079: Reading device group "modem"
[104] 04-02 07:52:58:079: Device List after deleting dupe
[104] 04-02 07:52:58:079: Device List after deleting dupe

[104] 04-02 07:52:58:113: ENTRY: Reading "TEST1"
[104] 04-02 07:52:58:113:
Before LoadPortsList2 in ReadEntryList()
[104] 04-02 07:52:58:113: LoadPortsList2
[104] 04-02 07:52:58:113: GetRasPorts
[104] 04-02 07:52:58:113: RasPortEnum...
[104] 04-02 07:52:58:113: RasPortEnum=603,c=22
[104] 04-02 07:52:58:113: RasPortEnum...
[104] 04-02 07:52:58:115: RasPortEnum=0,c=22
[104] 04-02 07:52:58:115: RasGetDevConfig
[104] 04-02 07:52:58:123: RasGetDevConfig=603
[104] 04-02 07:52:58:123: RasGetDevConfig
[104] 04-02 07:52:58:133: RasGetDevConfig=0
[104] 04-02 07:52:58:133: SanitizeUnimodemBlob: mdm prot=67506176
[104] 04-02 07:52:58:133: Port=COM1,fHw=1,fEc=0,bps=115200,fSp=0,prot=4061000
[104] 04-02 07:52:58:133: StringCchCopy failed due to error 0x8007007a
[104] 04-02 07:52:58:135: LoadPortsList=0
[104] 04-02 07:52:58:135: successfully finished LoadPortsList2 in ReadEntryList()
[104] 04-02 07:52:58:135: Reading media group "serial"
[104] 04-02 07:52:58:135: New link format
[104] 04-02 07:52:58:135:
DUPTEST:Port in this media
[104] 04-02 07:52:58:135: Port=COM1
[104] 04-02 07:52:58:135:
Trying to match the phonebook port in the system ports
[104] 04-02 07:52:58:135: Port configured
[104] 04-02 07:52:58:135: SetDefaultModemSettings(bps=115200)=1
[104] 04-02 07:52:58:135: Reading device group "modem"
[104] 04-02 07:52:58:135: Device List after deleting dupe
[104] 04-02 07:52:58:135: StringCchCopy failed due to error 0x8007007a
[104] 04-02 07:52:58:135: Device List after deleting dupe

[104] 04-02 07:52:58:169: ENTRY: Reading "TEST1"
[104] 04-02 07:52:58:171:
Before LoadPortsList2 in ReadEntryList()
[104] 04-02 07:52:58:171: LoadPortsList2
[104] 04-02 07:52:58:171: GetRasPorts
[104] 04-02 07:52:58:171: RasPortEnum...
[104] 04-02 07:52:58:171: RasPortEnum=603,c=22
[104] 04-02 07:52:58:171: RasPortEnum...
[104] 04-02 07:52:58:171: RasPortEnum=0,c=22
[104] 04-02 07:52:58:171: RasGetDevConfig
[104] 04-02 07:52:58:181: RasGetDevConfig=603
[104] 04-02 07:52:58:181: RasGetDevConfig
[104] 04-02 07:52:58:189: RasGetDevConfig=0
[104] 04-02 07:52:58:189: SanitizeUnimodemBlob: mdm prot=67506176
[104] 04-02 07:52:58:189: Port=COM1,fHw=1,fEc=0,bps=115200,fSp=0,prot=4061000
[104] 04-02 07:52:58:189: StringCchCopy failed due to error 0x8007007a
[104] 04-02 07:52:58:191: LoadPortsList=0
[104] 04-02 07:52:58:191: successfully finished LoadPortsList2 in ReadEntryList()
[104] 04-02 07:52:58:191: Reading media group "serial"
[104] 04-02 07:52:58:193: New link format
[104] 04-02 07:52:58:193:
DUPTEST:Port in this media
[104] 04-02 07:52:58:193: Port=COM1
[104] 04-02 07:52:58:193:
Trying to match the phonebook port in the system ports
[104] 04-02 07:52:58:193: Port configured
[104] 04-02 07:52:58:193: SetDefaultModemSettings(bps=115200)=1
[104] 04-02 07:52:58:193: Reading device group "modem"
[104] 04-02 07:52:58:193: Device List after deleting dupe
[104] 04-02 07:52:58:193: StringCchCopy failed due to error 0x8007007a
[104] 04-02 07:52:58:193: Device List after deleting dupe

[104] 04-02 07:52:58:227: ENTRY: Reading "TEST1"
[104] 04-02 07:52:58:227:
Before LoadPortsList2 in ReadEntryList()
[104] 04-02 07:52:58:227: LoadPortsList2
[104] 04-02 07:52:58:227: GetRasPorts
[104] 04-02 07:52:58:227: RasPortEnum...
[104] 04-02 07:52:58:227: RasPortEnum=603,c=22
[104] 04-02 07:52:58:227: RasPortEnum...
[104] 04-02 07:52:58:227: RasPortEnum=0,c=22
[104] 04-02 07:52:58:227: RasGetDevConfig
[104] 04-02 07:52:58:237: RasGetDevConfig=603
[104] 04-02 07:52:58:237: RasGetDevConfig
[104] 04-02 07:52:58:245: RasGetDevConfig=0
[104] 04-02 07:52:58:245: SanitizeUnimodemBlob: mdm prot=67506176
[104] 04-02 07:52:58:245: Port=COM1,fHw=1,fEc=0,bps=115200,fSp=0,prot=4061000
[104] 04-02 07:52:58:245: StringCchCopy failed due to error 0x8007007a
[104] 04-02 07:52:58:249: LoadPortsList=0
[104] 04-02 07:52:58:249: successfully finished LoadPortsList2 in ReadEntryList()
[104] 04-02 07:52:58:249: Reading media group "serial"
[104] 04-02 07:52:58:249: New link format
[104] 04-02 07:52:58:249:
DUPTEST:Port in this media
[104] 04-02 07:52:58:249: Port=COM1
[104] 04-02 07:52:58:249:
Trying to match the phonebook port in the system ports
[104] 04-02 07:52:58:249: Port configured
[104] 04-02 07:52:58:249: SetDefaultModemSettings(bps=115200)=1
[104] 04-02 07:52:58:249: Reading device group "modem"
[104] 04-02 07:52:58:249: Device List after deleting dupe
[104] 04-02 07:52:58:249: StringCchCopy failed due to error 0x8007007a
[104] 04-02 07:52:58:249: Device List after deleting dupe

[104] 04-02 07:53:26:522: ENTRY: Reading "TEST1"
[104] 04-02 07:53:26:526:
Before LoadPortsList2 in ReadEntryList()
[104] 04-02 07:53:26:528: LoadPortsList2
[104] 04-02 07:53:26:532: GetRasPorts
[104] 04-02 07:53:26:534: RasPortEnum...
[104] 04-02 07:53:26:538: RasPortEnum=603,c=22
[104] 04-02 07:53:26:542: RasPortEnum...
[104] 04-02 07:53:26:544: RasPortEnum=0,c=22
[104] 04-02 07:53:26:548: RasGetDevConfig
[104] 04-02 07:53:26:560: RasGetDevConfig=603
[104] 04-02 07:53:26:562: RasGetDevConfig
[104] 04-02 07:53:26:574: RasGetDevConfig=0
[104] 04-02 07:53:26:578: SanitizeUnimodemBlob: mdm prot=67506176
[104] 04-02 07:53:26:580: Port=COM1,fHw=1,fEc=0,bps=115200,fSp=0,prot=4061000
[104] 04-02 07:53:26:584: StringCchCopy failed due to error 0x8007007a
[104] 04-02 07:53:26:591: LoadPortsList=0
[104] 04-02 07:53:26:593: successfully finished LoadPortsList2 in ReadEntryList()
[104] 04-02 07:53:26:597: Reading media group "serial"
[104] 04-02 07:53:26:599: New link format
[104] 04-02 07:53:26:603:
DUPTEST:Port in this media
[104] 04-02 07:53:26:605: Port=COM1
[104] 04-02 07:53:26:609:
Trying to match the phonebook port in the system ports
[104] 04-02 07:53:26:611: Port configured
[104] 04-02 07:53:26:615: SetDefaultModemSettings(bps=115200)=1
[104] 04-02 07:53:26:617: Reading device group "modem"
[104] 04-02 07:53:26:621: Device List after deleting dupe
[104] 04-02 07:53:26:623: StringCchCopy failed due to error 0x8007007a
[104] 04-02 07:53:26:627: Device List after deleting dupe

<-- END -->

[104] 04-02 07:53:27:756: ReadRasFile: ReadEntryList returned 0
[104] 04-02 07:53:27:758: ReadPhonebookFile returns 0
[104] 04-02 07:53:27:762: DuplicatePhoneNode
[104] 04-02 07:53:27:764: DuplicateProtocolNode
[104] 04-02 07:53:27:768: DuplicateProtocolNode
[104] 04-02 07:53:27:770: DuplicateProtocolNode
[104] 04-02 07:53:27:774: DuplicateProtocolNode
[104] 04-02 07:53:27:778: DuplicateProtocolNode
[104] 04-02 07:53:27:780: DuplicateProtocolNode
[104] 04-02 07:53:27:784: DuplicateProtocolNode
[104] 04-02 07:53:27:786: DuplicateProtocolNode
[104] 04-02 07:53:27:790: DuplicateProtocolNode
[104] 04-02 07:53:27:792: DuplicateProtocolNode
[104] 04-02 07:53:27:796: DuplicateProtocolNode
[104] 04-02 07:53:27:800: DuplicateProtocolNode
[104] 04-02 07:53:27:802: DuplicateProtocolNode
[104] 04-02 07:53:27:806: DuplicateProtocolNode
[104] 04-02 07:53:27:808: DuplicateProtocolNode
[104] 04-02 07:53:27:812: DuplicateProtocolNode
[104] 04-02 07:53:27:814: DuplicateProtocolNode
[104] 04-02 07:53:27:818: DuplicateProtocolNode
[104] 04-02 07:53:27:822: DuplicateProtocolNode
[104] 04-02 07:53:27:824: DuplicateProtocolNode
[104] 04-02 07:53:27:828: DuplicateProtocolNode
[104] 04-02 07:53:27:830: GetPbkAndEntryName. rc=0x0
[104] 04-02 07:53:27:834: GetInstalledProtocolsEx=0xc.
[104] 04-02 07:53:27:838: RasEnumConnectionsW
[104] 04-02 07:53:27:842: IsRasmanServiceRunning=1
[104] 04-02 07:53:27:844: IsRasmanServiceRunning=1
[104] 04-02 07:53:27:866: RasEnumConnectionsW
[104] 04-02 07:53:27:870: IsRasmanServiceRunning=1
[104] 04-02 07:53:27:872: IsRasmanServiceRunning=1

• Edited by steffr2 Wednesday, April 02, 2014 6:18 AM

sometimes it opens fast, but most of the time it takes about 15s.

So, that's one of the "sometimes" I suppose? What does one of the "most of the time" examples look like?

Yes exactly. I created a new phonebook with 35 entries (TEST1 to TEST35) and when I open it, it takes about 30s to open it.

I quoted what gave me the idea that you were not giving us the more frequent case.  I thought you were implying that your single entry case most frequently had a delay associated with it?  So, I was looking for some evidence of a "15s" time difference.  Instead the time difference you showed us is only:  .365  If you are now implying that you are expecting a delay of about 1 second per entry and that is the most common case, where is it?

I cutted out some entries with "Reading TEST1" and post it here. These are not all, only the first ones and the last one before the application starts. In summary there are 65 times entries for "Reading TEST1".

I think all you need to do is show where there is delay.  So you should be able to cut out a lot more to make that clearer.

BTW it may help to show the command line that you are using.  I'm not sure if that can be inferred from the log.  It does not seem to be echoed there.  Have you tried using some of the command line switches to see if they provide any better performance?  Also, I'm wondering if rasphone.exe is the command you really want to use anyway.  E.g. it may also help to know exactly what you are trying to do with it.

 

HTH

Ok, to keep it simple:

I try to open a phonebook (*.pbk) file with double-click, not with command line. This file is automatically opened with rasphone.exe.

We use this file on a win 2012 server to dial isdn-connections for remote support. Each remote location has his own phonebook-entry (up to 100 entries at the moment).

I copied this phonebook file from the old win server 2003 where it opened in 1-2 seconds. Now if I open it on Server 2012 it takes multiple minutes.

In my last post, I shortened the phonebook to 35 connection entries with names TEST1 to TEST35.

I clearly see the problem: It's because rasphone.exe tries multiple times to open the same entry again and again. You see that in the log in my last post with the entry "TEST1".

The question is now, why it tries multiple times to open the same entry?

We use this file on a win 2012 server to dial isdn-connections for remote support. Each remote location has his own phonebook-entry (up to 100 entries at the moment).

I'm still not clear what happens after that.  E.g. if you are only opening it to dial one specific entry, rasdial.exe might be a better procedure to put in your shortcut and its performance might not have this delay, regardless of why it is there in rasphone.

Of course I can use rasdial.exe, but this is less user friendly than rasphone, because it doesn't have a GUI. The application has to be user-friendly, because it's not only me who uses this.

It doesn't solve my main problem, that the same phonebook which opens very fast on server 2003 does not on server 2012.

Hi all

today, i had the same issue, the solution is quite simple

Open an elevated command prompt and run the following command:

netsh ras set tracing * disabled

Verify it with 

netsh ras show tracing

only IpHlpSvc will left enabled

Optional: delete the huge rasapi32 Log in WINDIR\tracing

Good Luck!

edit: Tested on Windows 8.1 Pro

• Proposed as answer by Dave Truster Wednesday, September 03, 2014 9:12 AM
• Edited by Dave Truster Wednesday, September 03, 2014 9:13 AM

Hi Dave! This solution helped me, it starts now in about 10s instead of multiple minutes.

Because I couldn't wait for a solution, I wrote a Java App to use rasdial.exe. It is much faster :-)

When I double click on my rasphone.pbk file (or execute through VB.NET) I always get the Network Connection Dialog Box coming up.  This is different than the dialog box that comes up that previews the phone number, etc ( which is the Connect dialog box).  Is there a way to automatically connect without a dialog box being displayed?

Is there a way to automatically connect without a dialog box being displayed?

Try using rasdial.exe  (/? for help).