mku@NBK-MKU04 ~ $ cd time-lag-example/ mku@NBK-MKU04 ~/time-lag-example $ ###### first have a look at the content of nsswitch mku@NBK-MKU04 ~/time-lag-example $ grep -v "^#" /etc/nsswitch.conf passwd: files group: files mku@NBK-MKU04 ~/time-lag-example $ ###### now doing ls -l without the symbolic link mku@NBK-MKU04 ~/time-lag-example $ strace -o off-ln-s.trc ls -lrt total 233 -rwxr-xr-x+ 1 mku Domänen-Benutzer 421 Aug 17 10:32 nsswitch.conf -rw-r--r--+ 1 mku Domänen-Benutzer 106294 Aug 17 10:35 x-sav.trc -rw-r--r--+ 1 mku Domänen-Benutzer 76277 Aug 17 10:56 off-ln-s.trc mku@NBK-MKU04 ~/time-lag-example $ time ls -lrt total 209 -rwxr-xr-x+ 1 mku Domänen-Benutzer 421 Aug 17 10:32 nsswitch.conf -rw-r--r--+ 1 mku Domänen-Benutzer 106294 Aug 17 10:35 x-sav.trc -rw-r--r--+ 1 mku Domänen-Benutzer 106221 Aug 17 10:56 off-ln-s.trc real 0m0.070s user 0m0.015s sys 0m0.046s mku@NBK-MKU04 ~/time-lag-example $ ln -s //192.168.146.93/MeineOrdner/MeineDokumente dok $ ###### after defining the symb.link an additional ls-l mku@NBK-MKU04 ~/time-lag-example $ strace -o on--ln-s.trc ls -lrt total 338 -rwxr-xr-x+ 1 mku Domänen-Benutzer 421 Aug 17 10:32 nsswitch.conf -rw-r--r--+ 1 mku Domänen-Benutzer 106294 Aug 17 10:35 x-sav.trc -rw-r--r--+ 1 mku Domänen-Benutzer 106221 Aug 17 10:56 off-ln-s.trc lrwxrwxrwx 1 mku Domänen-Benutzer 43 Aug 17 10:57 dok -> //192.168.146.93/MeineOrdner/MeineDokumente -rwxr-xr-x+ 1 mku Domänen-Benutzer 79624 Aug 17 10:57 on--ln-s.trc mku@NBK-MKU04 ~/time-lag-example $ time ls -lrt total 322 -rwxr-xr-x+ 1 mku Domänen-Benutzer 421 Aug 17 10:32 nsswitch.conf -rw-r--r--+ 1 mku Domänen-Benutzer 106294 Aug 17 10:35 x-sav.trc -rw-r--r--+ 1 mku Domänen-Benutzer 106221 Aug 17 10:56 off-ln-s.trc lrwxrwxrwx 1 mku Domänen-Benutzer 43 Aug 17 10:57 dok -> //192.168.146.93/MeineOrdner/MeineDokumente -rwxr-xr-x+ 1 mku Domänen-Benutzer 114489 Aug 17 10:57 on--ln-s.trc real 0m4.630s user 0m0.000s sys 0m0.046s mku@NBK-MKU04 ~/time-lag-example $ ###### now looking for the time-lag appearance mku@NBK-MKU04 ~/time-lag-example $ egrep "^[0-9]{6,9}" -A 9 -B 9 on--ln-s.trc 335 37580 [main] ls 39908 transport_layer_pipes::connect: Error opening the pipe (2) 309 37889 [main] ls 39908 client_request::make_request: cygserver un-available --- Process 39908 loaded C:\Windows\SysWOW64\advapi32.dll at 77380000 --- Process 39908 loaded C:\Windows\SysWOW64\msvcrt.dll at 76EF0000 --- Process 39908 loaded C:\Windows\SysWOW64\sechost.dll at 758F0000 --- Process 39908 loaded C:\Windows\SysWOW64\rpcrt4.dll at 77430000 --- Process 39908 loaded C:\Windows\SysWOW64\sspicli.dll at 75720000 --- Process 39908 loaded C:\Windows\SysWOW64\cryptbase.dll at 75710000 --- Process 39908 thread 38964 created 4517135 4555024 [main] ls 39908 cygheap_user::ontherange: what 2, pw 0x612FFD28 221 4555245 [main] ls 39908 cygheap_user::ontherange: HOME is already in the environment /home/mku 655 4555900 [main] ls 39908 build_argv: argv[0] = 'ls' 270 4556170 [main] ls 39908 build_argv: argv[1] = '-lrt' 265 4556435 [main] ls 39908 build_argv: argc 2 751 4557186 [main] ls 39908 build_fh_pc: created an archetype (0x61301908) for /dev/pty0(136/0) 260 4557446 [main] ls 39908 build_fh_pc: fh 0x613016C0, dev 00880000 297 4557743 [main] ls 39908 fhandler_pipe::create: name \\.\pipe\cygwin-c5e39b7a9d22bafb-pty0-from-master, size 131072, mode PIPE_TYPE_MESSAGE 365 4558108 [main] ls 39908 fhandler_pipe::create: pipe busy 184 4558292 [main] ls 39908 tty::exists: exists 1 mku@NBK-MKU04 ~/time-lag-example $ ###### the cygheap_user log entry again!!! Lets look at the corresponding off trc mku@NBK-MKU04 ~/time-lag-example $ grep "cygheap_user" -A 9 -B 9 off-ln-s.trc 322 47822 [main] ls 40056 transport_layer_pipes::connect: Error opening the pipe (2) 279 48101 [main] ls 40056 client_request::make_request: cygserver un-available --- Process 40056 loaded C:\Windows\SysWOW64\advapi32.dll at 77380000 --- Process 40056 loaded C:\Windows\SysWOW64\msvcrt.dll at 76EF0000 --- Process 40056 loaded C:\Windows\SysWOW64\sechost.dll at 758F0000 --- Process 40056 loaded C:\Windows\SysWOW64\rpcrt4.dll at 77430000 --- Process 40056 loaded C:\Windows\SysWOW64\sspicli.dll at 75720000 --- Process 40056 loaded C:\Windows\SysWOW64\cryptbase.dll at 75710000 --- Process 40056 thread 39640 created 22548 70649 [main] ls 40056 cygheap_user::ontherange: what 2, pw 0x612FFD28 203 70852 [main] ls 40056 cygheap_user::ontherange: HOME is already in the environment /home/mku 633 71485 [main] ls 40056 build_argv: argv[0] = 'ls' 204 71689 [main] ls 40056 build_argv: argv[1] = '-lrt' 202 71891 [main] ls 40056 build_argv: argc 2 676 72567 [main] ls 40056 build_fh_pc: created an archetype (0x61301908) for /dev/pty0(136/0) 241 72808 [main] ls 40056 build_fh_pc: fh 0x613016C0, dev 00880000 273 73081 [main] ls 40056 fhandler_pipe::create: name \\.\pipe\cygwin-c5e39b7a9d22bafb-pty0-from-master, size 131072, mode PIPE_TYPE_MESSAGE 375 73456 [main] ls 40056 fhandler_pipe::create: pipe busy 233 73689 [main] ls 40056 tty::exists: exists 1 509 74198 [main] ls 40056 alloc_sd: uid 1049740, gid 1049089, attribute 020620 mku@NBK-MKU04 ~/time-lag-example $ alias ls alias ls='ls --color=auto --show-control-chars' mku@NBK-MKU04 ~/time-lag-example $ cygcheck -s | grep cygwin1 -A 9 3399k 2015/08/03 C:\cygwin\bin\cygwin1.dll Cygwin DLL version info: DLL version: 2.2.0 DLL epoch: 19 DLL old termios: 5 DLL malloc env: 28 Cygwin conv: 181 API major: 0 API minor: 289 Shared data: 5 DLL identifier: cygwin1 Mount registry: 3 Cygwin registry name: Cygwin Installations name: Installations Cygdrive default prefix: Build date: Shared id: cygwin1S5 No Cygwin services found. Cygwin Package Information Package Version Status _autorebase 001002-1 OK _update-info-dir 01421-1 OK mku@NBK-MKU04 ~/time-lag-example $