Attachment 612795 Details for Bug 857402 – RPC debug file

RPC debug file

rpc_debug.txt (text/plain), 21.00 KB, created by Thomas on 2012-09-14 10:29:56 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Thomas

Created: 2012-09-14 10:29:56 UTC

Size: 21.00 KB

patch

obsolete

>Sep 13 15:45:02 tlsbld035 kernel: device eth0 entered promiscuous mode
>Sep 13 15:45:03 tlsbld035 kernel: uhci_hcd 0000:01:00.4: Controller not stopped yet!
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_error_report client ffff88101728a000...
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       error 110
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 __rpc_wake_up_task (now 5669699467)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 disabling timer
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 removed from queue ffff88101728a258 "xprt_pending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       __rpc_wake_up_task done
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_tcp_state_change client ffff88101728a000...
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       state 7 conn 0 dead 0 zapped 1 sk_shutdown 3
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       disconnected transport ffff88101728a000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 sync task resuming
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 xprt_connect_status: retrying
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 call_connect_status (status -11)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 call_transmit (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 xprt_prepare_transmit
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 rpc_xdr_encode (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 marshaling UNIX cred ffff88201648ebc0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 using AUTH_UNIX cred ffff88201648ebc0 to wrap rpc data
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 xprt_transmit(120)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_tcp_send_request(120) = -110
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       sendmsg returned unrecognized error 110
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_tcp_state_change client ffff88101728a000...
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       state 7 conn 0 dead 0 zapped 1 sk_shutdown 3
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       disconnected transport ffff88101728a000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 call_transmit_status (status -110)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       wake_up_next(ffff88101728a190 "xprt_sending")
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 __rpc_wake_up_task (now 5669699467)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 removed from queue ffff88101728a190 "xprt_sending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       __rpc_wake_up_task done
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 call_status (status -110)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 call_timeout (major)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 invalidating UNIX cred ffff88201648ebc0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 call_bind (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 call_connect xprt ffff88101728a000 is not connected
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 xprt_connect xprt ffff88101728a000 is not connected
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 failed to lock transport ffff88101728a000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 sleep_on(queue "xprt_sending" time 5669699467)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 added to queue ffff88101728a190 "xprt_sending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3826 sync task going to sleep
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 sync task resuming
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 call_connect_status (status -11)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 call_transmit (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 xprt_prepare_transmit
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 rpc_xdr_encode (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 marshaling UNIX cred ffff88201648e980
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 using AUTH_UNIX cred ffff88201648e980 to wrap rpc data
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 xprt_transmit(116)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_tcp_send_request(116) = -32
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_tcp_state_change client ffff88101728a000...
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       state 7 conn 0 dead 0 zapped 1 sk_shutdown 3
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       disconnected transport ffff88101728a000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 call_status (status -32)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 call_bind (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 call_connect xprt ffff88101728a000 is not connected
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 xprt_connect xprt ffff88101728a000 is not connected
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 sleep_on(queue "xprt_pending" time 5669699467)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 added to queue ffff88101728a258 "xprt_pending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 setting alarm for 180000 ms
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3827 sync task going to sleep
>Sep 13 15:45:06 tlsbld035 kernel: NFS: nfs mount opts='addr=10.237.185.20,vers=3,proto=tcp,mountvers=3,mountproto=udp,mountport=4046'
>Sep 13 15:45:06 tlsbld035 kernel: NFS:   parsing nfs mount option 'addr=10.237.185.20'
>Sep 13 15:45:06 tlsbld035 kernel: NFS:   parsing nfs mount option 'vers=3'
>Sep 13 15:45:06 tlsbld035 kernel: NFS:   parsing nfs mount option 'proto=tcp'
>Sep 13 15:45:06 tlsbld035 kernel: NFS:   parsing nfs mount option 'mountvers=3'
>Sep 13 15:45:06 tlsbld035 kernel: NFS:   parsing nfs mount option 'mountproto=udp'
>Sep 13 15:45:06 tlsbld035 kernel: NFS:   parsing nfs mount option 'mountport=4046'
>Sep 13 15:45:06 tlsbld035 kernel: NFS: MNTPATH: '/vol/vol1/home'
>Sep 13 15:45:06 tlsbld035 kernel: NFS: sending MNT request for 10.237.185.20:/vol/vol1/home
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       set up xprt to 10.237.185.20 (port 4046) via udp
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       created transport ffff881017c8c000 with 16 slots
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       creating mount client for 10.237.185.20 (xprt ffff881017c8c000)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       creating UNIX authenticator for client ffff8810179a9000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       new task initialized, procpid 47082
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       allocated task ffff88016a844dc0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 __rpc_execute flags=0x680
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_start mount3 proc NULL (sync)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_reserve (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 reserved req ffff8810179a9400 xid 3f047120
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       wake_up_next(ffff881017c8c190 "xprt_sending")
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_reserveresult (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_refresh (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 holding NULL cred ffffffffa0229f20
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 refreshing NULL cred ffffffffa0229f20
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_refreshresult (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_allocate (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 allocated buffer of size 96 at ffff880d5e713000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_bind (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_connect xprt ffff881017c8c000 is not connected
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 xprt_connect xprt ffff881017c8c000 is not connected
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 xprt_cwnd_limited cong = 0 cwnd = 256
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 sleep_on(queue "xprt_pending" time 5669700251)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 added to queue ffff881017c8c258 "xprt_pending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 setting alarm for 5000 ms
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_connect scheduled xprt ffff881017c8c000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 sync task going to sleep
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_bind 0.0.0.0:778: ok (0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       worker connecting xprt ffff881017c8c000 via udp to 10.237.185.20 (port 4046)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 __rpc_wake_up_task (now 5669700251)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 disabling timer
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 removed from queue ffff881017c8c258 "xprt_pending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       __rpc_wake_up_task done
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 sync task resuming
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 xprt_connect_status: connection established
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_connect_status (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_transmit (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 xprt_prepare_transmit
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 rpc_xdr_encode (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 marshaling NULL cred ffffffffa0229f20
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 using AUTH_NULL cred ffffffffa0229f20 to wrap rpc data
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 xprt_transmit(40)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_udp_send_request(40) = 40
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 xmit complete
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 sleep_on(queue "xprt_pending" time 5669700251)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 added to queue ffff881017c8c258 "xprt_pending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 setting alarm for 5000 ms
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 sync task going to sleep
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_udp_data_ready...
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       cong 256, cwnd was 256, now 512
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       wake_up_next(ffff881017c8c190 "xprt_sending")
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 xid 3f047120 complete (24 bytes received)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 __rpc_wake_up_task (now 5669700251)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 disabling timer
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 removed from queue ffff881017c8c258 "xprt_pending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       __rpc_wake_up_task done
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 sync task resuming
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_status (status 24)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_decode (status 24)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 validating NULL cred ffffffffa0229f20
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 using AUTH_NULL cred ffffffffa0229f20 to unwrap rpc data
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 call_decode result 0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 return 0, status 0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 release task
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       freeing buffer of size 96 at ffff880d5e713000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 release request ffff8810179a9400
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       wake_up_next(ffff881017c8c320 "xprt_backlog")
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       rpc_release_client(ffff8810179a9000)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3914 freeing task
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       new task initialized, procpid 47082
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       allocated task ffff88016a844dc0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 __rpc_execute flags=0x280
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_start mount3 proc MOUNT (sync)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_reserve (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 reserved req ffff8810179a9400 xid 40047120
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       wake_up_next(ffff881017c8c190 "xprt_sending")
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_reserveresult (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_refresh (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 looking up UNIX cred
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       looking up UNIX cred
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 refreshing UNIX cred ffff88201648e980
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_refreshresult (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_allocate (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 allocated buffer of size 1512 at ffff880d5e713000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_bind (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_connect xprt ffff881017c8c000 is connected
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_transmit (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 xprt_prepare_transmit
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 xprt_cwnd_limited cong = 0 cwnd = 512
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 rpc_xdr_encode (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 marshaling UNIX cred ffff88201648e980
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 using AUTH_UNIX cred ffff88201648e980 to wrap rpc data
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 xprt_transmit(96)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_udp_send_request(96) = 96
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 xmit complete
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 sleep_on(queue "xprt_pending" time 5669700251)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 added to queue ffff881017c8c258 "xprt_pending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 setting alarm for 5000 ms
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       wake_up_next(ffff881017c8c190 "xprt_sending")
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 sync task going to sleep
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_udp_data_ready...
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       cong 256, cwnd was 512, now 512
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       wake_up_next(ffff881017c8c190 "xprt_sending")
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 xid 40047120 complete (72 bytes received)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 __rpc_wake_up_task (now 5669700252)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 disabling timer
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 removed from queue ffff881017c8c258 "xprt_pending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       __rpc_wake_up_task done
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 sync task resuming
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_status (status 72)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_decode (status 72)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 validating UNIX cred ffff88201648e980
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 using AUTH_UNIX cred ffff88201648e980 to unwrap rpc data
>Sep 13 15:45:06 tlsbld035 kernel: NFS: received 1 auth flavors
>Sep 13 15:45:06 tlsbld035 kernel: NFS:   auth flavor[0]: 1
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 call_decode result 0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 return 0, status 0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 release task
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       freeing buffer of size 1512 at ffff880d5e713000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 release request ffff8810179a9400
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       wake_up_next(ffff881017c8c320 "xprt_backlog")
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       rpc_release_client(ffff8810179a9000)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3915 freeing task
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       shutting down mount client for 10.237.185.20
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       rpc_release_client(ffff8810179a9000)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       destroying mount client for 10.237.185.20
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       destroying transport ffff881017c8c000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_destroy xprt ffff881017c8c000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       xs_close xprt ffff881017c8c000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       disconnected transport ffff881017c8c000
>Sep 13 15:45:06 tlsbld035 kernel: NFS: MNT request succeeded
>Sep 13 15:45:06 tlsbld035 kernel: NFS: using auth flavor 1
>Sep 13 15:45:06 tlsbld035 kernel: --> nfs_init_server()
>Sep 13 15:45:06 tlsbld035 kernel: --> nfs_get_client(10.237.185.20,v3)
>Sep 13 15:45:06 tlsbld035 kernel: --> nfs_get_client() = ffff88101643f400 [share]
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       new task initialized, procpid 47082
>Sep 13 15:45:06 tlsbld035 kernel: RPC:       allocated task ffff88016a844dc0
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3916 __rpc_execute flags=0x680
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3916 call_start nfsacl3 proc NULL (sync)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3916 call_reserve (status 0)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3916 failed to lock transport ffff88101728a000
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3916 sleep_on(queue "xprt_sending" time 5669700252)
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3916 added to queue ffff88101728a190 "xprt_sending"
>Sep 13 15:45:06 tlsbld035 kernel: RPC:  3916 sync task going to sleep
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3916 got signal
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3916 __rpc_wake_up_task (now 5669715826)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3916 removed from queue ffff88101728a190 "xprt_sending"
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       __rpc_wake_up_task done
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3916 sync task resuming
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3916 return -512, status -512
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3916 release task
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       rpc_release_client(ffff881015c98400)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3916 freeing task
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       shutting down nfsacl client for tlnap01a
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       rpc_release_client(ffff881015c98400)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       destroying nfsacl client for tlnap01a
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       rpc_release_client(ffff8810179a9000)
>Sep 13 15:45:22 tlsbld035 kernel: <-- nfs_init_server() = 0 [new ffff88101643f400]
>Sep 13 15:45:22 tlsbld035 kernel: --> nfs_probe_fsinfo()
>Sep 13 15:45:22 tlsbld035 kernel: NFS call  fsinfo
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       new task initialized, procpid 47082
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       allocated task ffff88016a844dc0
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 __rpc_execute flags=0x80
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 call_start nfs3 proc FSINFO (sync)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 call_reserve (status 0)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 failed to lock transport ffff88101728a000
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 sleep_on(queue "xprt_sending" time 5669715826)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 added to queue ffff88101728a190 "xprt_sending"
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 sync task going to sleep
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 got signal
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 __rpc_wake_up_task (now 5669715826)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 removed from queue ffff88101728a190 "xprt_sending"
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       __rpc_wake_up_task done
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 sync task resuming
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 return -512, status -512
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 release task
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       rpc_release_client(ffff8810179a9000)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3917 freeing task
>Sep 13 15:45:22 tlsbld035 kernel: NFS reply fsinfo: -512
>Sep 13 15:45:22 tlsbld035 kernel: NFS call  fsinfo
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       new task initialized, procpid 47082
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       allocated task ffff88016a844dc0
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 __rpc_execute flags=0x280
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 call_start nfs3 proc FSINFO (sync)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 call_reserve (status 0)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 failed to lock transport ffff88101728a000
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 sleep_on(queue "xprt_sending" time 5669715826)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 added to queue ffff88101728a190 "xprt_sending"
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 sync task going to sleep
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 got signal
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 __rpc_wake_up_task (now 5669715826)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 removed from queue ffff88101728a190 "xprt_sending"
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       __rpc_wake_up_task done
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 sync task resuming
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 return -512, status -512
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 release task
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       rpc_release_client(ffff881015775000)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:  3918 freeing task
>Sep 13 15:45:22 tlsbld035 kernel: NFS reply fsinfo: -512
>Sep 13 15:45:22 tlsbld035 kernel: nfs_probe_fsinfo: error = 512
>Sep 13 15:45:22 tlsbld035 kernel: --> nfs_free_server()
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       shutting down nfs client for tlnap01a
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       rpc_release_client(ffff8810179a9000)
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       destroying nfs client for tlnap01a
>Sep 13 15:45:22 tlsbld035 kernel: RPC:       rpc_release_client(ffff881015775000)
>Sep 13 15:45:22 tlsbld035 kernel: --> nfs_put_client({2})
>Sep 13 15:45:22 tlsbld035 kernel: <-- nfs_free_server()
>Sep 13 15:45:24 tlsbld035 kernel: device eth0 left promiscuous mode

Actions: View

Attachments on bug 857402: 612794 | 612795