[69614.986106] --> nfs41_call_sync_prepare data->clp->cl_session ffff88003cfc2800 [69614.986140] --> nfs4_setup_sequence clp ffff88003735b000 session ffff88003cfc2800 sr_slotid 128 [69614.986146] --> nfs41_setup_sequence [69614.986150] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69614.986155] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69614.986160] <-- nfs41_setup_sequence slotid=0 seqid=427 [69614.986163] <-- nfs4_setup_sequence status=0 [69614.986174] encode_compound: tag= [69614.986179] encode_sequence: sessionid=1276120374:2:2:0 seqid=427 slotid=0 max_slotid=0 cache_this=0 [69614.986852] decode_attr_type: type=040000 [69614.986871] decode_attr_change: change attribute=10240360146138680363 [69614.986875] decode_attr_size: file size=101 [69614.986880] decode_attr_fsid: fsid=(0x0/0x0) [69614.986884] decode_attr_fileid: fileid=3240997 [69614.986888] decode_attr_fs_locations: fs_locations done, error = 0 [69614.986892] decode_attr_mode: file mode=0755 [69614.986896] decode_attr_nlink: nlink=2 [69614.986901] decode_attr_owner: uid=0 [69614.986905] decode_attr_group: gid=0 [69614.986908] decode_attr_rdev: rdev=(0x0:0x0) [69614.986912] decode_attr_space_used: space used=0 [69614.986916] decode_attr_time_access: atime=1276190047 [69614.986920] decode_attr_time_metadata: ctime=1276190094 [69614.986923] decode_attr_time_modify: mtime=1276190094 [69614.986927] decode_attr_mounted_on_fileid: fileid=0 [69614.986931] decode_getfattr: xdr returned 0 [69614.986935] nfs41_sequence_done: Error 0 free the slot [69614.986940] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69614.986953] NFS: nfs_update_inode(0:10/3240997 ct=2 info=0x27e7f) [69614.986962] NFS: permission(0:10/3240997), mask=0x1, res=0 [69614.986971] NFS: atomic_lookup(0:10/3240997), .config [69614.986976] NFS: lookup(/.config) [69614.986980] NFS call lookup .config [69614.986984] NFS call lookupfh .config [69614.986991] --> nfs41_call_sync_prepare data->clp->cl_session ffff88003cfc2800 [69614.986997] --> nfs4_setup_sequence clp ffff88003735b000 session ffff88003cfc2800 sr_slotid 128 [69614.987003] --> nfs41_setup_sequence [69614.987008] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69614.987013] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69614.987017] <-- nfs41_setup_sequence slotid=0 seqid=428 [69614.987021] <-- nfs4_setup_sequence status=0 [69614.987029] encode_compound: tag= [69614.987034] encode_sequence: sessionid=1276120374:2:2:0 seqid=428 slotid=0 max_slotid=0 cache_this=0 [69614.987356] nfs41_sequence_done: Error 0 free the slot [69614.987364] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69614.987372] NFS reply lookupfh: -2 [69614.987377] NFS reply lookup: -2 [69614.987385] NFS: dentry_delete(/.config, 0) [69614.987448] NFS: permission(0:10/3240997), mask=0x1, res=0 [69614.987455] NFS: permission(0:10/3240997), mask=0x1, res=0 [69614.987463] NFS: permission(0:10/3240997), mask=0x3, res=0 [69614.987469] NFS: create(0:10/3240997), .config [69614.987498] --> nfs4_setup_sequence clp ffff88003735b000 session ffff88003cfc2800 sr_slotid 128 [69614.987504] --> nfs41_setup_sequence [69614.987507] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69614.987512] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69614.987517] <-- nfs41_setup_sequence slotid=0 seqid=429 [69614.987520] <-- nfs4_setup_sequence status=0 [69614.987525] encode_compound: tag= [69614.987529] encode_sequence: sessionid=1276120374:2:2:0 seqid=429 slotid=0 max_slotid=0 cache_this=1 [69614.989458] decode_attr_type: type=0100000 [69614.989463] decode_attr_change: change attribute=11321224060349049907 [69614.989467] decode_attr_size: file size=0 [69614.989470] decode_attr_fsid: fsid=(0x0/0x0) [69614.989474] decode_attr_fileid: fileid=3898308 [69614.989477] decode_attr_fs_locations: fs_locations done, error = 0 [69614.989482] decode_attr_mode: file mode=00 [69614.989485] decode_attr_nlink: nlink=1 [69614.989488] decode_attr_owner: uid=-2 [69614.989491] decode_attr_group: gid=-2 [69614.989494] decode_attr_rdev: rdev=(0x0:0x0) [69614.989498] decode_attr_space_used: space used=0 [69614.989502] decode_attr_time_access: atime=1276190109 [69614.989505] decode_attr_time_metadata: ctime=1276190109 [69614.989509] decode_attr_time_modify: mtime=1276190109 [69614.989513] decode_attr_mounted_on_fileid: fileid=0 [69614.989516] decode_getfattr: xdr returned 0 [69614.989520] decode_attr_type: type=040000 [69614.989523] decode_attr_change: change attribute=11321224060349049907 [69614.989527] decode_attr_size: file size=115 [69614.989530] decode_attr_fsid: fsid=(0x0/0x0) [69614.989534] decode_attr_fileid: fileid=3240997 [69614.992015] decode_attr_fs_locations: fs_locations done, error = 0 [69614.992015] decode_attr_mode: file mode=0755 [69614.992015] decode_attr_nlink: nlink=2 [69614.992015] decode_attr_owner: uid=-2 [69614.992015] decode_attr_group: gid=-2 [69614.992015] decode_attr_rdev: rdev=(0x0:0x0) [69614.992015] decode_attr_space_used: space used=0 [69614.992015] decode_attr_time_access: atime=1276190047 [69614.992015] decode_attr_time_metadata: ctime=1276190109 [69614.992015] decode_attr_time_modify: mtime=1276190109 [69614.992015] decode_attr_mounted_on_fileid: fileid=0 [69614.992015] decode_getfattr: xdr returned 0 [69614.992015] nfs41_sequence_done: Error 0 free the slot [69614.992015] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69615.188744] NFS: nfs_update_inode(0:10/3240997 ct=2 info=0x27e67) [69615.188752] NFS: mtime change on server for file 0:10/3240997 [69615.188757] NFS: isize change on server for file 0:10/3240997 [69615.188771] NFS: nfs_fhget(0:10/3898308 ct=1) [69615.188788] --> nfs41_call_sync_prepare data->clp->cl_session ffff88003cfc2800 [69615.188795] --> nfs4_setup_sequence clp ffff88003735b000 session ffff88003cfc2800 sr_slotid 128 [69615.188801] --> nfs41_setup_sequence [69615.188805] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69615.188810] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69615.188814] <-- nfs41_setup_sequence slotid=0 seqid=430 [69615.188818] <-- nfs4_setup_sequence status=0 [69615.188827] encode_compound: tag= [69615.188832] encode_sequence: sessionid=1276120374:2:2:0 seqid=430 slotid=0 max_slotid=0 cache_this=1 [69615.189219] decode_attr_type: type=0100000 [69615.189227] decode_attr_change: change attribute=11393281653037021956 [69615.189233] decode_attr_size: file size=0 [69615.189238] decode_attr_fsid: fsid=(0x0/0x0) [69615.189243] decode_attr_fileid: fileid=3898308 [69615.189248] decode_attr_fs_locations: fs_locations done, error = 0 [69615.189254] decode_attr_mode: file mode=0644 [69615.189260] decode_attr_nlink: nlink=1 [69615.189265] decode_attr_owner: uid=0 [69615.189270] decode_attr_group: gid=0 [69615.189275] decode_attr_rdev: rdev=(0x0:0x0) [69615.189279] decode_attr_space_used: space used=0 [69615.189284] decode_attr_time_access: atime=1276190109 [69615.189290] decode_attr_time_metadata: ctime=1276190110 [69615.189297] decode_attr_time_modify: mtime=1276190109 [69615.189317] decode_attr_mounted_on_fileid: fileid=0 [69615.189325] decode_getfattr: xdr returned 0 [69615.189333] nfs41_sequence_done: Error 0 free the slot [69615.189338] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69615.189353] NFS: nfs_update_inode(0:10/3898308 ct=2 info=0x27e7f) [69615.189358] NFS: change_attr change on server for file 0:10/3898308 [69615.189365] NFS: open file(/.config) [69615.189374] NFS: permission(0:10/3898308), mask=0x0, res=0 [69615.189546] get_lock_alloc_layout Begin [69615.189551] NFS_FILELAYOUT: allocating layout [69615.189555] get_lock_alloc_layout Return ffff88003b058338 [69615.189559] pnfs_has_layout:Begin [69615.189563] pnfs_has_layout:Return lseg (null) take_ref 0 ref 0 valid 0 [69615.189568] --> get_layout [69615.189572] --> pnfs_layout_from_open_stateid [69615.189575] <-- pnfs_layout_from_open_stateid [69615.189579] --> pnfs4_proc_layoutget [69615.189583] --> nfs4_pnfs_layoutget_prepare [69615.189587] --> nfs4_setup_sequence clp ffff88003735b000 session ffff88003cfc2800 sr_slotid 128 [69615.189592] --> nfs41_setup_sequence [69615.189596] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69615.189601] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69615.189605] <-- nfs41_setup_sequence slotid=0 seqid=431 [69615.189608] <-- nfs4_setup_sequence status=0 [69615.189616] encode_compound: tag= [69615.189620] encode_sequence: sessionid=1276120374:2:2:0 seqid=431 slotid=0 max_slotid=0 cache_this=0 [69615.189626] encode_layoutget: 1st type:0x1 iomode:2 off:0 len:78013 mc:4096 [69615.190540] decode_layoutget roff:0 rlen:18446744073709551615 riomode:2, lo_type:0x1, lo.len:56 [69615.190549] --> nfs4_pnfs_layoutget_done [69615.190554] nfs41_sequence_done: Error 0 free the slot [69615.190559] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69615.190578] -->pnfs_get_layout_done [69615.190587] pnfs_get_layout_done end (err:0) state 0x0 lseg (null) [69615.190593] <-- nfs4_pnfs_layoutget_done [69615.190602] --> filelayout_alloc_lseg [69615.190608] filelayout_set_layout: set_layout_map Begin [69615.190615] filelayout_set_layout: nfl_util 0x2000 num_fh 1 fsi 0 po 0 dev_id 00000351 00000001 [69615.190636] DEBUG: filelayout_set_layout: fh len 16 [69615.190640] --> filelayout_check_layout [69615.190643] --> nfs4_find_deviceid hash 5 [69615.190647] nfs4_pnfs_device_item_find device id (00000351 00000001) nfs4_deviceid ffff88003b987f40 [69615.190653] filelayout_check_layout Stripe unit (8192) not aligned with rsize 262144 wsize 262144 [69615.194516] nfs4_set_layout_deviceid [5] [69615.194516] --> filelayout_check_layout returns 0 [69615.194516] pnfs_insert_layout:Begin [69615.194516] pnfs_insert_layout: inserted lseg ffff88003b987840 iomode 2 offset 0 length 18446744073709551615 at tail [69615.194516] pnfs_insert_layout:Return [69615.194516] --> nfs4_pnfs_layoutget_release [69615.194516] <-- nfs4_pnfs_layoutget_release [69615.194516] <-- pnfs4_proc_layoutget status=0 [69615.194516] <-- get_layout status 0 [69615.194516] pnfs_update_layout end (err:0) state 0x0 lseg (null) [69615.194516] NFS: write(/.config, 78013@0) [69615.194516] NFS: write_begin(/.config(3898308), 4096@0) [69615.390162] NFS: write_end(/.config(3898308), 4096@0) [69615.390169] NFS: nfs_updatepage(/.config 4096@0) [69615.390178] NFS: nfs_updatepage returns 0 (isize 4096) [69615.393101] NFS: write_begin(/.config(3898308), 4096@4096) [69615.393128] NFS: write_end(/.config(3898308), 4096@4096) [69615.393137] NFS: nfs_updatepage(/.config 4096@4096) [69615.393150] NFS: nfs_updatepage returns 0 (isize 8192) [69615.393155] NFS: write_begin(/.config(3898308), 4096@8192) [69615.393164] NFS: write_end(/.config(3898308), 4096@8192) [69615.393173] NFS: nfs_updatepage(/.config 4096@8192) [69615.393188] NFS: nfs_updatepage returns 0 (isize 12288) [69615.393194] NFS: write_begin(/.config(3898308), 4096@12288) [69615.393202] NFS: write_end(/.config(3898308), 4096@12288) [69615.393206] NFS: nfs_updatepage(/.config 4096@12288) [69615.393212] NFS: nfs_updatepage returns 0 (isize 16384) [69615.393217] NFS: write_begin(/.config(3898308), 4096@16384) [69615.393226] NFS: write_end(/.config(3898308), 4096@16384) [69615.393230] NFS: nfs_updatepage(/.config 4096@16384) [69615.393236] NFS: nfs_updatepage returns 0 (isize 20480) [69615.393241] NFS: write_begin(/.config(3898308), 4096@20480) [69615.393249] NFS: write_end(/.config(3898308), 4096@20480) [69615.393253] NFS: nfs_updatepage(/.config 4096@20480) [69615.393258] NFS: nfs_updatepage returns 0 (isize 24576) [69615.393263] NFS: write_begin(/.config(3898308), 4096@24576) [69615.393270] NFS: write_end(/.config(3898308), 4096@24576) [69615.393275] NFS: nfs_updatepage(/.config 4096@24576) [69615.393281] NFS: nfs_updatepage returns 0 (isize 28672) [69615.393285] NFS: write_begin(/.config(3898308), 4096@28672) [69615.393293] NFS: write_end(/.config(3898308), 4096@28672) [69615.393297] NFS: nfs_updatepage(/.config 4096@28672) [69615.393304] NFS: nfs_updatepage returns 0 (isize 32768) [69615.393310] NFS: write_begin(/.config(3898308), 4096@32768) [69615.393319] NFS: write_end(/.config(3898308), 4096@32768) [69615.393323] NFS: nfs_updatepage(/.config 4096@32768) [69615.393330] NFS: nfs_updatepage returns 0 (isize 36864) [69615.393334] NFS: write_begin(/.config(3898308), 4096@36864) [69615.393343] NFS: write_end(/.config(3898308), 4096@36864) [69615.393347] NFS: nfs_updatepage(/.config 4096@36864) [69615.393353] NFS: nfs_updatepage returns 0 (isize 40960) [69615.393358] NFS: write_begin(/.config(3898308), 4096@40960) [69615.393368] NFS: write_end(/.config(3898308), 4096@40960) [69615.393372] NFS: nfs_updatepage(/.config 4096@40960) [69615.393378] NFS: nfs_updatepage returns 0 (isize 45056) [69615.393383] NFS: write_begin(/.config(3898308), 4096@45056) [69615.393392] NFS: write_end(/.config(3898308), 4096@45056) [69615.393396] NFS: nfs_updatepage(/.config 4096@45056) [69615.393400] NFS: nfs_updatepage returns 0 (isize 49152) [69615.393404] NFS: write_begin(/.config(3898308), 4096@49152) [69615.393410] NFS: write_end(/.config(3898308), 4096@49152) [69615.393414] NFS: nfs_updatepage(/.config 4096@49152) [69615.393419] NFS: nfs_updatepage returns 0 (isize 53248) [69615.393423] NFS: write_begin(/.config(3898308), 4096@53248) [69615.393429] NFS: write_end(/.config(3898308), 4096@53248) [69615.393433] NFS: nfs_updatepage(/.config 4096@53248) [69615.393437] NFS: nfs_updatepage returns 0 (isize 57344) [69615.393441] NFS: write_begin(/.config(3898308), 4096@57344) [69615.393447] NFS: write_end(/.config(3898308), 4096@57344) [69615.393451] NFS: nfs_updatepage(/.config 4096@57344) [69615.393455] NFS: nfs_updatepage returns 0 (isize 61440) [69615.393459] NFS: write_begin(/.config(3898308), 4096@61440) [69615.393466] NFS: write_end(/.config(3898308), 4096@61440) [69615.393469] NFS: nfs_updatepage(/.config 4096@61440) [69615.393474] NFS: nfs_updatepage returns 0 (isize 65536) [69615.393478] NFS: write_begin(/.config(3898308), 4096@65536) [69615.393484] NFS: write_end(/.config(3898308), 4096@65536) [69615.393488] NFS: nfs_updatepage(/.config 4096@65536) [69615.393492] NFS: nfs_updatepage returns 0 (isize 69632) [69615.393497] NFS: write_begin(/.config(3898308), 4096@69632) [69615.393502] NFS: write_end(/.config(3898308), 4096@69632) [69615.393506] NFS: nfs_updatepage(/.config 4096@69632) [69615.393510] NFS: nfs_updatepage returns 0 (isize 73728) [69615.393515] NFS: write_begin(/.config(3898308), 4096@73728) [69615.393521] NFS: write_end(/.config(3898308), 4096@73728) [69615.393524] NFS: nfs_updatepage(/.config 4096@73728) [69615.590188] NFS: nfs_updatepage returns 0 (isize 77824) [69615.592903] NFS: write_begin(/.config(3898308), 189@77824) [69615.592913] NFS: write_end(/.config(3898308), 189@77824) [69615.592919] NFS: nfs_updatepage(/.config 189@77824) [69615.592927] NFS: nfs_updatepage returns 0 (isize 78013) [69615.592947] NFS: flush(/.config) [69615.592971] --> _pnfs_try_to_write_data [69615.592975] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.592980] pnfs_writepages: Writing ino:3898308 8192@0 [69615.592984] get_lock_alloc_layout Begin [69615.592988] get_lock_alloc_layout Return ffff88003b058338 [69615.592992] pnfs_has_layout:Begin [69615.592996] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 2 valid 1 [69615.593002] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@0 iomode 2) [69615.593007] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.593012] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.593017] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@0 sync 0 [69615.593034] nfs4_pnfs_dserver_get: offset=0, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.593042] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=0, count=8192 [69615.593049] filelayout_write_pagelist ino 3898308 8192@0 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.593056] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.593061] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 0) [69615.593071] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69615.593083] --> nfs41_setup_sequence [69615.593088] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69615.593093] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69615.593098] <-- nfs41_setup_sequence slotid=0 seqid=19 [69615.593102] <-- nfs4_setup_sequence status=0 [69615.593112] encode_compound: tag= [69615.593117] encode_sequence: sessionid=1276181646:3:3:0 seqid=19 slotid=0 max_slotid=0 cache_this=1 [69615.593170] pnfs_writepages End (trypnfs:0) [69615.593177] --> _pnfs_try_to_write_data [69615.593181] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.593185] pnfs_writepages: Writing ino:3898308 8192@8192 [69615.593189] get_lock_alloc_layout Begin [69615.593193] get_lock_alloc_layout Return ffff88003b058338 [69615.593196] pnfs_has_layout:Begin [69615.593200] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 3 valid 1 [69615.593205] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@8192 iomode 2) [69615.593211] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.593215] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.593221] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@8192 sync 0 [69615.593227] nfs4_pnfs_dserver_get: offset=8192, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.593234] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=8192, count=8192 [69615.593242] filelayout_write_pagelist ino 3898308 8192@8192 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.593247] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.593252] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 8192) [69615.593258] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69615.593263] --> nfs41_setup_sequence [69615.593266] --> nfs4_find_slot used_slots=0001 highest_used=0 max_slots=16 [69615.593271] <-- nfs4_find_slot used_slots=0003 highest_used=1 slotid=1 [69615.593275] <-- nfs41_setup_sequence slotid=1 seqid=8 [69615.593278] <-- nfs4_setup_sequence status=0 [69615.593283] encode_compound: tag= [69615.593287] encode_sequence: sessionid=1276181646:3:3:0 seqid=8 slotid=1 max_slotid=1 cache_this=1 [69615.593294] pnfs_writepages End (trypnfs:0) [69615.593301] --> _pnfs_try_to_write_data [69615.593305] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.593309] pnfs_writepages: Writing ino:3898308 8192@16384 [69615.593313] get_lock_alloc_layout Begin [69615.593317] get_lock_alloc_layout Return ffff88003b058338 [69615.593320] pnfs_has_layout:Begin [69615.593323] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 4 valid 1 [69615.593328] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@16384 iomode 2) [69615.593339] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.593343] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.593350] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@16384 sync 0 [69615.593356] nfs4_pnfs_dserver_get: offset=16384, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.593363] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=16384, count=8192 [69615.593370] filelayout_write_pagelist ino 3898308 8192@16384 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.593375] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.596004] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 16384) [69615.596004] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69615.596004] --> nfs41_setup_sequence [69615.596004] --> nfs4_find_slot used_slots=0003 highest_used=1 max_slots=16 [69615.596004] <-- nfs4_find_slot used_slots=0007 highest_used=2 slotid=2 [69615.596004] <-- nfs41_setup_sequence slotid=2 seqid=8 [69615.596004] <-- nfs4_setup_sequence status=0 [69615.596004] encode_compound: tag= [69615.596004] encode_sequence: sessionid=1276181646:3:3:0 seqid=8 slotid=2 max_slotid=2 cache_this=1 [69615.596004] pnfs_writepages End (trypnfs:0) [69615.596004] --> _pnfs_try_to_write_data [69615.596004] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.596004] pnfs_writepages: Writing ino:3898308 8192@24576 [69615.596004] get_lock_alloc_layout Begin [69615.596004] get_lock_alloc_layout Return ffff88003b058338 [69615.596004] pnfs_has_layout:Begin [69615.596004] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 5 valid 1 [69615.596004] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@24576 iomode 2) [69615.596004] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.596004] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.596004] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@24576 sync 0 [69615.596004] nfs4_pnfs_dserver_get: offset=24576, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.596004] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=24576, count=8192 [69615.596004] filelayout_write_pagelist ino 3898308 8192@24576 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.596004] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.596004] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 24576) [69615.596004] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69615.596004] --> nfs41_setup_sequence [69615.596004] --> nfs4_find_slot used_slots=0007 highest_used=2 max_slots=16 [69615.596004] <-- nfs4_find_slot used_slots=000f highest_used=3 slotid=3 [69615.596004] <-- nfs41_setup_sequence slotid=3 seqid=5 [69615.596004] <-- nfs4_setup_sequence status=0 [69615.596004] encode_compound: tag= [69615.596004] encode_sequence: sessionid=1276181646:3:3:0 seqid=5 slotid=3 max_slotid=3 cache_this=1 [69615.596004] pnfs_writepages End (trypnfs:0) [69615.596004] --> _pnfs_try_to_write_data [69615.596004] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.596004] pnfs_writepages: Writing ino:3898308 8192@32768 [69615.596004] get_lock_alloc_layout Begin [69615.596004] get_lock_alloc_layout Return ffff88003b058338 [69615.596004] pnfs_has_layout:Begin [69615.596004] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 6 valid 1 [69615.596004] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@32768 iomode 2) [69615.596004] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.596004] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.596004] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@32768 sync 0 [69615.596004] nfs4_pnfs_dserver_get: offset=32768, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.596004] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=32768, count=8192 [69615.596004] filelayout_write_pagelist ino 3898308 8192@32768 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.596004] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.596004] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 32768) [69615.596004] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69615.596004] --> nfs41_setup_sequence [69615.596004] --> nfs4_find_slot used_slots=000f highest_used=3 max_slots=16 [69615.596004] <-- nfs4_find_slot used_slots=001f highest_used=4 slotid=4 [69615.596004] <-- nfs41_setup_sequence slotid=4 seqid=5 [69615.596004] <-- nfs4_setup_sequence status=0 [69615.596004] encode_compound: tag= [69615.596004] encode_sequence: sessionid=1276181646:3:3:0 seqid=5 slotid=4 max_slotid=4 cache_this=1 [69615.596004] pnfs_writepages End (trypnfs:0) [69615.596004] --> _pnfs_try_to_write_data [69615.596004] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.596004] pnfs_writepages: Writing ino:3898308 8192@40960 [69615.596004] get_lock_alloc_layout Begin [69615.596004] get_lock_alloc_layout Return ffff88003b058338 [69615.596004] pnfs_has_layout:Begin [69615.596004] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 7 valid 1 [69615.596004] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@40960 iomode 2) [69615.596004] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.596004] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.596004] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@40960 sync 0 [69615.596004] nfs4_pnfs_dserver_get: offset=40960, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.596004] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=40960, count=8192 [69615.596004] filelayout_write_pagelist ino 3898308 8192@40960 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.596004] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.596004] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 40960) [69615.596004] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69615.596004] --> nfs41_setup_sequence [69615.596004] --> nfs4_find_slot used_slots=001f highest_used=4 max_slots=16 [69615.596004] <-- nfs4_find_slot used_slots=003f highest_used=5 slotid=5 [69615.596004] <-- nfs41_setup_sequence slotid=5 seqid=5 [69615.596004] <-- nfs4_setup_sequence status=0 [69615.596004] encode_compound: tag= [69615.596004] encode_sequence: sessionid=1276181646:3:3:0 seqid=5 slotid=5 max_slotid=5 cache_this=1 [69615.596004] pnfs_writepages End (trypnfs:0) [69615.791232] pnfs_writeback_done: Begin (status -10008) [69615.791238] put_lseg: lseg ffff88003b987840 ref 7 valid 1 [69615.794450] NFS: 6195 nfs_writeback_done (status -10008 count 8192) [69615.794450] pnfs4_write_done DS write [69615.794450] nfs41_sequence_done: Error 0 free the slot [69615.794450] nfs4_free_slot: free_slotid 0 highest_used_slotid 5 [69615.794450] <-- pnfs4_write_done status= -11 [69615.990137] filelayout_write_call_done new off 8192 orig offset 8192 [69615.990144] pnfs_writeback_done: Begin (status 8192) [69615.990148] put_lseg: lseg ffff88003b987840 ref 6 valid 1 [69615.990153] NFS: 6196 nfs_writeback_done (status 8192 count 8192) [69615.990157] pnfs4_write_done DS write [69615.990161] nfs41_sequence_done: Error 0 free the slot [69615.990165] nfs4_free_slot: free_slotid 1 highest_used_slotid 5 [69615.990170] pnfs_update_last_write: Wrote 8192@8192 bpos 0, epos: 16383 [69615.990174] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69615.990179] pnfs_need_layoutcommit: Set layoutcommit [69615.990182] nfs_writeback_done DS write [69615.990197] NFS: 6196 write (0:10/3898308 4096@8192) marked for commit [69615.990208] NFS: 6196 write (0:10/3898308 4096@12288) marked for commit [69615.997055] --> _pnfs_try_to_write_data [69615.997061] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.997065] pnfs_writepages: Writing ino:3898308 8192@49152 [69615.997069] get_lock_alloc_layout Begin [69615.997073] get_lock_alloc_layout Return ffff88003b058338 [69615.997076] pnfs_has_layout:Begin [69615.997080] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 6 valid 1 [69615.997086] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@49152 iomode 2) [69615.997092] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.997096] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.997102] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@49152 sync 0 [69615.997108] nfs4_pnfs_dserver_get: offset=49152, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.997116] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=49152, count=8192 [69615.997123] filelayout_write_pagelist ino 3898308 8192@49152 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.997130] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.997134] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 49152) [69615.997141] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69615.997146] --> nfs41_setup_sequence [69615.997155] --> nfs4_find_slot used_slots=003c highest_used=5 max_slots=16 [69615.997160] <-- nfs4_find_slot used_slots=003d highest_used=5 slotid=0 [69615.997164] <-- nfs41_setup_sequence slotid=0 seqid=20 [69615.997168] <-- nfs4_setup_sequence status=0 [69615.997173] encode_compound: tag= [69615.997177] encode_sequence: sessionid=1276181646:3:3:0 seqid=20 slotid=0 max_slotid=5 cache_this=1 [69615.997203] pnfs_writepages End (trypnfs:0) [69615.997210] --> _pnfs_try_to_write_data [69615.997213] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.997217] pnfs_writepages: Writing ino:3898308 8192@57344 [69615.997221] get_lock_alloc_layout Begin [69615.997225] get_lock_alloc_layout Return ffff88003b058338 [69615.997228] pnfs_has_layout:Begin [69615.997232] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 7 valid 1 [69615.997237] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@57344 iomode 2) [69615.997243] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.997248] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.997253] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@57344 sync 0 [69615.997260] nfs4_pnfs_dserver_get: offset=57344, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.997267] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=57344, count=8192 [69615.997275] filelayout_write_pagelist ino 3898308 8192@57344 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.997281] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.997286] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 57344) [69615.997291] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69615.997298] --> nfs41_setup_sequence [69615.997301] --> nfs4_find_slot used_slots=003d highest_used=5 max_slots=16 [69615.997306] <-- nfs4_find_slot used_slots=003f highest_used=5 slotid=1 [69615.997310] <-- nfs41_setup_sequence slotid=1 seqid=9 [69615.997314] <-- nfs4_setup_sequence status=0 [69615.997318] encode_compound: tag= [69615.997321] encode_sequence: sessionid=1276181646:3:3:0 seqid=9 slotid=1 max_slotid=5 cache_this=1 [69615.997339] pnfs_writepages End (trypnfs:0) [69615.997354] --> _pnfs_try_to_write_data [69615.997358] _pnfs_try_to_write_data: Utilizing pNFS I/O [69615.997367] pnfs_writepages: Writing ino:3898308 8192@65536 [69615.997370] get_lock_alloc_layout Begin [69615.997374] get_lock_alloc_layout Return ffff88003b058338 [69615.997382] pnfs_has_layout:Begin [69615.997386] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 8 valid 1 [69615.997392] pnfs_update_layout: Using cached lseg ffff88003b987840 for 8192@65536 iomode 2) [69615.997398] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69615.997402] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69615.997407] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 8192@65536 sync 0 [69615.997413] nfs4_pnfs_dserver_get: offset=65536, count=8192, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69615.997420] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=65536, count=8192 [69615.997428] filelayout_write_pagelist ino 3898308 8192@65536 DS:93fb0b2d:2049 147.251.11.45.8.1 [69615.997433] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69615.997438] NFS: 0 initiated write call (req 0:10/3898308, 8192 bytes @ offset 65536) [69616.000005] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69616.000005] --> nfs41_setup_sequence [69616.000005] --> nfs4_find_slot used_slots=003f highest_used=5 max_slots=16 [69616.000005] <-- nfs4_find_slot used_slots=007f highest_used=6 slotid=6 [69616.000005] <-- nfs41_setup_sequence slotid=6 seqid=2 [69616.000005] <-- nfs4_setup_sequence status=0 [69616.000005] encode_compound: tag= [69616.000005] encode_sequence: sessionid=1276181646:3:3:0 seqid=2 slotid=6 max_slotid=6 cache_this=1 [69616.196799] filelayout_write_call_done new off 16384 orig offset 16384 [69616.196806] pnfs_writeback_done: Begin (status 8192) [69616.196811] put_lseg: lseg ffff88003b987840 ref 8 valid 1 [69616.196815] NFS: 6197 nfs_writeback_done (status 8192 count 8192) [69616.196820] pnfs4_write_done DS write [69616.196824] nfs41_sequence_done: Error 0 free the slot [69616.196828] nfs4_free_slot: free_slotid 2 highest_used_slotid 6 [69616.196832] pnfs_update_last_write: Wrote 8192@16384 bpos 0, epos: 24575 [69616.196837] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69616.196841] nfs_writeback_done DS write [69616.196851] filelayout_write_call_done new off 24576 orig offset 24576 [69616.196856] pnfs_writeback_done: Begin (status 8192) [69616.196860] put_lseg: lseg ffff88003b987840 ref 7 valid 1 [69616.196865] NFS: 6198 nfs_writeback_done (status 8192 count 8192) [69616.196869] pnfs4_write_done DS write [69616.196872] nfs41_sequence_done: Error 0 free the slot [69616.196876] nfs4_free_slot: free_slotid 3 highest_used_slotid 6 [69616.196881] pnfs_update_last_write: Wrote 8192@24576 bpos 0, epos: 32767 [69616.196885] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69616.196889] nfs_writeback_done DS write [69616.196901] filelayout_write_call_done new off 32768 orig offset 32768 [69616.196905] pnfs_writeback_done: Begin (status 8192) [69616.196910] put_lseg: lseg ffff88003b987840 ref 6 valid 1 [69616.196914] NFS: 6199 nfs_writeback_done (status 8192 count 8192) [69616.196918] pnfs4_write_done DS write [69616.196921] nfs41_sequence_done: Error 0 free the slot [69616.196925] nfs4_free_slot: free_slotid 4 highest_used_slotid 6 [69616.196930] pnfs_update_last_write: Wrote 8192@32768 bpos 0, epos: 40959 [69616.196934] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69616.196939] nfs_writeback_done DS write [69616.196945] filelayout_write_call_done new off 40960 orig offset 40960 [69616.196950] pnfs_writeback_done: Begin (status 8192) [69616.196954] put_lseg: lseg ffff88003b987840 ref 5 valid 1 [69616.196959] NFS: 6200 nfs_writeback_done (status 8192 count 8192) [69616.196963] pnfs4_write_done DS write [69616.196966] nfs41_sequence_done: Error 0 free the slot [69616.196970] nfs4_free_slot: free_slotid 5 highest_used_slotid 6 [69616.196974] pnfs_update_last_write: Wrote 8192@40960 bpos 0, epos: 49151 [69616.196979] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69616.196983] nfs_writeback_done DS write [69616.196992] NFS: 6197 write (0:10/3898308 4096@16384) marked for commit [69616.197000] NFS: 6197 write (0:10/3898308 4096@20480) marked for commit [69616.197008] NFS: 6198 write (0:10/3898308 4096@24576) marked for commit [69616.197015] NFS: 6198 write (0:10/3898308 4096@28672) marked for commit [69616.197022] NFS: 6199 write (0:10/3898308 4096@32768) marked for commit [69616.197029] NFS: 6199 write (0:10/3898308 4096@36864) marked for commit [69616.197037] NFS: 6200 write (0:10/3898308 4096@40960) marked for commit [69616.197044] NFS: 6200 write (0:10/3898308 4096@45056) marked for commit [69616.197069] filelayout_write_call_done new off 49152 orig offset 49152 [69616.197078] pnfs_writeback_done: Begin (status 8192) [69616.197082] put_lseg: lseg ffff88003b987840 ref 4 valid 1 [69616.197087] NFS: 6201 nfs_writeback_done (status 8192 count 8192) [69616.197091] pnfs4_write_done DS write [69616.197094] nfs41_sequence_done: Error 0 free the slot [69616.197098] nfs4_free_slot: free_slotid 0 highest_used_slotid 6 [69616.197102] pnfs_update_last_write: Wrote 8192@49152 bpos 0, epos: 57343 [69616.197106] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69616.197110] nfs_writeback_done DS write [69616.197118] NFS: 6201 write (0:10/3898308 4096@49152) marked for commit [69616.197125] NFS: 6201 write (0:10/3898308 4096@53248) marked for commit [69616.197146] filelayout_write_call_done new off 57344 orig offset 57344 [69616.197151] pnfs_writeback_done: Begin (status 8192) [69616.197155] put_lseg: lseg ffff88003b987840 ref 3 valid 1 [69616.197159] NFS: 6202 nfs_writeback_done (status 8192 count 8192) [69616.197163] pnfs4_write_done DS write [69616.197166] nfs41_sequence_done: Error 0 free the slot [69616.197170] nfs4_free_slot: free_slotid 1 highest_used_slotid 6 [69616.197174] pnfs_update_last_write: Wrote 8192@57344 bpos 0, epos: 65535 [69616.197179] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69616.197183] nfs_writeback_done DS write [69616.197190] NFS: 6202 write (0:10/3898308 4096@57344) marked for commit [69616.197197] NFS: 6202 write (0:10/3898308 4096@61440) marked for commit [69616.197214] pnfs_writepages End (trypnfs:0) [69616.197221] --> _pnfs_try_to_write_data [69616.197224] _pnfs_try_to_write_data: Utilizing pNFS I/O [69616.197228] pnfs_writepages: Writing ino:3898308 4285@73728 [69616.197232] get_lock_alloc_layout Begin [69616.197236] get_lock_alloc_layout Return ffff88003b058338 [69616.197239] pnfs_has_layout:Begin [69616.197245] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 3 valid 1 [69616.197250] pnfs_update_layout: Using cached lseg ffff88003b987840 for 4285@73728 iomode 2) [69616.200004] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69616.200004] pnfs_writepages: Calling layout driver (how 0) write with 2 pages [69616.200004] --> filelayout_write_pagelist ino 3898308 nr_pages 2 pgbase 0 req 4285@73728 sync 0 [69616.200004] nfs4_pnfs_dserver_get: offset=73728, count=4285, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69616.200004] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=73728, count=4285 [69616.200004] filelayout_write_pagelist ino 3898308 4285@73728 DS:93fb0b2d:2049 147.251.11.45.8.1 [69616.200004] --> pnfs4_proc_write_setup ds_nfs_client ffff88003b98f800 [69616.200004] NFS: 0 initiated write call (req 0:10/3898308, 4285 bytes @ offset 73728) [69616.200004] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69616.200004] --> nfs41_setup_sequence [69616.200004] --> nfs4_find_slot used_slots=0040 highest_used=6 max_slots=16 [69616.200004] <-- nfs4_find_slot used_slots=0041 highest_used=6 slotid=0 [69616.200004] <-- nfs41_setup_sequence slotid=0 seqid=21 [69616.200004] <-- nfs4_setup_sequence status=0 [69616.200004] encode_compound: tag= [69616.200004] encode_sequence: sessionid=1276181646:3:3:0 seqid=21 slotid=0 max_slotid=6 cache_this=1 [69616.397679] filelayout_write_call_done new off 65536 orig offset 65536 [69616.397687] pnfs_writeback_done: Begin (status 8192) [69616.397691] put_lseg: lseg ffff88003b987840 ref 3 valid 1 [69616.397696] NFS: 6203 nfs_writeback_done (status 8192 count 8192) [69616.397700] pnfs4_write_done DS write [69616.397704] nfs41_sequence_done: Error 0 free the slot [69616.397708] nfs4_free_slot: free_slotid 6 highest_used_slotid 0 [69616.397712] pnfs_update_last_write: Wrote 8192@65536 bpos 0, epos: 73727 [69616.397717] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69616.397721] nfs_writeback_done DS write [69616.397734] NFS: 6203 write (0:10/3898308 4096@65536) marked for commit [69616.397741] NFS: 6203 write (0:10/3898308 4096@69632) marked for commit [69616.397763] pnfs_writepages End (trypnfs:0) [69616.398090] filelayout_write_call_done new off 73728 orig offset 73728 [69616.398099] pnfs_writeback_done: Begin (status 4285) [69616.398105] put_lseg: lseg ffff88003b987840 ref 2 valid 1 [69616.398111] NFS: 6204 nfs_writeback_done (status 4285 count 4285) [69616.398123] pnfs4_write_done DS write [69616.398126] nfs41_sequence_done: Error 0 free the slot [69616.398130] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69616.398134] pnfs_update_last_write: Wrote 4285@73728 bpos 0, epos: 78012 [69616.398139] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69616.398143] nfs_writeback_done DS write [69616.398153] NFS: 6204 write (0:10/3898308 4096@73728) marked for commit [69616.398161] NFS: 6204 write (0:10/3898308 189@77824) marked for commit [69620.452091] nfs4_renew_state: start [69620.452102] nfs4_renew_state: failed to call renewd. Reason: lease not expired [69620.452110] nfs4_schedule_state_renewal: requeueing work. Lease period = 55 [69620.452117] nfs4_renew_state: done [69630.788026] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69630.788045] --> nfs41_setup_sequence [69630.788052] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69630.788059] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69630.788065] <-- nfs41_setup_sequence slotid=0 seqid=22 [69630.788070] <-- nfs4_setup_sequence status=0 [69630.788090] encode_compound: tag= [69630.788107] encode_sequence: sessionid=1276181646:3:3:0 seqid=22 slotid=0 max_slotid=0 cache_this=1 [69630.789098] NFS: 6195 nfs_writeback_done (status 8192 count 8192) [69630.789107] pnfs4_write_done DS write [69630.789113] nfs41_sequence_done: Error 0 free the slot [69630.789119] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69630.789127] pnfs_update_last_write: Wrote 8192@0 bpos 0, epos: 78012 [69630.789133] pnfs_need_layoutcommit: has_layout=1 ctx=ffff88003b987640 [69630.789140] nfs_writeback_done DS write [69630.789159] NFS: 6195 write (0:10/3898308 4096@0) marked for commit [69630.789177] NFS: 6195 write (0:10/3898308 4096@4096) marked for commit [69630.789213] _pnfs_try_to_commit: Utilizing pNFS I/O [69630.789220] pnfs_commit: Begin [69630.789226] get_lock_alloc_layout Begin [69630.789241] get_lock_alloc_layout Return ffff88003b058338 [69630.789245] pnfs_has_layout:Begin [69630.789249] pnfs_has_layout:Return lseg ffff88003b987840 take_ref 1 ref 2 valid 1 [69630.789254] pnfs_update_layout: Using cached lseg ffff88003b987840 for 189@0 iomode 2) [69630.789260] pnfs_update_layout end (err:0) state 0x0 lseg ffff88003b987840 [69630.789264] pnfs_commit: Calling layout driver commit [69630.789270] filelayout_commit data ffff88003cfe7a80 pnfs_client (null) nfslay ffff88003b987880 sync 1 [69630.789276] filelayout_commit stripesize 8192 [69630.789281] nfs4_pnfs_dserver_get: offset=0, count=4096, si=0, dsi=0, stripe_count=1, stripe_unit=8192 first_stripe_index 0 [69630.789289] nfs4_pnfs_dserver_get: dev_id=00000351 00000001, ip:port=147.251.11.45.8.1, ds_idx=0 stripe_idx=0, offset=0, count=4096 [69630.789297] filelayout_commit: Initiating commit: 78013@0 USE DS: [69630.789301] ip_addr 93fb0b2d [69630.789305] port 2049 [69630.789308] client ffff88003b98f800 [69630.789311] ref count 1 [69630.789314] cl_exchange_flags 60001 [69630.789317] ip:port 147.251.11.45.8.1 [69630.789322] --> pnfs4_proc_commit_setup ds_nfs_client ffff88003b98f800 commit_through_mds 0 [69630.789327] NFS: 0 initiated commit call [69630.789341] --> nfs4_setup_sequence clp ffff88003b98f800 session ffff88003cd8bc00 sr_slotid 128 [69630.789347] --> nfs41_setup_sequence [69630.789355] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69630.789365] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69630.789370] <-- nfs41_setup_sequence slotid=0 seqid=23 [69630.789374] <-- nfs4_setup_sequence status=0 [69630.789378] encode_compound: tag= [69630.789382] encode_sequence: sessionid=1276181646:3:3:0 seqid=23 slotid=0 max_slotid=0 cache_this=1 [69630.789403] pnfs_commit End (trypnfs:0) [69630.790916] pnfs_commit_done: Begin (status 0) [69630.790924] put_lseg: lseg ffff88003b987840 ref 2 valid 1 [69630.790929] NFS: 6205 nfs_commit_done (status 0) [69630.790935] --> pnfs4_commit_done task->tk_status 0 [69630.790940] pnfs4_commit_done DS commit [69630.790944] nfs41_sequence_done: Error 0 free the slot [69630.790958] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69630.790966] <-- pnfs4_commit_done [69630.790975] NFS: commit (0:10/3898308 4096@0) OK [69630.790982] NFS: commit (0:10/3898308 4096@4096) OK [69630.790988] NFS: commit (0:10/3898308 4096@8192) OK [69630.790993] NFS: commit (0:10/3898308 4096@12288) OK [69630.790999] NFS: commit (0:10/3898308 4096@16384) OK [69630.791005] NFS: commit (0:10/3898308 4096@20480) OK [69630.791010] NFS: commit (0:10/3898308 4096@24576) OK [69630.791016] NFS: commit (0:10/3898308 4096@28672) OK [69630.791021] NFS: commit (0:10/3898308 4096@32768) OK [69630.791027] NFS: commit (0:10/3898308 4096@36864) OK [69630.791033] NFS: commit (0:10/3898308 4096@40960) OK [69630.791042] NFS: commit (0:10/3898308 4096@45056) OK [69630.791052] NFS: commit (0:10/3898308 4096@49152) OK [69630.791058] NFS: commit (0:10/3898308 4096@53248) OK [69630.791064] NFS: commit (0:10/3898308 4096@57344) OK [69630.791069] NFS: commit (0:10/3898308 4096@61440) OK [69630.791075] NFS: commit (0:10/3898308 4096@65536) OK [69630.791080] NFS: commit (0:10/3898308 4096@69632) OK [69630.791086] NFS: commit (0:10/3898308 4096@73728) OK [69630.791091] NFS: commit (0:10/3898308 189@77824) OK [69630.791102] pnfs_layoutcommit_inode Begin (sync:1) [69630.791108] --> pnfs_get_layout_stateid [69630.791111] <-- pnfs_get_layout_stateid [69630.791114] pnfs_layoutcommit_setup Begin (sync:1) [69630.791118] pnfs_layoutcommit_setup End Status 0 [69630.791122] NFS call layoutcommit 78013 @ 0 [69630.791128] --> nfs41_call_sync_prepare data->clp->cl_session ffff88003cfc2800 [69630.794897] --> nfs4_setup_sequence clp ffff88003735b000 session ffff88003cfc2800 sr_slotid 128 [69630.794897] --> nfs41_setup_sequence [69630.794897] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69630.794897] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69630.794897] <-- nfs41_setup_sequence slotid=0 seqid=432 [69630.794897] <-- nfs4_setup_sequence status=0 [69630.794897] encode_compound: tag= [69630.794897] encode_sequence: sessionid=1276120374:2:2:0 seqid=432 slotid=0 max_slotid=0 cache_this=0 [69630.794897] encode_layoutcommit: 78013@0 lbw: 78012 type: 1 [69630.989760] decode_attr_type: type=0100000 [69630.989771] decode_attr_change: change attribute=12474145562874604083 [69630.989776] decode_attr_size: file size=78013 [69630.989780] decode_attr_fsid: fsid=(0x0/0x0) [69630.989784] decode_attr_fileid: fileid=3898308 [69630.989788] decode_attr_fs_locations: fs_locations done, error = 0 [69630.989792] decode_attr_mode: file mode=0644 [69630.989796] decode_attr_nlink: nlink=1 [69630.989800] decode_attr_owner: uid=0 [69630.989804] decode_attr_group: gid=0 [69630.989807] decode_attr_rdev: rdev=(0x0:0x0) [69630.989811] decode_attr_space_used: space used=0 [69630.989815] decode_attr_time_access: atime=1276190109 [69630.989819] decode_attr_time_metadata: ctime=1276190125 [69630.989822] decode_attr_time_modify: mtime=1276190125 [69630.989826] decode_attr_mounted_on_fileid: fileid=0 [69630.989830] decode_getfattr: xdr returned 0 [69630.989834] nfs41_sequence_done: Error 0 free the slot [69630.989838] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69630.989844] NFS reply layoutcommit: 0 [69630.989848] pnfs_layoutcommit_done: (status 0) [69630.989852] pnfs_layoutcommit_inode end (err:0) [69630.989859] NFS: release(/.config) [69630.989868] --> nfs4_setup_sequence clp ffff88003735b000 session ffff88003cfc2800 sr_slotid 128 [69630.989874] --> nfs41_setup_sequence [69630.989877] --> nfs4_find_slot used_slots=0000 highest_used=-1 max_slots=16 [69630.989882] <-- nfs4_find_slot used_slots=0001 highest_used=0 slotid=0 [69630.989886] <-- nfs41_setup_sequence slotid=0 seqid=433 [69630.989890] <-- nfs4_setup_sequence status=0 [69630.989895] encode_compound: tag= [69630.989899] encode_sequence: sessionid=1276120374:2:2:0 seqid=433 slotid=0 max_slotid=0 cache_this=1 [69630.990225] decode_attr_type: type=00 [69630.990232] decode_attr_change: change attribute=12474145562874604083 [69630.990239] decode_attr_size: file size=78013 [69630.990244] decode_attr_fsid: fsid=(0x0/0x0) [69630.990249] decode_attr_fileid: fileid=0 [69630.990254] decode_attr_fs_locations: fs_locations done, error = 0 [69630.990260] decode_attr_mode: file mode=00 [69630.990265] decode_attr_nlink: nlink=1 [69630.990269] decode_attr_owner: uid=-2 [69630.990273] decode_attr_group: gid=-2 [69630.990278] decode_attr_rdev: rdev=(0x0:0x0) [69630.990283] decode_attr_space_used: space used=0 [69630.990288] decode_attr_time_access: atime=0 [69630.990293] decode_attr_time_metadata: ctime=1276190125 [69630.990298] decode_attr_time_modify: mtime=1276190125 [69630.990304] decode_attr_mounted_on_fileid: fileid=0 [69630.990309] decode_getfattr: xdr returned 0 [69630.990314] nfs41_sequence_done: Error 0 free the slot [69630.990328] nfs4_free_slot: free_slotid 0 highest_used_slotid -1 [69630.990338] NFS: nfs_update_inode(0:10/3898308 ct=2 info=0x26040) [69630.990343] NFS: change_attr change on server for file 0:10/3898308 [69630.990347] NFS: mtime change on server for file 0:10/3898308 [69630.990367] NFS: dentry_delete(/.config, 8)