Bug #71692 [NEW]: imap_open() successful, but very slow with Win I/O errs
| From: | charles dot gebhard at gmail dot com | Date: | Mon, 29 Feb 2016 20:53:26 +0000 |
| Subject: | Bug #71692 [NEW]: imap_open() successful, but very slow with Win I/O errs | ||
| Groups: | php.bugs | ||
| Request: | Send a blank email to php-bugs+get-199535@lists.php.net to get a copy of this message | ||
From: charles dot gebhard at gmail dot com
Operating system: Windows 8.1
PHP version: 5.6.18
Package: IMAP related
Bug Type: Bug
Bug description:imap_open() successful, but very slow with Win I/O errs
Description:
------------
Connecting via imap_open() to outlook.office365.com (and other hosts)
takes over 7 seconds from Windows OS only. The same script below works
quickly on Linux & OpenBSD.
Test script:
---------------
$start = time();
imap_open(
'{outlook.office365.com:143}',
'xxx@yyy.com',
'password',
null,
1,
['DISABLE_AUTHENTICATOR' => ['GSSAPI','NTLM']] // used with and
without
this param
);
print_r(imap_errors()); // none returned
print_r(imap_alerts()); // none retured
die("Time " . (time() - $start) . " seconds\n");
Expected result:
----------------
Time 0 seconds
or 1 second at most.
Actual result:
--------------
Time 8 seconds.
I used NtTrace to find the slowness. There are lots of errors/warnings,
but I'm not sure what is relevant. Below is an excerpt of where things
slow down. Full debug log is attached at patch.
...
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92bc6c [0x338],
DesiredAccess=KEY_READ, ObjectAttributes=0x334:"EncodingType 1",
OpenOptions=0 ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92bc6c, DesiredAccess=KEY_READ,
ObjectAttributes=0x338:"CryptDllVerifyEncodedSignature", OpenOptions=0 )
=> 0xc0000034 [2 'The system cannot find the file specified.']
21:42:37.729: NtClose( Handle=0x338 ) => 0
21:42:37.729: NtEnumerateKey( KeyHandle=0x334, Index=2,
KeyInformationClass=0 [KeyBasicInformation], KeyInformation=0x92b87c,
Length=0x120, ResultLength=0x92b874 ) => 0x8000001a [259 'No more data
is available.']
21:42:37.729: NtClose( Handle=0x334 ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92bc80 [0x334],
DesiredAccess=KEY_READ,
ObjectAttributes=0x4c:"Software\Microsoft\Cryptography\OID",
OpenOptions=0 ) => 0
21:42:37.729: NtEnumerateKey( KeyHandle=0x334, Index=0,
KeyInformationClass=0 [KeyBasicInformation], KeyInformation=0x92b840,
Length=0x120, ResultLength=0x92b838 [0x2c] ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92bc30 [0x338],
DesiredAccess=KEY_READ, ObjectAttributes=0x334:"EncodingType 0",
OpenOptions=0 ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92bc30, DesiredAccess=KEY_READ,
ObjectAttributes=0x338:"CryptDllImportPublicKeyInfoEx2", OpenOptions=0 )
=> 0xc0000034 [2 'The system cannot find the file specified.']
21:42:37.729: NtClose( Handle=0x338 ) => 0
21:42:37.729: NtEnumerateKey( KeyHandle=0x334, Index=1,
KeyInformationClass=0 [KeyBasicInformation], KeyInformation=0x92b840,
Length=0x120, ResultLength=0x92b838 [0x2c] ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92bc30 [0x338],
DesiredAccess=KEY_READ, ObjectAttributes=0x334:"EncodingType 1",
OpenOptions=0 ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92bc30, DesiredAccess=KEY_READ,
ObjectAttributes=0x338:"CryptDllImportPublicKeyInfoEx2", OpenOptions=0 )
=> 0xc0000034 [2 'The system cannot find the file specified.']
21:42:37.729: NtClose( Handle=0x338 ) => 0
21:42:37.729: NtEnumerateKey( KeyHandle=0x334, Index=2,
KeyInformationClass=0 [KeyBasicInformation], KeyInformation=0x92b840,
Length=0x120, ResultLength=0x92b838 ) => 0x8000001a [259 'No more data
is available.']
21:42:37.729: NtClose( Handle=0x334 ) => 0
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x1a4, Event=0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92bbdc,
IoControlCode=0x00390402, InputBuffer=0x92bc80, InputBufferLength=0x38,
OutputBuffer=0x92bbfc, OutputBufferLength=8 ) => 0x80000005 [234 'More
data is available.']
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x1a4, Event=0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92bbdc [0/0x118],
IoControlCode=0x00390402, InputBuffer=0x92bc80, InputBufferLength=0x38,
OutputBuffer=0x2fa4520, OutputBufferLength=0x118 ) => 0
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x1a4, Event=0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92bb80,
IoControlCode=0x00390402, InputBuffer=0x92bc24, InputBufferLength=0x40,
OutputBuffer=0x92bba0, OutputBufferLength=8 ) => 0x80000005 [234 'More
data is available.']
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x1a4, Event=0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92bb80 [0/0xe0],
IoControlCode=0x00390402, InputBuffer=0x92bc24, InputBufferLength=0x40,
OutputBuffer=0x2fa4728, OutputBufferLength=0xe0 ) => 0
21:42:37.729: NtAllocateVirtualMemory( ProcessHandle=-1,
lpAddress=0x92bb28 [0x02fa6000], ZeroBits=0, pSize=0x92bb40 [0x2000],
flAllocationType=0x1000, flProtect=4 ) => 0
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x1a4, Event=0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92bd14,
IoControlCode=0x00390402, InputBuffer=0x92bdb8, InputBufferLength=0x40,
OutputBuffer=0x92bd34, OutputBufferLength=8 ) => 0x80000005 [234 'More
data is available.']
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x1a4, Event=0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92bd14 [0/0xe0],
IoControlCode=0x00390402, InputBuffer=0x92bdb8, InputBufferLength=0x40,
OutputBuffer=0x2fa4828, OutputBufferLength=0xe0 ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92c284 [0x334],
DesiredAccess=KEY_READ,
ObjectAttributes=0x4c:"Software\Microsoft\Cryptography\OID",
OpenOptions=0 ) => 0
21:42:37.729: NtEnumerateKey( KeyHandle=0x334, Index=0,
KeyInformationClass=0 [KeyBasicInformation], KeyInformation=0x92be44,
Length=0x120, ResultLength=0x92be3c [0x2c] ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92c234 [0x338],
DesiredAccess=KEY_READ, ObjectAttributes=0x334:"EncodingType 0",
OpenOptions=0 ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92c234, DesiredAccess=KEY_READ,
ObjectAttributes=0x338:"CertDllVerifyCertificateChainPolicy",
OpenOptions=0 ) => 0xc0000034 [2 'The system cannot find the file
specified.']
21:42:37.729: NtClose( Handle=0x338 ) => 0
21:42:37.729: NtEnumerateKey( KeyHandle=0x334, Index=1,
KeyInformationClass=0 [KeyBasicInformation], KeyInformation=0x92be44,
Length=0x120, ResultLength=0x92be3c [0x2c] ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92c234 [0x338],
DesiredAccess=KEY_READ, ObjectAttributes=0x334:"EncodingType 1",
OpenOptions=0 ) => 0
21:42:37.729: NtOpenKeyEx( KeyHandle=0x92c234, DesiredAccess=KEY_READ,
ObjectAttributes=0x338:"CertDllVerifyCertificateChainPolicy",
OpenOptions=0 ) => 0xc0000034 [2 'The system cannot find the file
specified.']
21:42:37.729: NtClose( Handle=0x338 ) => 0
21:42:37.729: NtEnumerateKey( KeyHandle=0x334, Index=2,
KeyInformationClass=0 [KeyBasicInformation], KeyInformation=0x92be44,
Length=0x120, ResultLength=0x92be3c ) => 0x8000001a [259 'No more data
is available.']
21:42:37.729: NtClose( Handle=0x334 ) => 0
21:42:37.729: NtAllocateVirtualMemory( ProcessHandle=-1,
lpAddress=0x92c14c [0x02fa8000], ZeroBits=0, pSize=0x92c164 [0x5000],
flAllocationType=0x1000, flProtect=4 ) => 0
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92bd8c [0/0x1c],
IoControlCode=0x00012024, InputBuffer=0x92bdf0, InputBufferLength=0x28,
OutputBuffer=0x92bdf0, OutputBufferLength=0x28 ) => 0
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92be50 [0/0x35],
IoControlCode=0x0001201f, InputBuffer=0x92be38, InputBufferLength=0x10,
OutputBuffer=null, OutputBufferLength=0 ) => 0
21:42:37.729: NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92bd50,
IoControlCode=0x00012024, InputBuffer=0x92bdb4, InputBufferLength=0x28,
OutputBuffer=0x92bdb4, OutputBufferLength=0x28 ) => 0x103 [997
'Overlapped I/O operation is in progress.']
21:42:37.776: NtWaitForSingleObject( Handle=0xf0, Alertable=true,
Timeout=0x92bd10 [-5e+006] ) => 0
21:42:37.776: NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92be14 [0/0xb5],
IoControlCode=0x00012017, InputBuffer=0x92bdfc, InputBufferLength=0x10,
OutputBuffer=null, OutputBufferLength=0 ) => 0
21:42:37.776: NtWaitForSingleObject( Handle=0xa4, Alertable=false,
Timeout=0x92be68 [0] ) => 0x102 [1460 'This operation returned because
the timeout period expired.']
21:42:37.776: NtWaitForSingleObject( Handle=0xb0, Alertable=false,
Timeout=0x92b54c [0] ) => 0x102 [1460 'This operation returned because
the timeout period expired.']
21:42:37.776: NtCreateEvent( EventHandle=0x92b01c [0x334],
DesiredAccess=DELETE|READ_CONTROL|WRITE_DAC|WRITE_OWNER|SYNCHRONIZE|0x3,
ObjectAttributes=null, EventType=1 [SynchronizationEvent],
InitialState=false ) => 0
21:42:37.776: NtDeviceIoControlFile( FileHandle=0xf8, Event=0x334,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92b06c [0/0x68],
IoControlCode=0x0012000f, InputBuffer=0x92b0a8, InputBufferLength=0x38,
OutputBuffer=0x92b0a8, OutputBufferLength=0x38 ) => 0
21:42:37.776: NtClose( Handle=0x334 ) => 0
21:42:37.792: NtAlpcSendWaitReceivePort( PortHandle=0xfc,
SendFlags=0x40020000, SendMessage=0x2f5cd58 [2 [LPC_REPLY] (64b)],
InMessageBuffer=0x2fa2950, ReceiveBuffer=0x2f5cd58,
ReceiveBufferSize=0x92ac54 [0x68], OutMessageBuffer=0x2fa2950,
Timeout=null ) => 0 21:42:37.792: NtOpenKeyEx( KeyHandle=0x92b004
[0x334], DesiredAccess=KEY_READ,
ObjectAttributes=0x4c:"SYSTEM\CurrentControlSet\Services\NetBT\Linkage",
OpenOptions=0 ) => 0 21:42:37.792: NtQueryValueKey( KeyHandle=0x334,
ValueName="Export", KeyValueInformationClass=2
[KeyValuePartialInformation], KeyValueInformation=0x92ae9c, Length=0x90,
ResultLength=0x92ae78 ) => 0x80000005 [234 'More data is available.']
21:42:37.792: NtQueryValueKey( KeyHandle=0x334, ValueName="Export",
KeyValueInformationClass=2 [KeyValuePartialInformation],
KeyValueInformation=0x92ae9c, Length=0x90, ResultLength=0x92ae78 ) =>
0x80000005 [234 'More data is available.'] 21:42:37.792:
NtQueryValueKey( KeyHandle=0x334, ValueName="Export",
KeyValueInformationClass=2 [KeyValuePartialInformation],
KeyValueInformation=0x2f601d8, Length=0x352, ResultLength=0x92ae78
[0x352] ) => 0 21:42:37.792: NtClose( Handle=0x334 ) => 0 21:42:37.792:
NtAllocateVirtualMemory( ProcessHandle=-1, lpAddress=0x92ac48
[0x00ec2000], ZeroBits=0, pSize=0x92ac60 [0x3000],
flAllocationType=0x1000, flProtect=4 ) => 0 21:42:37.792: NtCreateFile(
FileHandle=0xec0d3c, DesiredAccess=GENERIC_READ,
ObjectAttributes="\Device\NetBT_Tcpip_{8C417BCD-EF32-4EDE-9480-B1BF4E5BDC83}",
IoStatusBlock=0x92afe0, AllocationSize=null, FileAttributes=0,
ShareAccess=3, CreateDisposition=3, CreateOptions=0, EaBuffer=null,
EaLength=0 ) => 0xc0000034 [2 'The system cannot find the file
specified.'] 21:42:37.792: NtCreateFile( FileHandle=0xec0d3c [0x334],
DesiredAccess=GENERIC_READ,
ObjectAttributes="\Device\NetBT_Tcpip_{774F75B1-D995-4095-9952-8D33AA602645}",
IoStatusBlock=0x92afe0 [0/0], AllocationSize=null, FileAttributes=0,
ShareAccess=3, CreateDisposition=3, CreateOptions=0, EaBuffer=null,
EaLength=0 ) => 0 21:42:37.792: NtCreateFile( FileHandle=0xec11ec,
DesiredAccess=GENERIC_READ,
ObjectAttributes="\Device\NetBT_Tcpip6_{0D60388E-D7F7-41E3-9D1F-BB0A63D35523}",
IoStatusBlock=0x92afe0, AllocationSize=null, FileAttributes=0,
ShareAccess=3, CreateDisposition=3, CreateOptions=0, EaBuffer=null,
EaLength=0 ) => 0xc0000034 [2 'The system cannot find the file
specified.'] 21:42:37.792: NtCreateFile( FileHandle=0xec11ec,
DesiredAccess=GENERIC_READ,
ObjectAttributes="\Device\NetBT_Tcpip6_{8C417BCD-EF32-4EDE-9480-B1BF4E5BDC83}",
IoStatusBlock=0x92afe0, AllocationSize=null, FileAttributes=0,
ShareAccess=3, CreateDisposition=3, CreateOptions=0, EaBuffer=null,
EaLength=0 ) => 0xc0000034 [2 'The system cannot find the file
specified.'] 21:42:37.792: NtCreateFile( FileHandle=0xec11ec,
DesiredAccess=GENERIC_READ,
ObjectAttributes="\Device\NetBT_Tcpip6_{EFA528A3-36EC-40EA-AEC9-8E9A4D898535}",
IoStatusBlock=0x92afe0, AllocationSize=null, FileAttributes=0,
ShareAccess=3, CreateDisposition=3, CreateOptions=0, EaBuffer=null,
EaLength=0 ) => 0xc0000034 [2 'The system cannot find the file
specified.'] 21:42:37.792: NtCreateFile( FileHandle=0xec11ec,
DesiredAccess=GENERIC_READ,
ObjectAttributes="\Device\NetBT_Tcpip6_{7BF7AA50-B8DA-4D7E-A765-4848A84851D3}",
IoStatusBlock=0x92afe0, AllocationSize=null, FileAttributes=0,
ShareAccess=3, CreateDisposition=3, CreateOptions=0, EaBuffer=null,
EaLength=0 ) => 0xc0000034 [2 'The system cannot find the file
specified.'] 21:42:37.792: NtCreateFile( FileHandle=0xec11ec,
DesiredAccess=GENERIC_READ,
ObjectAttributes="\Device\NetBT_Tcpip6_{774F75B1-D995-4095-9952-8D33AA602645}",
IoStatusBlock=0x92afe0, AllocationSize=null, FileAttributes=0,
ShareAccess=3, CreateDisposition=3, CreateOptions=0, EaBuffer=null,
EaLength=0 ) => 0xc0000034 [2 'The system cannot find the file
specified.'] 21:42:37.792: NtCreateEvent( EventHandle=0x92af9c [0x338],
DesiredAccess=DELETE|READ_CONTROL|WRITE_DAC|WRITE_OWNER|SYNCHRONIZE|0x3,
ObjectAttributes=null, EventType=0 [NotificationEvent],
InitialState=true ) => 0 21:42:37.792: NtDeviceIoControlFile(
FileHandle=0x334, Event=0x338, ApcRoutine=null, ApcContext=null,
IoStatusBlock=0xec0d44, IoControlCode=0x002100ae, InputBuffer=0xec0d4c,
InputBufferLength=0x20, OutputBuffer=0xec0d6c, OutputBufferLength=0x27c
) => 0x103 [997 'Overlapped I/O operation is in progress.']
21:42:42.332: NtWaitForMultipleObjects( Count=1, Handles=0x92af3c
[0x338], WaitType=1 [WaitAny], Alertable=false, Timeout=null ) => 0
21:42:42.332: NtClose( Handle=0x334 ) => 0 21:42:42.332: NtClose(
Handle=0x338 ) => 0 21:42:42.332: NtDeviceIoControlFile(
FileHandle=0x134, Event=0xf0, ApcRoutine=null, ApcContext=null,
IoStatusBlock=0x92bd58 [0/0x1c], IoControlCode=0x00012024,
InputBuffer=0x92bdbc, InputBufferLength=0x28, OutputBuffer=0x92bdbc,
OutputBufferLength=0x28 ) => 0 21:42:42.332: NtDeviceIoControlFile(
FileHandle=0x134, Event=0xf0, ApcRoutine=null, ApcContext=null,
IoStatusBlock=0x92be1c [0/0x65], IoControlCode=0x0001201f,
InputBuffer=0x92be04, InputBufferLength=0x10, OutputBuffer=null,
OutputBufferLength=0 ) => 0 21:42:42.332: NtDeviceIoControlFile(
FileHandle=0x134, Event=0xf0, ApcRoutine=null, ApcContext=null,
IoStatusBlock=0x92bd1c, IoControlCode=0x00012024, InputBuffer=0x92bd80,
InputBufferLength=0x28, OutputBuffer=0x92bd80, OutputBufferLength=0x28 )
=> 0x103 [997 'Overlapped I/O operation is in progress.'] 21:42:42.847:
NtWaitForSingleObject( Handle=0xf0, Alertable=true, Timeout=0x92bcdc
[-5e+006] ) => 0x102 [1460 'This operation returned because the timeout
period expired.'] 21:42:43.939: NtWaitForSingleObject( Handle=0xf0,
Alertable=true, Timeout=0x92bcdc [9.22337e+018] ) => 0 21:42:43.939:
NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0, ApcRoutine=null,
ApcContext=null, IoStatusBlock=0x92bde0 [0/0x45],
IoControlCode=0x00012017, InputBuffer=0x92bdc8, InputBufferLength=0x10,
OutputBuffer=null, OutputBufferLength=0 ) => 0 21:42:43.939:
NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0, ApcRoutine=null,
ApcContext=null, IoStatusBlock=0x92bd8c [0/0x1c],
IoControlCode=0x00012024, InputBuffer=0x92bdf0, InputBufferLength=0x28,
OutputBuffer=0x92bdf0, OutputBufferLength=0x28 ) => 0 21:42:43.939:
NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0, ApcRoutine=null,
ApcContext=null, IoStatusBlock=0x92be50 [0/0x35],
IoControlCode=0x0001201f, InputBuffer=0x92be38, InputBufferLength=0x10,
OutputBuffer=null, OutputBufferLength=0 ) => 0 21:42:43.939:
NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0, ApcRoutine=null,
ApcContext=null, IoStatusBlock=0x92bd50, IoControlCode=0x00012024,
InputBuffer=0x92bdb4, InputBufferLength=0x28, OutputBuffer=0x92bdb4,
OutputBufferLength=0x28 ) => 0x103 [997 'Overlapped I/O operation is in
progress.'] 21:42:44.001: NtWaitForSingleObject( Handle=0xf0,
Alertable=true, Timeout=0x92bd10 [-5e+006] ) => 0 21:42:44.001:
NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0, ApcRoutine=null,
ApcContext=null, IoStatusBlock=0x92be14 [0/0xe5],
IoControlCode=0x00012017, InputBuffer=0x92bdfc, InputBufferLength=0x10,
OutputBuffer=null, OutputBufferLength=0 ) => 0 21:42:44.001:
NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0, ApcRoutine=null,
ApcContext=null, IoStatusBlock=0x92bd9c [0/0x1c],
IoControlCode=0x00012024, InputBuffer=0x92be00, InputBufferLength=0x28,
OutputBuffer=0x92be00, OutputBufferLength=0x28 ) => 0 21:42:44.001:
NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0, ApcRoutine=null,
ApcContext=null, IoStatusBlock=0x92be60 [0/0x35],
IoControlCode=0x0001201f, InputBuffer=0x92be48, InputBufferLength=0x10,
OutputBuffer=null, OutputBufferLength=0 ) => 0 21:42:44.001:
NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0, ApcRoutine=null,
ApcContext=null, IoStatusBlock=0x92bd60, IoControlCode=0x00012024,
InputBuffer=0x92bdc4, InputBufferLength=0x28, OutputBuffer=0x92bdc4,
OutputBufferLength=0x28 ) => 0x103 [997 'Overlapped I/O operation is in
progress.'] 21:42:44.064: NtWaitForSingleObject( Handle=0xf0,
Alertable=true, Timeout=0x92bd20 [-5e+006] ) => 0
21:42:44.079: NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92be24 [0/0x155],
IoControlCode=0x00012017, InputBuffer=0x92be0c, InputBufferLength=0x10,
OutputBuffer=null, OutputBufferLength=0 ) => 0
21:42:44.079: NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92d8cc [0/0x1c],
IoControlCode=0x00012024, InputBuffer=0x92d930, InputBufferLength=0x28,
OutputBuffer=0x92d930, OutputBufferLength=0x28 ) => 0
21:42:44.079: NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92d990 [0/0x35],
IoControlCode=0x0001201f, InputBuffer=0x92d978, InputBufferLength=0x10,
OutputBuffer=null, OutputBufferLength=0 ) => 0
21:42:44.079: NtDeviceIoControlFile( FileHandle=0x134, Event=0xf0,
ApcRoutine=null, ApcContext=null, IoStatusBlock=0x92d890,
IoControlCode=0x00012024, InputBuffer=0x92d8f4, InputBufferLength=0x28,
OutputBuffer=0x92d8f4, OutputBufferLength=0x28 ) => 0x103 [997
'Overlapped I/O operation is in progress.']
21:42:44.126: NtWaitForSingleObject( Handle=0xf0, Alertable=true,
Timeout=0x92d850 [-5e+006] ) => 0
...
--
Edit bug report at https://bugs.php.net/bug.php?id=71692&edit=1
--
Try a snapshot (PHP 5.4): https://bugs.php.net/fix.php?id=71692&r=trysnapshot54
Try a snapshot (PHP 5.5): https://bugs.php.net/fix.php?id=71692&r=trysnapshot55
Try a snapshot (trunk): https://bugs.php.net/fix.php?id=71692&r=trysnapshottrunk
Fixed in SVN: https://bugs.php.net/fix.php?id=71692&r=fixed
Fixed in release: https://bugs.php.net/fix.php?id=71692&r=alreadyfixed
Need backtrace: https://bugs.php.net/fix.php?id=71692&r=needtrace
Need Reproduce Script: https://bugs.php.net/fix.php?id=71692&r=needscript
Try newer version: https://bugs.php.net/fix.php?id=71692&r=oldversion
Not developer issue: https://bugs.php.net/fix.php?id=71692&r=support
Expected behavior: https://bugs.php.net/fix.php?id=71692&r=notwrong
Not enough info: https://bugs.php.net/fix.php?id=71692&r=notenoughinfo
Submitted twice: https://bugs.php.net/fix.php?id=71692&r=submittedtwice
register_globals: https://bugs.php.net/fix.php?id=71692&r=globals
PHP 4 support discontinued: https://bugs.php.net/fix.php?id=71692&r=php4
Daylight Savings: https://bugs.php.net/fix.php?id=71692&r=dst
IIS Stability: https://bugs.php.net/fix.php?id=71692&r=isapi
Install GNU Sed: https://bugs.php.net/fix.php?id=71692&r=gnused
Floating point limitations: https://bugs.php.net/fix.php?id=71692&r=float
No Zend Extensions: https://bugs.php.net/fix.php?id=71692&r=nozend
MySQL Configuration Error: https://bugs.php.net/fix.php?id=71692&r=mysqlcfg