Subject: Re: kern/36963
To: None <kern-bug-people@netbsd.org, gnats-admin@netbsd.org,>
From: Jan Danielsson <jan.m.danielsson@gmail.com>
List: netbsd-bugs
Date: 09/16/2007 16:15:05
The following reply was made to PR kern/36963; it has been noted by GNATS.

From: Jan Danielsson <jan.m.danielsson@gmail.com>
To: gnats-bugs@netbsd.org
Cc: 
Subject: Re: kern/36963
Date: Sun, 16 Sep 2007 18:11:23 +0200

 -----BEGIN PGP SIGNED MESSAGE-----
 Hash: SHA512
 
    The previous comment about how belonging to "wheel" changes things
 may not be relevant. It turns out the permission problem comes and goes.
 It's mostly there, but at times the system seems to behave very
 normally. I must have had some really good timing.
 
    As Martin Husemann suggested, I tried to kdump the "ls -l", both when
 it was working and when it wasn't. I finally gave up waiting for it to
 work again, so I rebooted. The beginning of the files follows.
 
    fails.log:
 - --------------------------------------------------------
  24778      1 ktrace   EMUL  "netbsd"
  24778      1 ktrace   CALL
 execve(0x7f7fffffe870,0x7f7fffffed68,0x7f7fffffed80)
  24778      1 ktrace   NAMI  "/home/pkgsrc/bin/ls"
  24778      1 ktrace   RET   execve -1 errno 2 No such file or directory
  24778      1 ktrace   CALL
 execve(0x7f7fffffe870,0x7f7fffffed68,0x7f7fffffed80)
  24778      1 ktrace   NAMI  "/bin/ls"
  24778      1 ktrace   NAMI  "/libexec/ld.elf_so"
  24778      1 ls       EMUL  "netbsd"
  24778      1 ls       RET   execve JUSTRETURN
  24778      1 ls       CALL  mmap(0,0x8000,3,0x1002,0xffffffff,0,0)
  24778      1 ls       RET   mmap 140187698954240/0x7f7ffdff8000
  24778      1 ls       CALL  open(0x7f7ffde0a82e,0,0x7f7ffde0a82e)
  24778      1 ls       NAMI  "/etc/ld.so.conf"
  24778      1 ls       RET   open -1 errno 2 No such file or directory
  24778      1 ls       CALL  open(0x7f7fffffe5d8,0,0xff31302d6e722d62)
  24778      1 ls       NAMI  "/lib/libc.so.12"
  24778      1 ls       RET   open 3
  24778      1 ls       CALL  __fstat30(3,0x7f7fffffe508)
  24778      1 ls       RET   __fstat30 0
  24778      1 ls       CALL  mmap(0,0x1000,1,1,3,0x7f7f00000000,0)
  24778      1 ls       RET   mmap 140187698950144/0x7f7ffdff7000
  24778      1 ls       CALL  munmap(0x7f7ffdff7000,0x1000)
  24778      1 ls       RET   munmap 0
  24778      1 ls       CALL
 mmap(0,0x207000,5,0x14000002,3,0x7f7f00000000,0)
  24778      1 ls       RET   mmap 140187693744128/0x7f7ffdb00000
  24778      1 ls       CALL
 mmap(0x7f7ffdceb000,0xb000,3,0x12,3,0x7f7f00000000,0xeb000)
  24778      1 ls       RET   mmap 140187695755264/0x7f7ffdceb000
  24778      1 ls       CALL
 mmap(0x7f7ffdcf6000,0x11000,3,0x1012,0xffffffff,0x7f7f00000000,0)
  24778      1 ls       RET   mmap 140187695800320/0x7f7ffdcf6000
  24778      1 ls       CALL  mprotect(0x7f7ffdbeb000,0x100000,0)
  24778      1 ls       RET   mprotect 0
  24778      1 ls       CALL  close(3)
  24778      1 ls       RET   close 0
  24778      1 ls       CALL
 __sysctl(0x7f7fffffecb0,2,0x7f7ffdcfa320,0x7f7fffffeca8,0,0)
  24778      1 ls       RET   __sysctl 0
  24778      1 ls       CALL  issetugid
  24778      1 ls       RET   issetugid 0
  24778      1 ls       CALL  ioctl(1,TIOCGETA,0x7f7fffffecc0)
  24778      1 ls       GIO   fd 1 read 44 bytes
        "\^F#\0\0\^C\0\0\0\0\v\0\0\M-O\^E\0
 \^D\M^?\M^?\^?\^W\^U\^R\M^?\^C\^\\^Z\^Y\^Q\^S\^V\^O\^A\0\^T\M^?\0\M^V\0\0\0\M^V\0\0"
  24778      1 ls       RET   ioctl 0
  24778      1 ls       CALL  ioctl(1,TIOCGWINSZ,0x7f7fffffed00)
  24778      1 ls       GIO   fd 1 read 8 bytes
        "@\0\M^D\0\0\0\0\0"
  24778      1 ls       RET   ioctl 0
  24778      1 ls       CALL  getuid
  24778      1 ls       RET   getuid 1001/0x3e9, 1001/0x3e9
  24778      1 ls       CALL
 __sysctl(0x7f7fffffeb80,2,0x7f7fffffeb9c,0x7f7fffffeb90,0,0)
  24778      1 ls       RET   __sysctl 0
  24778      1 ls       CALL  readlink(0x7f7ffdbd92ac,0x7f7fffffebb0,0x3f)
  24778      1 ls       NAMI  "/etc/malloc.conf"
  24778      1 ls       RET   readlink -1 errno 2 No such file or directory
  24778      1 ls       CALL  mmap(0,0x1000,3,0x1002,0xffffffff,0,0)
  24778      1 ls       RET   mmap 140187698950144/0x7f7ffdff7000
  24778      1 ls       CALL  break(0x505838)
  24778      1 ls       RET   break 0
  24778      1 ls       CALL  break(0x506838)
  24778      1 ls       RET   break 0
  24778      1 ls       CALL  break(0x507000)
  24778      1 ls       RET   break 0
  24778      1 ls       CALL  break(0x508000)
  24778      1 ls       RET   break 0
  24778      1 ls       CALL  break(0x509000)
  24778      1 ls       RET   break 0
  24778      1 ls       CALL  break(0x50a000)
  24778      1 ls       RET   break 0
  24778      1 ls       CALL  break(0x50b000)
  24778      1 ls       RET   break 0
  24778      1 ls       CALL  __lstat30(0x50a168,0x50a170)
  24778      1 ls       NAMI  "."
  24778      1 ls       RET   __lstat30 0
  24778      1 ls       CALL  open(0x7f7ffdbd52fc,0,0)
  24778      1 ls       NAMI  "."
  24778      1 ls       RET   open 3
  24778      1 ls       CALL  fcntl(3,2,1)
  24778      1 ls       RET   fcntl 0
  24778      1 ls       CALL  fchdir(3)
  24778      1 ls       RET   fchdir 0
  24778      1 ls       CALL  open(0x7f7ffdbd52fc,0,0)
  24778      1 ls       NAMI  "."
  24778      1 ls       RET   open 4
  24778      1 ls       CALL  open(0x509000,4,0x50a100)
  24778      1 ls       NAMI  "."
  24778      1 ls       RET   open 5
  24778      1 ls       CALL  fcntl(5,2,1)
  24778      1 ls       RET   fcntl 0
  24778      1 ls       CALL  __fstat30(5,0x7f7fffffeb40)
  24778      1 ls       RET   __fstat30 0
  24778      1 ls       CALL
 __sysctl(0x7f7fffffe210,2,0x7f7ffdd05a60,0x7f7fffffe208,0,0)
  24778      1 ls       RET   __sysctl 0
  24778      1 ls       CALL  fstatvfs1(5,0x7f7fffffe270,2)
  24778      1 ls       RET   fstatvfs1 -1 errno 13 Permission denied
  24778      1 ls       CALL  close(5)
  24778      1 ls       RET   close 0
  24778      1 ls       CALL  fchdir(4)
  24778      1 ls       RET   fchdir 0
  24778      1 ls       CALL  close(4)
  24778      1 ls       RET   close 0
 - --------------------------------------------------------
 
 
    works.log:
 - --------------------------------------------------------
    959      1 ktrace   EMUL  "netbsd"
    959      1 ktrace   CALL
 execve(0x7f7fffffe870,0x7f7fffffed68,0x7f7fffffed80)
    959      1 ktrace   NAMI  "/home/pkgsrc/bin/ls"
    959      1 ktrace   RET   execve -1 errno 2 No such file or directory
    959      1 ktrace   CALL
 execve(0x7f7fffffe870,0x7f7fffffed68,0x7f7fffffed80)
    959      1 ktrace   NAMI  "/bin/ls"
    959      1 ktrace   NAMI  "/libexec/ld.elf_so"
    959      1 ls       EMUL  "netbsd"
    959      1 ls       RET   execve JUSTRETURN
    959      1 ls       CALL  mmap(0,0x8000,3,0x1002,0xffffffff,0,0)
    959      1 ls       RET   mmap 140187698954240/0x7f7ffdff8000
    959      1 ls       CALL  open(0x7f7ffde0a82e,0,0x7f7ffde0a82e)
    959      1 ls       NAMI  "/etc/ld.so.conf"
    959      1 ls       RET   open -1 errno 2 No such file or directory
    959      1 ls       CALL  open(0x7f7fffffe5d8,0,0xff31302d6e722d62)
    959      1 ls       NAMI  "/lib/libc.so.12"
    959      1 ls       RET   open 3
    959      1 ls       CALL  __fstat30(3,0x7f7fffffe508)
    959      1 ls       RET   __fstat30 0
    959      1 ls       CALL  mmap(0,0x1000,1,1,3,0x7f7f00000000,0)
    959      1 ls       RET   mmap 140187698950144/0x7f7ffdff7000
    959      1 ls       CALL  munmap(0x7f7ffdff7000,0x1000)
    959      1 ls       RET   munmap 0
    959      1 ls       CALL
 mmap(0,0x207000,5,0x14000002,3,0x7f7f00000000,0)
    959      1 ls       RET   mmap 140187693744128/0x7f7ffdb00000
    959      1 ls       CALL
 mmap(0x7f7ffdceb000,0xb000,3,0x12,3,0x7f7f00000000,0xeb000)
    959      1 ls       RET   mmap 140187695755264/0x7f7ffdceb000
    959      1 ls       CALL
 mmap(0x7f7ffdcf6000,0x11000,3,0x1012,0xffffffff,0x7f7f00000000,0)
    959      1 ls       RET   mmap 140187695800320/0x7f7ffdcf6000
    959      1 ls       CALL  mprotect(0x7f7ffdbeb000,0x100000,0)
    959      1 ls       RET   mprotect 0
    959      1 ls       CALL  close(3)
    959      1 ls       RET   close 0
    959      1 ls       CALL
 __sysctl(0x7f7fffffecb0,2,0x7f7ffdcfa320,0x7f7fffffeca8,0,0)
    959      1 ls       RET   __sysctl 0
    959      1 ls       CALL  issetugid
    959      1 ls       RET   issetugid 0
    959      1 ls       CALL  ioctl(1,TIOCGETA,0x7f7fffffecc0)
    959      1 ls       GIO   fd 1 read 44 bytes
        "\^B+\0\0\^C\0\0\0\0K\0\0\M-K\^E\0
 \^D\M^?\M^?\^?\^W\^U\^R\M^?\^C\^\\^Z\^Y\^Q\^S\^V\^O\^A\0\^T\M^?\M^@%\0\0\M^@%\0\0"
    959      1 ls       RET   ioctl 0
    959      1 ls       CALL  ioctl(1,TIOCGWINSZ,0x7f7fffffed00)
    959      1 ls       GIO   fd 1 read 8 bytes
        "2\0P\0\0\0\0\0"
    959      1 ls       RET   ioctl 0
    959      1 ls       CALL  getuid
    959      1 ls       RET   getuid 1001/0x3e9, 1001/0x3e9
    959      1 ls       CALL
 __sysctl(0x7f7fffffeb80,2,0x7f7fffffeb9c,0x7f7fffffeb90,0,0)
    959      1 ls       RET   __sysctl 0
    959      1 ls       CALL  readlink(0x7f7ffdbd92ac,0x7f7fffffebb0,0x3f)
    959      1 ls       NAMI  "/etc/malloc.conf"
    959      1 ls       RET   readlink -1 errno 2 No such file or directory
    959      1 ls       CALL  mmap(0,0x1000,3,0x1002,0xffffffff,0,0)
    959      1 ls       RET   mmap 140187698950144/0x7f7ffdff7000
    959      1 ls       CALL  break(0x505838)
    959      1 ls       RET   break 0
    959      1 ls       CALL  break(0x506838)
    959      1 ls       RET   break 0
    959      1 ls       CALL  break(0x507000)
    959      1 ls       RET   break 0
    959      1 ls       CALL  break(0x508000)
    959      1 ls       RET   break 0
    959      1 ls       CALL  break(0x509000)
    959      1 ls       RET   break 0
    959      1 ls       CALL  break(0x50a000)
    959      1 ls       RET   break 0
    959      1 ls       CALL  break(0x50b000)
    959      1 ls       RET   break 0
    959      1 ls       CALL  __lstat30(0x50a168,0x50a170)
    959      1 ls       NAMI  "."
    959      1 ls       RET   __lstat30 0
    959      1 ls       CALL  open(0x7f7ffdbd52fc,0,0)
    959      1 ls       NAMI  "."
    959      1 ls       RET   open 3
    959      1 ls       CALL  fcntl(3,2,1)
    959      1 ls       RET   fcntl 0
    959      1 ls       CALL  fchdir(3)
    959      1 ls       RET   fchdir 0
    959      1 ls       CALL  open(0x7f7ffdbd52fc,0,0)
    959      1 ls       NAMI  "."
    959      1 ls       RET   open 4
    959      1 ls       CALL  open(0x509000,4,0x50a100)
    959      1 ls       NAMI  "."
    959      1 ls       RET   open 5
    959      1 ls       CALL  fcntl(5,2,1)
    959      1 ls       RET   fcntl 0
    959      1 ls       CALL  __fstat30(5,0x7f7fffffeb40)
    959      1 ls       RET   __fstat30 0
    959      1 ls       CALL
 __sysctl(0x7f7fffffe210,2,0x7f7ffdd05a60,0x7f7fffffe208,0,0)
    959      1 ls       RET   __sysctl 0
    959      1 ls       CALL  fstatvfs1(5,0x7f7fffffe270,2)
    959      1 ls       RET   fstatvfs1 0
    959      1 ls       CALL  break(0x50c000)
    959      1 ls       RET   break 0
    959      1 ls       CALL  __fstat30(5,0x7f7fffffeb50)
    959      1 ls       RET   __fstat30 0
    959      1 ls       CALL  fchdir(5)
    959      1 ls       RET   fchdir 0
    959      1 ls       CALL  lseek(5,0,0,1)
    959      1 ls       RET   lseek 0
    959      1 ls       CALL  __getdents30(5,0x50b000,0x1000)
    959      1 ls       GIO   fd 5 read 440 bytes
 - --------------------------------------------------------
 
    Lines 40 and 92 (and below) differ.
 
    When ls fails:
  24778      1 ls       CALL  fstatvfs1(5,0x7f7fffffe270,2)
  24778      1 ls       RET   fstatvfs1 -1 errno 13 Permission denied
 
    When ls succeeds:
    959      1 ls       CALL  fstatvfs1(5,0x7f7fffffe270,2)
    959      1 ls       RET   fstatvfs1 0
 
    I find it important to stress that I have done no system
 configuration changes between these runs.
 
 
 - --
 Kind regards,
 Jan Danielsson
 
 -----BEGIN PGP SIGNATURE-----
 Version: GnuPG v1.4.7 (NetBSD)
 
 iD8DBQFG7VWruPlHKFfKXTYRCu+lAKCWYHfLAtOoDta01GQlF/9WjsgoVgCghCSb
 JWXrT45cH+YQ9y9Yo4Ed7YQ=
 =/CTo
 -----END PGP SIGNATURE-----