A better log sequence
I've captured a better log sequence (hopefully). Here we are mid-transfer (filename being copied is London.mov - "Mac Movies" is the destination folder on the FreeNAS CIFS share)…
[2012/04/19 20:04:47.295163, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:04:50.284856, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:04:50.305584, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:05:12.836494, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:05:12.856395, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:05:21.962563, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:05:21.973105, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:05:42.884443, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:05:42.905553, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:05:49.047085, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:05:49.058624, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2)
Then a bit later, just as 4.29Gb is approaching:
[root@proliant] ~# tail -f /var/log/samba/log.smbd
[2012/04/19 20:06:35.269168, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._.DS_Store (numopen=2) NT_STATUS_OK
[2012/04/19 20:06:35.273861, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/.DS_Store read=Yes write=No (numopen=3)
[2012/04/19 20:06:35.284997, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/.DS_Store (numopen=2) NT_STATUS_OK
[2012/04/19 20:06:35.290480, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._.DS_Store read=Yes write=No (numopen=3)
[2012/04/19 20:06:35.309396, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._.DS_Store (numopen=2) NT_STATUS_OK
Then at 4.29Gb on the dot, I get the Mac Finder error (-36) and these logs:
[2012/04/19 20:12:02.472864, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=Yes (numopen=3)
[2012/04/19 20:12:02.477858, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:02.478206, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._.DS_Store read=Yes write=No (numopen=3)
[2012/04/19 20:12:02.480091, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=No write=No (numopen=4)
[2012/04/19 20:12:02.482352, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=3) NT_STATUS_OK
[2012/04/19 20:12:02.484703, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._.DS_Store (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:02.486458, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=No write=Yes (numopen=3)
[2012/04/19 20:12:02.775002, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._.DS_Store read=Yes write=No (numopen=4)
[2012/04/19 20:12:02.799665, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=3) NT_STATUS_OK
[2012/04/19 20:12:02.805522, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=Yes (numopen=4)
[2012/04/19 20:12:02.808624, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._.DS_Store (numopen=3) NT_STATUS_OK
[2012/04/19 20:12:02.816664, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:02.819564, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:02.822197, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:02.827885, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:02.831669, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:02.839361, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:03.952168, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:03.957092, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:03.961499, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:03.963209, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.123763, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.130467, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.136746, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.143888, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.148198, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.152030, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.153958, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.155921, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.161700, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.163480, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.167785, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.169571, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.173291, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.175696, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.179542, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.181912, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.185767, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.187547, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.191262, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.214914, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.219096, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.221173, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.225616, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.230480, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.234340, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.239090, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.241467, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.249252, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.251189, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.255030, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.256956, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.258905, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.263791, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.265863, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.270157, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.272091, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.275496, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.277425, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.281150, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.283218, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.287212, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.289140, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=3)
[2012/04/19 20:12:04.293019, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=2) NT_STATUS_OK
[2012/04/19 20:12:04.310932, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.319155, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.323299, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.325227, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.329239, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:04.332971, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._London.mov read=Yes write=No (numopen=2)
[2012/04/19 20:12:04.339638, 2] smbd/close.c:691(close_normal_file)
nharvey closed file Mac Movies/._London.mov (numopen=1) NT_STATUS_OK
[2012/04/19 20:12:06.656497, 2] smbd/open.c:704(open_file)
nharvey opened file Mac Movies/._.DS_Store read=Yes write=No (numopen=2)
Any thoughts on what might be happening here?
Thanks
Nick