[OpenAFS] 1.4.0 on Solaris 10 x86/amd64

Loic Tortay tortay@cc.in2p3.fr
Fri, 11 Nov 2005 22:44:53 +0100


--5QAgd0e35j3NYeGe
Content-Type: text/plain; charset=iso-8859-1
Content-Disposition: inline
Content-Transfer-Encoding: quoted-printable
X-MIME-Autoconverted: from 8bit to quoted-printable by ccmail.in2p3.fr id jACJvQXw069476

According to chas williams - CONTRACTOR:
> In message <20051110115621.A24867@ccdevli1.in2p3.fr>,Loic Tortay writes=
:
> >The volume name requested is really "line noise".
>
> ok.  after looking at the code, i dont see anything obviously wrong
> and since other 64-bit platforms dont seem to have a problem i am
> forced to think it might be a compiler issue.  can you apply
> this to a broken version and let me know what you see.
>
> also, you might try 'fs lsm /afs/whatever' just to see what
> it says.
>
Done, I included the change you proposed for the CM_TRACE_GETVOL macro
("%p" format specifier instead of "%x").

The added debug output is:
  avc->linkData
  cpos <null string>
  volnamep =EDf=FF=FF=FF=FF/afs
  avc->linkData
  cpos <null string>
  volnamep \355f\214\377\377\377\377/afs
  avc->linkData
  cpos <null string>
  volnamep \355f\214\377\377\377\377/afs
  avc->linkData
  cpos <null string>
  volnamep \355f\214\377\377\377\377/afs

"fs lsm /afs/in2p3.fr" gives the following error (the error is the same
with other cells):
 'in2p3.fr' is not a mount point.

I attached the "fstrace" output for a few basic commands ("cd
/afs/in2p3.fr", "ls -l /afs/in2p3.fr" and "fs lsm /afs/in2p3.fr").


We had what really looked like a compiler issue with Studio 10 on AMD64
for one of our local software (when using the optimizer with
"-xarch=3Damd64 -fast"), that's why we're using the "117837-05" patch for
the C compiler.

But in
<https://lists.openafs.org/pipermail/openafs-info/2005-November/020104.ht=
ml>,
Kris Kasner mentioned that he had the original problem even when using GC=
C.


Lo=EFc.
--=20
| Lo=EFc Tortay <tortay@cc.in2p3.fr> -     IN2P3 Computing Centre     |

--5QAgd0e35j3NYeGe
Content-Type: text/plain; charset=iso-8859-1
Content-Disposition: attachment; filename="1382c.log"
Content-Transfer-Encoding: quoted-printable
X-MIME-Autoconverted: from 8bit to quoted-printable by ccmail.in2p3.fr id jACJvQXw069476

AFS Trace Dump -

   Date: Fri Nov 11 22:15:25 2005

Found 1 logs.

Contents of log cmfx:
time 452.000000, pid 0: Fri Nov 11 22:14:44 2005


time 452.000000, pid 344: RPC GetVolumeByName for 536871133 (at 0x9bb8e6)=
=20
time -1551.-626552, pid 0: Fri Nov 11 22:14:44 2005


time -1551.-626552, pid 344: Analyze RPC op -1 conn 0x889315c8 code 0x0 u=
ser 0x0=20
time -1491.-359488, pid 0: Fri Nov 11 22:14:44 2005


time -1491.-359488, pid 344: Analyze RPC op 2 conn 0x88931a50 code 0x0 us=
er 0x64=20
time 462.205880, pid 0: Fri Nov 11 22:14:44 2005


time 462.205880, pid 344: ProcessFS vp 0x8c2ab000 old len (0x0, 0x800) ne=
w len (0x9bb8f0, 0x800)=20
time 378.564965, pid 0: Fri Nov 11 22:14:44 2005


time 378.564965, pid 344: RPC GetVolumeByName for 536871133 (at 0x9bb826)=
=20
time -1551.-626552, pid 0: Fri Nov 11 22:14:44 2005


time -1551.-626552, pid 344: Analyze RPC op -1 conn 0x889315c8 code 0x0 u=
ser 0x0=20
time 175.749413, pid 0: Fri Nov 11 22:14:44 2005


time 175.749413, pid 344: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 175.749413, pid 0: Fri Nov 11 22:14:44 2005


time 175.749413, pid 344: GetdCache tlen 0x800 flags 0x1 abyte (0x0, 0x0)=
 Position (0x9bba70, 0x0)=20
time -1491.-359488, pid 0: Fri Nov 11 22:14:44 2005


time -1491.-359488, pid 344: Analyze RPC op 2 conn 0x88931a50 code 0x0 us=
er 0x64=20
time 462.205880, pid 0: Fri Nov 11 22:14:44 2005


time 462.205880, pid 344: ProcessFS vp 0x8c2ab000 old len (0x0, 0x800) ne=
w len (0x9bb8f0, 0x800)=20
time 175.749413, pid 0: Fri Nov 11 22:14:44 2005


time 175.749413, pid 344: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 175.749413, pid 0: Fri Nov 11 22:14:44 2005


time 175.749413, pid 344: GetdCache tlen 0x800 flags 0x1 abyte (0xfffffff=
f, 0x0) Position (0x9bba70, 0x0)=20
time 452.000000, pid 0: Fri Nov 11 22:14:44 2005


time 452.000000, pid 344: Lookup adp 0x8c2ab000 name in2p3.fr fid (11:536=
871133.2.5412), code=3D0=20
time -1491.-358864, pid 0: Fri Nov 11 22:14:44 2005


time -1491.-358864, pid 344: Analyze RPC op 2 conn 0x88931a50 code 0x0 us=
er 0x64=20
time 462.205880, pid 0: Fri Nov 11 22:14:44 2005


time 462.205880, pid 344: ProcessFS vp 0x8c2ab270 old len (0x0, 0xb) new =
len (0x9bb920, 0xb)=20
time 462.205880, pid 0: Fri Nov 11 22:14:44 2005


time 462.205880, pid 344: RPC GetVolumeByName for =EDf=8C=FF=FF=FF=FF/afs=
 (at 0x88b4b621)=20
time -1551.-626552, pid 0: Fri Nov 11 22:14:44 2005


time -1551.-626552, pid 344: Analyze RPC op -1 conn 0x889315c8 code 0x58c=
07 user 0x0=20
time 175.245092, pid 0: Fri Nov 11 22:14:44 2005


time 175.245092, pid 344: Returning code 19 from 19=20
time 175.749413, pid 0: Fri Nov 11 22:14:44 2005


time 175.749413, pid 344: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 175.749413, pid 0: Fri Nov 11 22:14:44 2005


time 175.749413, pid 344: GetdCache tlen 0x800 flags 0x1 abyte (0x0, 0x0)=
 Position (0x9bba70, 0x0)=20
time 452.000000, pid 0: Fri Nov 11 22:14:44 2005


time 452.000000, pid 344: Lookup adp 0x8c2ab000 name in2p3.fr fid (11:536=
871133.2.5412), code=3D0=20
time 452.065536, pid 0: Fri Nov 11 22:14:44 2005


time 452.065536, pid 344: RPC GetVolumeByName for =EDf=8C=FF=FF=FF=FF/afs=
 (at 0x88b4b621)=20
time -1551.-626552, pid 0: Fri Nov 11 22:14:44 2005


time -1551.-626552, pid 344: Analyze RPC op -1 conn 0x889315c8 code 0x58c=
07 user 0x0=20
time 175.245092, pid 0: Fri Nov 11 22:14:44 2005


time 175.245092, pid 344: Returning code 19 from 19=20
time -1491.-359488, pid 0: Fri Nov 11 22:14:44 2005


time -1491.-359488, pid 344: vfs root vp 0x8c2ab000, code 0=20
time 175.749413, pid 0: Fri Nov 11 22:14:44 2005


time 175.749413, pid 344: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 175.749413, pid 0: Fri Nov 11 22:14:44 2005


time 175.749413, pid 344: GetdCache tlen 0x800 flags 0x1 abyte (0x0, 0x0)=
 Position (0x9bba70, 0x0)=20
time 452.000000, pid 0: Fri Nov 11 22:14:44 2005


time 452.000000, pid 344: Lookup adp 0x8c2ab000 name in2p3.fr fid (11:536=
871133.2.5412), code=3D0=20
time 452.065536, pid 0: Fri Nov 11 22:14:44 2005


time 452.065536, pid 344: RPC GetVolumeByName for =EDf=8C=FF=FF=FF=FF/afs=
 (at 0x88b4b621)=20
time -1551.-626552, pid 0: Fri Nov 11 22:14:44 2005


time -1551.-626552, pid 344: Analyze RPC op -1 conn 0x889315c8 code 0x58c=
07 user 0x0=20
time 175.245092, pid 0: Fri Nov 11 22:14:44 2005


time 175.245092, pid 344: Returning code 19 from 19=20
time 180.749413, pid 0: Fri Nov 11 22:14:49 2005


time 180.749413, pid 393: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 180.749413, pid 0: Fri Nov 11 22:14:49 2005


time 180.749413, pid 393: GetdCache tlen 0x800 flags 0x1 abyte (0x0, 0x0)=
 Position (0x9df9e0, 0x0)=20
time 457.000000, pid 0: Fri Nov 11 22:14:49 2005


time 457.000000, pid 393: Lookup adp 0x8c2ab000 name in2p3.fr fid (11:536=
871133.2.5412), code=3D0=20
time 457.065536, pid 0: Fri Nov 11 22:14:49 2005


time 457.065536, pid 393: RPC GetVolumeByName for =EDf=8C=FF=FF=FF=FF/afs=
 (at 0x88b4b621)=20
time -1546.-626552, pid 0: Fri Nov 11 22:14:49 2005


time -1546.-626552, pid 393: Analyze RPC op -1 conn 0x889315c8 code 0x58c=
07 user 0x0=20
time 180.245092, pid 0: Fri Nov 11 22:14:49 2005


time 180.245092, pid 393: Returning code 19 from 19=20
time 184.749413, pid 0: Fri Nov 11 22:14:53 2005


time 184.749413, pid 344: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 184.749413, pid 0: Fri Nov 11 22:14:53 2005


time 184.749413, pid 344: GetdCache tlen 0x800 flags 0x1 abyte (0x0, 0x0)=
 Position (0x9bb9e0, 0x0)=20
time 461.000000, pid 0: Fri Nov 11 22:14:53 2005


time 461.000000, pid 344: Lookup adp 0x8c2ab000 name fs fid (11:536871133=
.-2018458368.-1), code=3D2=20
time -1482.-359488, pid 0: Fri Nov 11 22:14:53 2005


time -1482.-359488, pid 344: Returning code 2 from 19=20
time 184.749413, pid 0: Fri Nov 11 22:14:53 2005


time 184.749413, pid 394: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 184.749413, pid 0: Fri Nov 11 22:14:53 2005


time 184.749413, pid 394: GetdCache tlen 0x800 flags 0x1 abyte (0x0, 0x0)=
 Position (0x9df940, 0x0)=20
time 461.000000, pid 0: Fri Nov 11 22:14:53 2005


time 461.000000, pid 394: Lookup adp 0x8c2ab000 name fs fid (11:536871133=
.0.0), code=3D2=20
time -1482.-359488, pid 0: Fri Nov 11 22:14:53 2005


time -1482.-359488, pid 394: Returning code 2 from 19=20
time 190.749413, pid 0: Fri Nov 11 22:14:59 2005


time 190.749413, pid 395: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 190.749413, pid 0: Fri Nov 11 22:14:59 2005


time 190.749413, pid 395: GetdCache tlen 0x800 flags 0x1 abyte (0x0, 0x0)=
 Position (0x9df9d0, 0x0)=20
time 467.000000, pid 0: Fri Nov 11 22:14:59 2005


time 467.000000, pid 395: Lookup adp 0x8c2ab000 name in2p3.fr fid (11:536=
871133.2.5412), code=3D0=20
time 467.065536, pid 0: Fri Nov 11 22:14:59 2005


time 467.065536, pid 395: RPC GetVolumeByName for =EDf=8C=FF=FF=FF=FF/afs=
 (at 0x88b4b621)=20
time -1536.-626552, pid 0: Fri Nov 11 22:14:59 2005


time -1536.-626552, pid 395: Analyze RPC op -1 conn 0x889315c8 code 0x58c=
07 user 0x0=20
time 190.245092, pid 0: Fri Nov 11 22:14:59 2005


time 190.245092, pid 395: Returning code 19 from 19=20
time -1526.-614336, pid 0: Fri Nov 11 22:14:59 2005


time -1526.-614336, pid 395: Pioctl command 0x1d for vp 0x8c2ab000, follo=
w=3D1=20
time 190.749413, pid 0: Fri Nov 11 22:14:59 2005


time 190.749413, pid 395: GetdCache vp 0x8c2ab000 dcache 0x8c6465a0 dcach=
e low-version 0x66, vcache low-version 0x66=20
time 190.749413, pid 0: Fri Nov 11 22:14:59 2005


time 190.749413, pid 395: GetdCache tlen 0x800 flags 0x1 abyte (0xfffffe8=
0, 0x0) Position (0x9dfee0, 0x0)=20
time 190.772664, pid 0: Fri Nov 11 22:14:59 2005


time 190.772664, pid 395: Returning code 22 from 41=20
time -1522.-614336, pid 0: Fri Nov 11 22:15:03 2005


time -1522.-614336, pid 396: Pioctl command 0x4 for vp 0x8c2ab000, follow=
=3D1=20
time 481.354400, pid 0: Fri Nov 11 22:15:03 2005


time 481.354400, pid 396: Analyze RPC op 19 conn 0x88931a50 code 0x0 user=
 0x64=20

AFS Trace Dump - Completed

--5QAgd0e35j3NYeGe--