bash very slow in cygwin 1.7.16-1 Win7/64 bit

Adam Rosi-Kessel adam@rosi-kessel.org
Sun Sep 30 20:52:00 GMT 2012


Cygwin used to run very quickly for me; now it doesn't. Not sure when it 
stopped -- last few weeks.

# time for i in {1..5} ; do bash -c "echo Hello" ; done
Hello
Hello
Hello
Hello
Hello

real    0m51.451s
user    0m0.230s
sys     0m0.979s

# time ls | wc -l
21

real    0m10.231s
user    0m0.030s
sys     0m0.264s

The system should be fast enough:

- Windows 7 / 64-bit fully patched
- Quad core CPU
- 8 GB RAM
- nothing else running
- Everything on solid state disk

This problem seems to have many different causes. Here is what I've 
tried so far with no success at all:

- Uninstall bash_completion
- Move .bashrc / .bash_profile out of the way
- Running in xterm
- setting PS1 to '$'
- unmounting all network drives
- unsetting the path
- adding '127.0.0.1 localhost cygdrive wpad' to 
c:\windows\system32\drivers\etc\hosts
- running as administrator

Any suggestions for further things to try?

# strace -tt ls

     2       2 [main] ls (24012) 
**********************************************
   138     140 [main] ls (24012) Program name: C:\cygwin\bin\ls.exe 
(windows pid 24012)
    65     205 [main] ls (24012) OS version:   Windows NT-6.1
    45     250 [main] ls (24012) 
**********************************************
  1281    1531 [main] ls (24012) sigprocmask: 0 = sigprocmask (0, 
0x6123D428, 0x610FB180)
  1318    2849 [main] ls 24012 open_shared: name shared.5, n 5, shared 
0x60FF0000 (wanted 0x60FF0000), h 0x7C, *m 6
    89    2938 [main] ls 24012 heap_init: heap base 0x80000000, heap top 
0x80000000, heap size 0x18000000 (402653184)
    65    3003 [main] ls 24012 open_shared: name 
S-1-5-21-96414999-1499730031-444732941-29377.1, n 1, shared 0x60FE0000 
(wanted 0x60FE0000), h 0x74, *m 6
    89    3092 [main] ls 24012 user_info::create: opening user shared 
for 'S-1-5-21-96414999-1499730031-444732941-29377' at 0x60FE0000
    34    3126 [main] ls 24012 user_info::create: user shared version 
6467403B
    63    3189 [main] ls 24012 fhandler_pipe::create: name 
\\.\pipe\cygwin-c5e39b7a9d22bafb-24012-sigwait, size 164, mode 
PIPE_TYPE_MESSAGE
    69    3258 [main] ls 24012 fhandler_pipe::create: pipe read handle 0x98
    30    3288 [main] ls 24012 fhandler_pipe::create: CreateFile: name 
\\.\pipe\cygwin-c5e39b7a9d22bafb-24012-sigwait
    50    3338 [main] ls 24012 fhandler_pipe::create: pipe write handle 0x9C
    38    3376 [main] ls 24012 dll_crt0_0: finished dll_crt0_0 
initialization
   437    3813 [sig] ls 24012 wait_sig: entering ReadFile loop, 
my_readsig 0x98, my_sendsig 0x9C
   293    4106 [main] ls 24012 mount_info::conv_to_posix_path: 
conv_to_posix_path (C:\cygwin\tmp, no-keep-rel, no-add-slash)
    63    4169 [main] ls 24012 normalize_win32_path: C:\cygwin\tmp = 
normalize_win32_path (C:\cygwin\tmp)
    39    4208 [main] ls 24012 mount_info::conv_to_posix_path: /tmp = 
conv_to_posix_path (C:\cygwin\tmp)
    62    4270 [main] ls 24012 sigprocmask: 0 = sigprocmask (0, 
0x800180A8, 0x610FB180)
   172    4442 [main] ls 24012 _cygwin_istext_for_stdio: fd 0: not open
    36    4478 [main] ls 24012 _cygwin_istext_for_stdio: fd 1: not open
    36    4514 [main] ls 24012 _cygwin_istext_for_stdio: fd 2: not open
   123    4637 [main] ls (24012) open_shared: name cygpid.24012, n 
24012, shared 0x60FD0000 (wanted 0x60FD0000), h 0xC4, *m 2
    43    4680 [main] ls 24012 pinfo::thisproc: myself dwProcessId 24012
    33    4713 [main] ls 24012 time: 1349037741 = time(0)
   884    5597 [main] ls 24012 environ_init: GetEnvironmentStrings 
returned 0x4F2958
    69    5666 [main] ls 24012 environ_init: 0x80028290: !::=::\
    62    5728 [main] ls 24012 environ_init: 0x800282A0: !C:=C:\1\config
    65    5793 [main] ls 24012 environ_init: 0x800282B8: 
COMMONPROGRAMFILES=C:\Program Files (x86)\Common Files
    62    5855 [main] ls 24012 environ_init: 0x800282F8: 
CommonProgramFiles(x86)=C:\Program Files (x86)\Common Files
    64    5919 [main] ls 24012 parse_options: glob (called func)
    58    5977 [main] ls 24012 parse_options: returning
    31    6008 [main] ls 24012 environ_init: 0x80028340: CYGWIN=noglob
    63    6071 [main] ls 24012 getwinenv: can't set native for PATH= 
since no environ yet
    72    6143 [main] ls 24012 mount_info::conv_to_posix_path: 
conv_to_posix_path (C:\cygwin\bin, keep-rel, no-add-slash)
    35    6178 [main] ls 24012 normalize_win32_path: C:\cygwin\bin = 
normalize_win32_path (C:\cygwin\bin)
    35    6213 [main] ls 24012 mount_info::conv_to_posix_path: /usr/bin 
= conv_to_posix_path (C:\cygwin\bin)
    86    6299 [main] ls 24012 win_env::add_cache: posix /usr/bin
    30    6329 [main] ls 24012 win_env::add_cache: native PATH=C:\cygwin\bin
    34    6363 [main] ls 24012 posify_maybe: env var converted to 
PATH=/usr/bin
    80    6443 [main] ls 24012 environ_init: 0x800383B0: PATH=/usr/bin
    64    6507 [main] ls 24012 environ_init: 0x800383C8: 
PROGRAMFILES=C:\Program Files (x86)
    58    6565 [main] ls 24012 environ_init: 0x80028368: PS1=#
    62    6627 [main] ls 24012 environ_init: 0x800383F8: 
ProgramFiles(x86)=C:\Program Files (x86)
   104    6731 [main] ls 24012 environ_init: 0x80038428: 
SYSTEMROOT=C:\Windows
    62    6793 [main] ls 24012 environ_init: 0x80038448: WINDIR=C:\Windows
    55    6848 [main] ls 24012 environ_init: 0x80038460: _=/usr/bin/strace
    57    6905 [main] ls 24012 environ_init: 0x80038478: 
asl.log=Destination=file;OnFirstLog=command,environment
    66    6971 [main] ls 24012 pinfo_init: Set nice to 0
    34    7005 [main] ls 24012 pinfo_init: pid 24012, pgid 24012
    32    7037 [main] ls 24012 App version:  1007.10, api: 0.259
    33    7070 [main] ls 24012 DLL version:  1007.16, api: 0.262
    28    7098 [main] ls 24012 DLL build:    2012-07-20 22:55
    39    7137 [main] ls 24012 dtable::extend: size 32, fds 0x612737C0
  1719    8856 [main] ls 24012 pwdgrp::load: \etc\passwd curr_lines 8
    58    8914 [main] ls 24012 pwdgrp::load: \etc\passwd load succeeded
  1397   10311 [main] ls 24012 pwdgrp::load: \etc\group curr_lines 15
    41   10352 [main] ls 24012 pwdgrp::load: \etc\group load succeeded
    27   10379 [main] ls 24012 cygheap_user::ontherange: what 2, pw 
0x800389E8
    22   10401 [main] ls 24012 cygheap_user::ontherange: Set HOME (from 
/etc/passwd) to /cygdrive/c/0/cygwin_home
   100   10501 [main] ls 24012 normalize_posix_path: src 
/cygdrive/c/0/cygwin_home
    40   10541 [main] ls 24012 normalize_posix_path: 
/cygdrive/c/0/cygwin_home = normalize_posix_path (/cygdrive/c/0/cygwin_home)
    31   10572 [main] ls 24012 mount_info::conv_to_win32_path: 
conv_to_win32_path (/cygdrive/c/0/cygwin_home)
    42   10614 [main] ls 24012 mount_info::cygdrive_win32_path: src 
'/cygdrive/c/0/cygwin_home', dst 'C:\0\cygwin_home'
    38   10652 [main] ls 24012 set_flags: flags: binary (0x2)
    36   10688 [main] ls 24012 mount_info::conv_to_win32_path: src_path 
/cygdrive/c/0/cygwin_home, dst C:\0\cygwin_home, flags 0x4022, rc 0
   303   10991 [main] ls 24012 symlink_info::check: 0x0 = NtCreateFile 
(\??\C:\0\cygwin_home)
    87   11078 [main] ls 24012 mount_info::conv_to_posix_path: 
conv_to_posix_path (c:\users\avk\SkyDrive\0\cygwin_home, no-keep-rel, 
no-add-slash)
    48   11126 [main] ls 24012 normalize_win32_path: 
C:\users\avk\SkyDrive\0\cygwin_home = normalize_win32_path 
(c:\users\avk\SkyDrive\0\cygwin_home)
    24   11150 [main] ls 24012 mount_info::conv_to_posix_path: 
/cygdrive/c/users/avk/SkyDrive/0/cygwin_home = conv_to_posix_path 
(c:\users\avk\SkyDrive\0\cygwin_home)
    51   11201 [main] ls 24012 symlink_info::check: 44 = 
symlink.check(C:\0\cygwin_home, 0x2890F8) (0x4804023)
    35   11236 [main] ls 24012 path_conv::check: 
this->path(C:\0\cygwin_home), has_acls(1)
    64   11300 [main] ls 24012 win_env::add_cache: posix 
/cygdrive/c/0/cygwin_home
    27   11327 [main] ls 24012 win_env::add_cache: native 
HOME=C:\0\cygwin_home
    46   11373 [main] ls 24012 normalize_posix_path: src 
/cygdrive/c/0/cygwin_home
    24   11397 [main] ls 24012 normalize_posix_path: 
/cygdrive/c/0/cygwin_home = normalize_posix_path (/cygdrive/c/0/cygwin_home)
    25   11422 [main] ls 24012 mount_info::conv_to_win32_path: 
conv_to_win32_path (/cygdrive/c/0/cygwin_home)
    25   11447 [main] ls 24012 mount_info::cygdrive_win32_path: src 
'/cygdrive/c/0/cygwin_home', dst 'C:\0\cygwin_home'
    25   11472 [main] ls 24012 set_flags: flags: binary (0x2)
    24   11496 [main] ls 24012 mount_info::conv_to_win32_path: src_path 
/cygdrive/c/0/cygwin_home, dst C:\0\cygwin_home, flags 0x4022, rc 0
   281   11777 [main] ls 24012 symlink_info::check: 0x0 = NtCreateFile 
(\??\C:\0\cygwin_home)
    86   11863 [main] ls 24012 mount_info::conv_to_posix_path: 
conv_to_posix_path (c:\users\avk\SkyDrive\0\cygwin_home, no-keep-rel, 
no-add-slash)
    37   11900 [main] ls 24012 normalize_win32_path: 
C:\users\avk\SkyDrive\0\cygwin_home = normalize_win32_path 
(c:\users\avk\SkyDrive\0\cygwin_home)
    36   11936 [main] ls 24012 mount_info::conv_to_posix_path: 
/cygdrive/c/users/avk/SkyDrive/0/cygwin_home = conv_to_posix_path 
(c:\users\avk\SkyDrive\0\cygwin_home)
    58   11994 [main] ls 24012 symlink_info::check: 44 = 
symlink.check(C:\0\cygwin_home, 0x289150) (0x4804023)
    34   12028 [main] ls 24012 path_conv::check: 
this->path(C:\0\cygwin_home), has_acls(1)
   103   12131 [main] ls 24012 win_env::add_cache: posix 
/cygdrive/c/0/cygwin_home
    31   12162 [main] ls 24012 win_env::add_cache: native 
HOME=C:\0\cygwin_home
    90   12252 [main] ls 24012 build_argv: argv[0] = 'ls'
    31   12283 [main] ls 24012 build_argv: argc 1
   168   12451 [main] ls 24012 build_fh_pc: created an archetype 
(0x61273C00) for /dev/pty0(136/0)
    35   12486 [main] ls 24012 build_fh_pc: fh 0x612739A8, dev 0x880000
    30   12516 [main] ls 24012 fhandler_pipe::create: name 
\\.\pipe\cygwin-c5e39b7a9d22bafb-pty0-from-master, size 131072, mode 
PIPE_TYPE_MESSAGE
    63   12579 [main] ls 24012 fhandler_pipe::create: pipe busy
    25   12604 [main] ls 24012 tty::exists: exists 1
    59   12663 [main] ls 24012 alloc_sd: uid 39377, gid 10545, attribute 
2190
    26   12689 [main] ls 24012 cygsid::debug_print: alloc_sd: owner SID 
= S-1-5-21-96414999-1499730031-444732941-29377 (+)
    23   12712 [main] ls 24012 cygsid::debug_print: alloc_sd: group SID 
= S-1-5-32-545 (+)
    36   12748 [main] ls 24012 alloc_sd: ACL-Size: 112
    55   12803 [main] ls 24012 alloc_sd: Created SD-Size: 176
    21   12824 [main] ls 24012 fhandler_pty_slave::open: (444): pty 
output_mutex (0xC8): waiting 500 ms
    22   12846 [main] ls 24012 fhandler_pty_slave::open: (444): pty 
output_mutex: acquired
    31   12877 [main] ls 24012 tty::create_inuse: cygtty.slave_alive.0 0xD4
    25   12902 [main] ls 24012 fhandler_pty_slave::open: (447): pty 
output_mutex(0xC8) released
    51   12953 [main] ls 24012 open_shared: name cygpid.25228, n 25228, 
shared 0x30000 (wanted 0x0), h 0xD8, *m 6
    35   12988 [main] ls 24012 fhandler_pty_slave::open: dup handles 
directly since I'm the owner
    33   13021 [main] ls 24012 fhandler_pty_slave::open: duplicated 
from_master 0x314->0xD8 from pty_owner
    23   13044 [main] ls 24012 fhandler_pty_slave::open: duplicated 
to_master 0x31C->0xE0 from pty_owner
    39   13083 [main] ls 24012 fhandler_console::need_invisible: 
invisible_console 0
    27   13110 [main] ls 24012 fhandler_base::open_with_arch: line 474:  
/dev/pty0<0x61273C00> usecount + 1 = 1
    24   13134 [main] ls 24012 fhandler_base::set_flags: flags 0x10002, 
supplied_bin 0x0
    21   13155 [main] ls 24012 fhandler_base::set_flags: O_TEXT/O_BINARY 
set in flags 0x10000
    21   13176 [main] ls 24012 fhandler_base::set_flags: filemode set to 
binary
    22   13198 [main] ls 24012 _pinfo::set_ctty: old no ctty, ctty 
device number 0xFFFFFFFF, tc.ntty device number 0x880000 flags & 
O_NOCTTY 0x0
    21   13219 [main] ls 24012 _pinfo::set_ctty: cygheap->ctty 0x0, 
archetype 0x61273C00
    21   13240 [main] ls 24012 _pinfo::set_ctty: ctty was NULL
    21   13261 [main] ls 24012 _pinfo::set_ctty: line 456: 
/dev/pty0<0x61273C00> usecount + 1 = 2
    22   13283 [main] ls 24012 _pinfo::set_ctty: /dev/pty0 ctty, usecount 2
    23   13306 [main] ls 24012 _pinfo::set_ctty: attaching ctty 
/dev/pty0 sid 24012, pid 24012, pgid 24012, tty->pgid 25976, tty->sid -1
    23   13329 [main] ls 24012 _pinfo::set_ctty: cygheap->ctty now 
0x61273C00, archetype 0x61273C00
    22   13351 [main] ls 24012 fhandler_pty_slave::open_setup: /dev/pty0 
opened, usecount 2
    23   13374 [main] ls 24012 fhandler_base::set_flags: flags 0x10002, 
supplied_bin 0x0
    21   13395 [main] ls 24012 fhandler_base::set_flags: O_TEXT/O_BINARY 
set in flags 0x10000
    22   13417 [main] ls 24012 fhandler_base::set_flags: filemode set to 
binary
    21   13438 [main] ls 24012 _pinfo::set_ctty: old ctty /dev/pty0, 
ctty device number 0x880000, tc.ntty device number 0x880000 flags & 
O_NOCTTY 0x0
    51   13489 [main] ls 24012 _pinfo::set_ctty: attaching ctty 
/dev/pty0 sid -1, pid 24012, pgid 25976, tty->pgid 25976, tty->sid -1
    31   13520 [main] ls 24012 _pinfo::set_ctty: cygheap->ctty now 
0x61273C00, archetype 0x61273C00
    29   13549 [main] ls 24012 fhandler_pty_slave::open_setup: /dev/pty0 
opened, usecount 2
  3766   17315 [main] ls 24012 handle_to_fn: current match 'C:' = 
'\Device\HarddiskVolume1'
   253   17568 [main] ls 24012 mount_info::conv_to_posix_path: 
conv_to_posix_path (C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt, 
no-keep-rel, no-add-slash)
    38   17606 [main] ls 24012 normalize_win32_path: 
C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt = normalize_win32_path 
(C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt)
    29   17635 [main] ls 24012 mount_info::conv_to_posix_path: 
/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt = conv_to_posix_path 
(C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt)
    25   17660 [main] ls 24012 handle_to_fn: derived path 
'C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt', posix 
'/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt'
    24   17684 [main] ls 24012 normalize_posix_path: src 
/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt
    24   17708 [main] ls 24012 normalize_posix_path: 
/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt = 
normalize_posix_path (/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt)
    22   17730 [main] ls 24012 mount_info::conv_to_win32_path: 
conv_to_win32_path (/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt)
    23   17753 [main] ls 24012 mount_info::cygdrive_win32_path: src 
'/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt', dst 
'C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt'
    23   17776 [main] ls 24012 set_flags: flags: binary (0x2)
    21   17797 [main] ls 24012 mount_info::conv_to_win32_path: src_path 
/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt, dst 
C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt, flags 0x4022, rc 0
   348   18145 [main] ls 24012 symlink_info::check: 0x0 = NtCreateFile 
(\??\C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt)
    55   18200 [main] ls 24012 symlink_info::check: not a symlink
    85   18285 [main] ls 24012 symlink_info::check: 0 = 
symlink.check(C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt, 0x289820) (0x4022)
    38   18323 [main] ls 24012 path_conv::check: 
this->path(C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt), has_acls(1)
    44   18367 [main] ls 24012 build_fh_pc: fh 0x61273EA0, dev 0xC3
    38   18405 [main] ls 24012 fhandler_base::set_flags: flags 0x10001, 
supplied_bin 0x0
    33   18438 [main] ls 24012 fhandler_base::set_flags: O_TEXT/O_BINARY 
set in flags 0x10000
    30   18468 [main] ls 24012 fhandler_base::set_flags: filemode set to 
binary
    30   18498 [main] ls 24012 fhandler_base::init: created new 
fhandler_base for handle 0x3F0, bin 1
   187   18685 [main] ls 24012 build_fh_pc: found an archetype for 
(null)(136/0) io_handle 0xD8
    40   18725 [main] ls 24012 build_fh_pc: fh 0x61274138, dev 0x880000
    36   18761 [main] ls 24012 fhandler_base::open_with_arch: line 494:  
/dev/pty0<0x61273C00> usecount + 1 = 3
    33   18794 [main] ls 24012 fhandler_base::set_flags: flags 0x10002, 
supplied_bin 0x0
    30   18824 [main] ls 24012 fhandler_base::set_flags: O_TEXT/O_BINARY 
set in flags 0x10000
    32   18856 [main] ls 24012 fhandler_base::set_flags: filemode set to 
binary
    31   18887 [main] ls 24012 _pinfo::set_ctty: old ctty /dev/pty0, 
ctty device number 0x880000, tc.ntty device number 0x880000 flags & 
O_NOCTTY 0x0
    33   18920 [main] ls 24012 _pinfo::set_ctty: attaching ctty 
/dev/pty0 sid -1, pid 24012, pgid 25976, tty->pgid 25976, tty->sid -1
    30   18950 [main] ls 24012 _pinfo::set_ctty: cygheap->ctty now 
0x61273C00, archetype 0x61273C00
    30   18980 [main] ls 24012 fhandler_pty_slave::open_setup: /dev/pty0 
opened, usecount 3
    33   19013 [main] ls 24012 fhandler_base::set_flags: flags 0x10002, 
supplied_bin 0x0
    31   19044 [main] ls 24012 fhandler_base::set_flags: O_TEXT/O_BINARY 
set in flags 0x10000
    30   19074 [main] ls 24012 fhandler_base::set_flags: filemode set to 
binary
    28   19102 [main] ls 24012 _pinfo::set_ctty: old ctty /dev/pty0, 
ctty device number 0x880000, tc.ntty device number 0x880000 flags & 
O_NOCTTY 0x0
    32   19134 [main] ls 24012 _pinfo::set_ctty: attaching ctty 
/dev/pty0 sid -1, pid 24012, pgid 25976, tty->pgid 25976, tty->sid -1
    30   19164 [main] ls 24012 _pinfo::set_ctty: cygheap->ctty now 
0x61273C00, archetype 0x61273C00
    31   19195 [main] ls 24012 fhandler_pty_slave::open_setup: /dev/pty0 
opened, usecount 3
   140   19335 [main] ls 24012 __set_errno: void dll_crt0_1(void*):953 
setting errno 0
   298   19633 [main] ls 24012 __get_lcid_from_locale: LCID=0x0000
    81   19714 [main] ls 24012 __get_lcid_from_locale: LCID=0x0000
    75   19789 [main] ls 24012 __get_lcid_from_locale: LCID=0x0000
    78   19867 [main] ls 24012 __get_lcid_from_locale: LCID=0x0000
    74   19941 [main] ls 24012 __get_lcid_from_locale: LCID=0x0000
   418   20359 [main] ls 24012 isatty: 0 = isatty(1)
    37   20396 [main] ls 24012 ioctl: ioctl(fd 1, cmd 0x5401)
    32   20428 [main] ls 24012 __set_errno: virtual int 
fhandler_base::ioctl(unsigned int, void*):1251 setting errno 22
    29   20457 [main] ls 24012 fhandler_base::ioctl: -1 = ioctl(5401, 
0x28AC18)
    29   20486 [main] ls 24012 ioctl: -1 = ioctl(1, 0x5401, ...), errno 22
   154   20640 [main] ls 24012 normalize_posix_path: src .
    31   20671 [main] ls 24012 cwdstuff::get: posix /tmp
    31   20702 [main] ls 24012 cwdstuff::get: (/tmp) = cwdstuff::get 
(0x80000008, 32768, 1, 0), errno 0
    31   20733 [main] ls 24012 normalize_posix_path: /tmp/ = 
normalize_posix_path (.)
    30   20763 [main] ls 24012 mount_info::conv_to_win32_path: 
conv_to_win32_path (/tmp)
    32   20795 [main] ls 24012 set_flags: flags: binary (0x2)
    30   20825 [main] ls 24012 mount_info::conv_to_win32_path: src_path 
/tmp, dst C:\cygwin\tmp, flags 0x3000A, rc 0
   668   21493 [main] ls 24012 symlink_info::check: 0x0 = NtCreateFile 
(\??\C:\cygwin\tmp)
    49   21542 [main] ls 24012 symlink_info::check: not a symlink
    48   21590 [main] ls 24012 symlink_info::check: 0 = 
symlink.check(C:\cygwin\tmp, 0x289670) (0x3000A)
    26   21616 [main] ls 24012 path_conv::check: 
this->path(C:\cygwin\tmp), has_acls(1)
    27   21643 [main] ls 24012 build_fh_pc: fh 0x612743A8, dev 0xC3
   285   21928 [main] ls 24012 fhandler_base::set_close_on_exec: set 
close_on_exec for /tmp to 1
    31   21959 [main] ls 24012 fhandler_disk_file::opendir: 0x80054228 = 
opendir (/tmp)
    69   22028 [main] ls 24012 fhandler_disk_file::readdir: 0 = 
readdir(0x80054228, 0x28A7FC) (L"." > ".") (attr 0x10 > type 4)
    33   22061 [main] ls 24012 normalize_posix_path: src /tmp/..
    23   22084 [main] ls 24012 normalize_posix_path: / = 
normalize_posix_path (/tmp/..)
    21   22105 [main] ls 24012 mount_info::conv_to_win32_path: 
conv_to_win32_path (/)
    23   22128 [main] ls 24012 set_flags: flags: binary (0x2)
    21   22149 [main] ls 24012 mount_info::conv_to_win32_path: src_path 
/, dst C:\cygwin, flags 0x3000A, rc 0
   262   22411 [main] ls 24012 symlink_info::check: 0x0 = NtCreateFile 
(\??\C:\cygwin)
    85   22496 [main] ls 24012 mount_info::conv_to_posix_path: 
conv_to_posix_path (c:\users\avk\skydrive\0\cygwin, no-keep-rel, 
no-add-slash)
    36   22532 [main] ls 24012 normalize_win32_path: 
C:\users\avk\skydrive\0\cygwin = normalize_win32_path 
(c:\users\avk\skydrive\0\cygwin)
    30   22562 [main] ls 24012 mount_info::conv_to_posix_path: 
/cygdrive/c/users/avk/skydrive/0/cygwin = conv_to_posix_path 
(c:\users\avk\skydrive\0\cygwin)
    32   22594 [main] ls 24012 symlink_info::check: 39 = 
symlink.check(C:\cygwin, 0x289380) (0x443000B)
    32   22626 [main] ls 24012 path_conv::check: this->path(C:\cygwin), 
has_acls(1)
    97   22723 [main] ls 24012 fhandler_disk_file::readdir: 0 = 
readdir(0x80054228, 0x28A7FC) (L".." > "..") (attr 0x10 > type 4)
    37   22760 [main] ls 24012 fhandler_disk_file::readdir: 0 = 
readdir(0x80054228, 0x28A7FC) (L".X11-unix" > ".X11-unix") (attr 0x10 > 
type 4)
    30   22790 [main] ls 24012 fhandler_disk_file::readdir: 0 = 
readdir(0x80054228, 0x28A7FC) (L"hsperfdata_avk" > "hsperfdata_avk") 
(attr 0x10 > type 4)
    58   22848 [main] ls 24012 fhandler_disk_file::readdir: 0 = 
readdir(0x80054228, 0x28A7FC) (L"log.txt" > "log.txt") (attr 0x20 > type 8)
    59   22907 [main] ls 24012 geterrno_from_win_error: windows error 18 
== errno 89
    42   22949 [main] ls 24012 fhandler_disk_file::readdir: 89 = 
readdir(0x80054228, 0x28A7FC) (L"(null)" > "***") (attr 0x0 > type 0)
    51   23000 [main] ls 24012 fhandler_disk_file::closedir: 0 = 
closedir(0x80054228, /tmp)
    41   23041 [main] ls 24012 close: close(3)
    33   23074 [main] ls 24012 fhandler_base::close: closing '/tmp' 
handle 0xFC
    49   23123 [main] ls 24012 close: 0 = close(3)
    76   23199 [main] ls 24012 closedir: 0 = closedir(0x0)
    93   23292 [main] ls 24012 _cygwin_istext_for_stdio: fd 0: opened as 
binary
    26   23318 [main] ls 24012 _cygwin_istext_for_stdio: fd 1: opened as 
binary
    24   23342 [main] ls 24012 _cygwin_istext_for_stdio: fd 2: opened as 
binary
   207   23549 [main] ls 24012 cygpsid::debug_print: get_sids_info: 
owner SID = S-1-5-21-96414999-1499730031-444732941-29377
    27   23576 [main] ls 24012 cygpsid::debug_print: get_sids_info: 
group SID = S-1-5-32-545
    25   23601 [main] ls 24012 get_info_from_sd: ACL 1A0, uid 39377, gid 
10545
    44   23645 [main] ls 24012 fhandler_base::fstat_helper: 0 = fstat 
(\??\C:\Users\avk\SkyDrive\0\cygwin\tmp\log.txt, 0x28A1D0) 
st_size=21020, st_mode=0x81A0, 
st_ino=7881299348355873st_atim=5068AEAD.2DB8DA30 
st_ctim=5068AEAD.2DB8DA30 st_mtim=5068AEAD.2DB8DA30 
st_birthtim=5068AEAD.2DB8DA30
    28   23673 [main] ls 24012 fstat64: 0 = fstat(1, 0x28A1D0)
hsperfdata_avk
log.txt
   461   24134 [main] ls 24012 write: 23 = write(1, 0x800639B8, 23)
    90   24224 [main] ls 24012 close: close(1)
    25   24249 [main] ls 24012 fhandler_base::close: closing 
'/cygdrive/c/Users/avk/SkyDrive/0/cygwin/tmp/log.txt' handle 0x3F0
    26   24275 [main] ls 24012 close: 0 = close(1)
   430   24705 [main] ls 24012 close: close(2)
    26   24731 [main] ls 24012 fhandler_pty_slave::cleanup: /dev/pty0 
closed, usecount 3
    25   24756 [main] ls 24012 fhandler_base::close_with_arch: line 
1120:  /dev/pty0<0x61273C00> usecount + -1 = 2
    24   24780 [main] ls 24012 fhandler_base::close_with_arch: not 
closing archetype
    23   24803 [main] ls 24012 close: 0 = close(2)
   464   25267 [main] ls 24012 close: close(0)
    27   25294 [main] ls 24012 fhandler_pty_slave::cleanup: /dev/pty0 
closed, usecount 2
    24   25318 [main] ls 24012 fhandler_base::close_with_arch: line 
1120:  /dev/pty0<0x61273C00> usecount + -1 = 1
    24   25342 [main] ls 24012 fhandler_base::close_with_arch: not 
closing archetype
    23   25365 [main] ls 24012 close: 0 = close(0)
   166   25531 [main] ls 24012 do_exit: do_exit (0), exit_state 1
    25   25556 [main] ls 24012 void: 0x0 = signal (20, 0x1)
    23   25579 [main] ls 24012 void: 0x0 = signal (1, 0x1)
    25   25604 [main] ls 24012 void: 0x0 = signal (2, 0x1)
    23   25627 [main] ls 24012 void: 0x0 = signal (3, 0x1)
    25   25652 [main] ls 24012 init_cygheap::close_ctty: closing 
cygheap->ctty 0x61273C00
    23   25675 [main] ls 24012 fhandler_base::close_with_arch: closing 
passed in archetype, usecount 0
    23   25698 [main] ls 24012 fhandler_pty_slave::close: closing last 
open /dev/pty0 handle
    73   25771 [main] ls 24012 fhandler_console::free_console: freed 
console, res 1
    35   25806 [main] ls 24012 fhandler_pty_common::close: pty0 
<0xD8,0xE0> closing
    30   25836 [main] ls 24012 getpid: 24012 = getpid()
    38   25874 [main] ls 24012 sigproc_terminate: entering
    21   25895 [main] ls 24012 sig_send: sendsig 0x9C, pid 24012, signal 
-42, its_me 1
    26   25921 [main] ls 24012 sig_send: Not waiting for sigcomplete.  
its_me 1 signal -42
    21   25942 [main] ls 24012 sig_send: returning 0x0 from sending 
signal -42
   -16   25926 [sig] ls 24012 wait_sig: saw __SIGEXIT
    36   25962 [main] ls 24012 proc_terminate: nprocs 0
    39   26001 [main] ls 24012 proc_terminate: leaving
     3   26004 [sig] ls 24012 wait_sig: signal thread exiting
    44   26048 [main] ls 24012 __to_clock_t: dwHighDateTime 0, 
dwLowDateTime 312002
    22   26070 [main] ls 24012 __to_clock_t: total 00000000 0000001F
    36   26106 [main] ls 24012 __to_clock_t: dwHighDateTime 0, 
dwLowDateTime 0
    28   26134 [main] ls 24012 __to_clock_t: total 00000000 00000000
    27   26161 [main] ls 24012 pinfo::exit: Calling ExitProcess n 0x0, 
exitcode 0x0


--
Problem reports:       http://cygwin.com/problems.html
FAQ:                   http://cygwin.com/faq/
Documentation:         http://cygwin.com/docs.html
Unsubscribe info:      http://cygwin.com/ml/#unsubscribe-simple



More information about the Cygwin mailing list