6635 call_reserveresult (status 0) RPC: 16635 call_refresh (status 0) RPC: 16635 refreshing UNIX cred ec632900 RPC: 16635 call_refreshresult (status 0) RPC: 16635 call_allocate (status 0) RPC: 16635 allocated buffer of size 560 at eeec7800 RPC: 16635 call_bind (status 0) RPC: 16635 call_connect xprt eeebe000 is connected RPC: 16635 call_transmit (status 0) RPC: 16635 xprt_prepare_transmit RPC: 16635 rpc_xdr_encode (status 0) RPC: 16635 marshaling UNIX cred ec632900 RPC: 16635 using AUTH_UNIX cred ec632900 to wrap rpc data RPC: 16635 xprt_transmit(152) RPC: xs_tcp_send_request(152) = 152 RPC: 16635 xmit complete RPC: 16635 sleep_on(queue "xprt_pending" time 237537206) RPC: 16635 added to queue eeebe1ac "xprt_pending" RPC: 16635 setting alarm for 60000 ms RPC: wake_up_next(eeebe154 "xprt_resend") RPC: wake_up_next(eeebe0fc "xprt_sending") RPC: 16635 sync task going to sleep RPC: xs_tcp_data_ready... RPC: xs_tcp_data_recv started RPC: reading TCP record fragment of length 120 RPC: reading XID (4 bytes) RPC: reading reply for XID 440e8c4d RPC: reading CALL/REPLY flag (4 bytes) RPC: read reply XID 440e8c4d RPC: XID 440e8c4d read 112 bytes RPC: xprt = eeebe000, tcp_copied = 120, tcp_offset = 120, tcp_reclen = 120 RPC: 16635 xid 440e8c4d complete (120 bytes received) RPC: 16635 __rpc_wake_up_task (now 237537206) RPC: 16635 disabling timer RPC: 16635 removed from queue eeebe1ac "xprt_pending" RPC: __rpc_wake_up_task done RPC: xs_tcp_data_recv done RPC: 16635 sync task resuming RPC: 16635 call_status (status 120) RPC: 16635 call_decode (status 120) RPC: 16635 validating UNIX cred ec632900 RPC: 16635 using AUTH_UNIX cred ec632900 to unwrap rpc data RPC: 16635 call_decode result 0 RPC: 16635 return 0, status 0 RPC: 16635 release task RPC: freeing buffer of size 560 at eeec7800 RPC: 16635 release request ef816570 RPC: wake_up_next(eeebe204 "xprt_backlog") RPC: rpc_release_client(eeef7a00) RPC: 16635 freeing task NFS: nfs_update_inode(0:12/4751361 ct=2 info=0x7e7f) NFS reply access: 0 NFS: permission(0:12/4751361), mask=0x1, res=0 NFS: nfs_lookup_revalidate(/gentoo) is valid RPC: looking up Generic cred NFS call access RPC: new task initialized, procpid 3694 RPC: allocated task ec6f8080 RPC: 16636 __rpc_execute flags=0x80 RPC: 16636 call_start nfs3 proc ACCESS (sync) RPC: 16636 call_reserve (status 0) RPC: 16636 reserved req ef816570 xid 440e8c4e RPC: 16636 call_reserveresult (status 0) RPC: 16636 call_refresh (status 0) RPC: 16636 refreshing UNIX cred ec632900 RPC: 16636 call_refreshresult (status 0) RPC: 16636 call_allocate (status 0) RPC: 16636 allocated buffer of size 560 at eeed5800 RPC: 16636 call_bind (status 0) RPC: 16636 call_connect xprt eeebe000 is connected RPC: 16636 call_transmit (status 0) RPC: 16636 xprt_prepare_transmit RPC: 16636 rpc_xdr_encode (status 0) RPC: 16636 marshaling UNIX cred ec632900 RPC: 16636 using AUTH_UNIX cred ec632900 to wrap rpc data RPC: 16636 xprt_transmit(160) RPC: xs_tcp_send_request(160) = 160 RPC: 16636 xmit complete RPC: 16636 sleep_on(queue "xprt_pending" time 237537206) RPC: 16636 added to queue eeebe1ac "xprt_pending" RPC: 16636 setting alarm for 60000 ms RPC: wake_up_next(eeebe154 "xprt_resend") RPC: wake_up_next(eeebe0fc "xprt_sending") RPC: 16636 sync task going to sleep RPC: xs_tcp_data_ready... RPC: xs_tcp_data_recv started RPC: reading TCP record fragment of length 120 RPC: reading XID (4 bytes) RPC: reading reply for XID 440e8c4e RPC: reading CALL/REPLY flag (4 bytes) RPC: read reply XID 440e8c4e RPC: XID 440e8c4e read 112 bytes RPC: xprt = eeebe000, tcp_copied = 120, tcp_offset = 120, tcp_reclen = 120 RPC: 16636 xid 440e8c4e complete (120 bytes received) RPC: 16636 __rpc_wake_up_task (now 237537206) RPC: 16636 disabling timer RPC: 16636 removed from queue eeebe1ac "xprt_pending" RPC: __rpc_wake_up_task done RPC: xs_tcp_data_recv done RPC: 16636 sync task resuming RPC: 16636 call_status (status 120) RPC: 16636 call_decode (status 120) RPC: 16636 validating UNIX cred ec632900 RPC: 16636 using AUTH_UNIX cred ec632900 to unwrap rpc data RPC: 16636 call_decode result 0 RPC: 16636 return 0, status 0 RPC: 16636 release task RPC: freeing buffer of size 560 at eeed5800 RPC: 16636 release request ef816570 RPC: wake_up_next(eeebe204 "xprt_backlog") RPC: rpc_release_client(eeef7a00) RPC: 16636 freeing task NFS: nfs_update_inode(0:12/4046851 ct=1 info=0x7e7f) NFS reply access: 0 NFS: permission(0:12/4046851), mask=0x1, res=0 NFS: nfs_lookup_revalidate(gentoo/portage) is valid NFS: revalidating (0:13/2) NFS call getattr RPC: new task initialized, procpid 3694 RPC: allocated task ec6f8080 RPC: 16637 __rpc_execute flags=0x80 RPC: 16637 call_start nfs3 proc GETATTR (sync) RPC: 16637 call_reserve (status 0) RPC: 16637 reserved req ef816570 xid 440e8c4f RPC: 16637 call_reserveresult (status 0) RPC: 16637 call_refresh (status 0) RPC: 16637 looking up UNIX cred RPC: looking up UNIX cred RPC: 16637 refreshing UNIX cred ec632900 RPC: 16637 call_refreshresult (status 0) RPC: 16637 call_allocate (status 0) RPC: 16637 allocated buffer of size 548 at e0fcb000 RPC: 16637 call_bind (status 0) RPC: 16637 call_connect xprt eeebe000 is connected RPC: 16637 call_transmit (status 0) RPC: 16637 xprt_prepare_transmit RPC: 16637 rpc_xdr_encode (status 0) RPC: 16637 marshaling UNIX cred ec632900 RPC: 16637 using AUTH_UNIX cred ec632900 to wrap rpc data RPC: 16637 xprt_transmit(140) RPC: xs_tcp_send_request(140) = 140 RPC: 16637 xmit complete RPC: 16637 sleep_on(queue "xprt_pending" time 237537206) RPC: 16637 added to queue eeebe1ac "xprt_pending" RPC: 16637 setting alarm for 60000 ms RPC: wake_up_next(eeebe154 "xprt_resend") RPC: wake_up_next(eeebe0fc "xprt_sending") RPC: 16637 sync task going to sleep RPC: xs_tcp_data_ready... RPC: xs_tcp_data_recv started RPC: reading TCP record fragment of length 112 RPC: reading XID (4 bytes) RPC: reading reply for XID 440e8c4f RPC: reading CALL/REPLY flag (4 bytes) RPC: read reply XID 440e8c4f RPC: XID 440e8c4f read 104 bytes RPC: xprt = eeebe000, tcp_copied = 112, tcp_offset = 112, tcp_reclen = 112 RPC: 16637 xid 440e8c4f complete (112 bytes received) RPC: 16637 __rpc_wake_up_task (now 237537206) RPC: 16637 disabling timer RPC: 16637 removed from queue eeebe1ac "xprt_pending" RPC: __rpc_wake_up_task done RPC: xs_tcp_data_recv done RPC: 16637 sync task resuming RPC: 16637 call_status (status 112) RPC: 16637 call_decode (status 112) RPC: 16637 validating UNIX cred ec632900 RPC: 16637 using AUTH_UNIX cred ec632900 to unwrap rpc data RPC: 16637 call_decode result 0 RPC: 16637 return 0, status 0 RPC: 16637 release task RPC: freeing buffer of size 548 at e0fcb000 RPC: 16637 release request ef816570 RPC: wake_up_next(eeebe204 "xprt_backlog") RPC: rpc_release_client(eeef7c00) RPC: 16637 freeing task NFS reply getattr: 0 NFS: nfs_update_inode(0:13/2 ct=2 info=0x7e7f) NFS: (0:13/2) revalidation complete RPC: looking up Generic cred NFS: permission(0:12/4751361), mask=0x1, res=0 NFS: nfs_lookup_revalidate(/gentoo) is valid RPC: looking up Generic cred NFS: permission(0:12/4046851), mask=0x1, res=0 NFS: revalidating (0:12/4097180) NFS call getattr RPC: new task initialized, procpid 3694 RPC: allocated task ec6f8b00 RPC: 16638 __rpc_execute flags=0x80 RPC: 16638 call_start nfs3 proc GETATTR (sync) RPC: 16638 call_reserve (status 0) RPC: 16638 reserved req ef816570 xid 440e8c50 RPC: 16638 call_reserveresult (status 0) RPC: 16638 call_refresh (status 0) RPC: 16638 looking up UNIX cred RPC: looking up UNIX cred RPC: 16638 refreshing UNIX cred ec632900 RPC: 16638 call_refreshresult (status 0) RPC: 16638 call_allocate (status 0) RPC: 16638 allocated buffer of size 548 at ec74b000 RPC: 16638 call_bind (status 0) RPC: 16638 call_connect xprt eeebe000 is connected RPC: 16638 call_transmit (status 0) RPC: 16638 xprt_prepare_transmit RPC: 16638 rpc_xdr_encode (status 0) RPC: 16638 marshaling UNIX cred ec632900 RPC: 16638 using AUTH_UNIX cred ec632900 to wrap rpc data RPC: 16638 xprt_transmit(156) RPC: xs_tcp_send_request(156) = 156 RPC: 16638 xmit complete RPC: 16638 sleep_on(queue "xprt_pending" time 237537206) RPC: 16638 added to queue eeebe1ac "xprt_pending" RPC: 16638 setting alarm for 60000 ms RPC: wake_up_next(eeebe154 "xprt_resend") RPC: wake_up_next(eeebe0fc "xprt_sending") RPC: 16638 sync task going to sleep RPC: xs_tcp_data_ready... RPC: xs_tcp_data_recv started RPC: reading TCP record fragment of length 112 RPC: reading XID (4 bytes) RPC: reading reply for XID 440e8c50 RPC: reading CALL/REPLY flag (4 bytes) RPC: read reply XID 440e8c50 RPC: XID 440e8c50 read 104 bytes RPC: xprt = eeebe000, tcp_copied = 112, tcp_offset = 112, tcp_reclen = 112 RPC: 16638 xid 440e8c50 complete (112 bytes received) RPC: 16638 __rpc_wake_up_task (now 237537207) RPC: 16638 disabling timer RPC: 16638 removed from queue eeebe1ac "xprt_pending" RPC: __rpc_wake_up_task done RPC: xs_tcp_data_recv done RPC: 16638 sync task resuming RPC: 16638 call_status (status 112) RPC: 16638 call_decode (status 112) RPC: 16638 validating UNIX cred ec632900 RPC: 16638 using AUTH_UNIX cred ec632900 to unwrap rpc data RPC: 16638 call_decode result 0 RPC: 16638 return 0, status 0 RPC: 16638 release task RPC: freeing buffer of size 548 at ec74b000 RPC: 16638 release request ef816570 RPC: wake_up_next(eeebe204 "xprt_backlog") RPC: rpc_release_client(eeef7a00) RPC: 16638 freeing task NFS reply getattr: 0 NFS: nfs_update_inode(0:12/4097180 ct=1 info=0x7e7f) NFS: (0:12/4097180) revalidation complete NFS: nfs_lookup_revalidate(gentoo/portage) is valid RPC: looking up Generic cred NFS call access RPC: new task initialized, procpid 3694 RPC: allocated task ec6f8b00 RPC: 16639 __rpc_execute flags=0x80 RPC: 16639 call_start nfs3 proc ACCESS (sync) RPC: 16639 call_reserve (status 0) RPC: 16639 reserved req ef816570 xid 440e8c51 RPC: 16639 call_reserveresult (status 0) RPC: 16639 call_refresh (status 0) RPC: 16639 refreshing UNIX cred ec632900 RPC: 16639 call_refreshresult (status 0) RPC: 16639 call_allocate (status 0) RPC: 16639 allocated buffer of size 560 at eeed6800 RPC: 16639 call_bind (status 0) RPC: 16639 call_connect xprt eeebe000 is connected RPC: 16639 call_transmit (status 0) RPC: 16639 xprt_prepare_transmit RPC: 16639 rpc_xdr_encode (status 0) RPC: 16639 marshaling UNIX cred ec632900 RPC: 16639 using AUTH_UNIX cred ec632900 to wrap rpc data RPC: 16639 xprt_transmit(144) RPC: xs_tcp_send_request(144) = 144 RPC: 16639 xmit complete RPC: 16639 sleep_on(queue "xprt_pending" time 237537208) RPC: 16639 added to queue eeebe1ac "xprt_pending" RPC: 16639 setting alarm for 60000 ms RPC: wake_up_next(eeebe154 "xprt_resend") RPC: wake_up_next(eeebe0fc "xprt_sending") RPC: 16639 sync task going to sleep RPC: xs_tcp_data_ready... RPC: xs_tcp_data_recv started RPC: reading TCP record fragment of length 120 RPC: reading XID (4 bytes) RPC: reading reply for XID 440e8c51 RPC: reading CALL/REPLY flag (4 bytes) RPC: read reply XID 440e8c51 RPC: XID 440e8c51 read 112 bytes RPC: xprt = eeebe000, tcp_copied = 120, tcp_offset = 120, tcp_reclen = 120 RPC: 16639 xid 440e8c51 complete (120 bytes received) RPC: 16639 __rpc_wake_up_task (now 237537208) RPC: 16639 disabling timer RPC: 16639 removed from queue eeebe1ac "xprt_pending" RPC: __rpc_wake_up_task done RPC: xs_tcp_data_recv done RPC: 16639 sync task resuming RPC: 16639 call_status (status 120) RPC: 16639 call_decode (status 120) RPC: 16639 validating UNIX cred ec632900 RPC: 16639 using AUTH_UNIX cred ec632900 to unwrap rpc data RPC: 16639 call_decode result 0 RPC: 16639 return 0, status 0 RPC: 16639 release task RPC: freeing buffer of size 560 at eeed6800 RPC: 16639 release request ef816570 RPC: wake_up_next(eeebe204 "xprt_backlog") RPC: rpc_release_client(eeef7c00) RPC: 16639 freeing task NFS: nfs_update_inode(0:13/2 ct=2 info=0x7e7f) NFS reply access: 0 NFS: permission(0:13/2), mask=0x24, res=0 NFS: open dir(/) RPC: looking up Generic cred NFS: revalidating (0:13/2) NFS call getattr RPC: new task initialized, procpid 3694 RPC: allocated task ec6f8b00 RPC: 16640 __rpc_execute flags=0x80 RPC: 16640 call_start nfs3 proc GETATTR (sync) RPC: 16640 call_reserve (status 0) RPC: 16640 reserved req ef816570 xid 440e8c52 RPC: 16640 call_reserveresult (status 0) RPC: 16640 call_refresh (status 0) RPC: 16640 looking up UNIX cred RPC: looking up UNIX cred RPC: 16640 refreshing UNIX cred ec632900 RPC: 16640 call_refreshresult (status 0) RPC: 16640 call_allocate (status 0) RPC: 16640 allocated buffer of size 548 at ec5e3800 RPC: 16640 call_bind (status 0) RPC: 16640 call_connect xprt eeebe000 is connected RPC: 16640 call_transmit (status 0) RPC: 16640 xprt_prepare_transmit RPC: 16640 rpc_xdr_encode (status 0) RPC: 16640 marshaling UNIX cred ec632900 RPC: 16640 using AUTH_UNIX cred ec632900 to wrap rpc data RPC: 16640 xprt_transmit(140) RPC: xs_tcp_send_request(140) = 140 RPC: 16640 xmit complete RPC: 16640 sleep_on(queue "xprt_pending" time 237537208) RPC: 16640 added to queue eeebe1ac "xprt_pending" RPC: 16640 setting alarm for 60000 ms RPC: wake_up_next(eeebe154 "xprt_resend") RPC: wake_up_next(eeebe0fc "xprt_sending") RPC: 16640 sync task going to sleep RPC: xs_tcp_data_ready... RPC: xs_tcp_data_recv started RPC: reading TCP record fragment of length 112 RPC: reading XID (4 bytes) RPC: reading reply for XID 440e8c52 RPC: reading CALL/REPLY flag (4 bytes) RPC: read reply XID 440e8c52 RPC: XID 440e8c52 read 104 bytes RPC: xprt = eeebe000, tcp_copied = 112, tcp_offset = 112, tcp_reclen = 112 RPC: 16640 xid 440e8c52 complete (112 bytes received) RPC: 16640 __rpc_wake_up_task (now 237537208) RPC: 16640 disabling timer RPC: 16640 removed from queue eeebe1ac "xprt_pending" RPC: __rpc_wake_up_task done RPC: xs_tcp_data_recv done RPC: 16640 sync task resuming RPC: 16640 call_status (status 112) RPC: 16640 call_decode (status 112) RPC: 16640 validating UNIX cred ec632900 RPC: 16640 using AUTH_UNIX cred ec632900 to unwrap rpc data RPC: 16640 call_decode result 0 RPC: 16640 return 0, status 0 RPC: 16640 release task RPC: freeing buffer of size 548 at ec5e3800 RPC: 16640 release request ef816570 RPC: wake_up_next(eeebe204 "xprt_backlog") RPC: rpc_release_client(eeef7c00) RPC: 16640 freeing task NFS reply getattr: 0 NFS: nfs_update_inode(0:13/2 ct=2 info=0x7e7f) NFS: (0:13/2) revalidation complete NFS: readdir(/) starting at cookie 0 NFS: nfs_do_filldir() filling ended @ cookie 2440; returning = 0 NFS: nfs_do_filldir() filling ended @ cookie 4096; returning = 0 NFS: readdir(/) returns 0 NFS: readdir(/) starting at cookie 166 NFS: readdir(/) returns 0