search

hanwen / go-fuse

FUSE bindings for Go
Other
2.04k stars 328 forks source link

"Argument list too long" when copy a file with large com.apple.ResourceFork into the fs #362

Open atYuguo opened 4 years ago

atYuguo commented 4 years ago

Greetings, this problem can be reproduced by running the example go-fuse/example/loopback on macos with osxfuse. The testing file is:

ls -l@ ~/codeTest/testF
-rw-r--r--@ 1 XXX  XXX  0 May 26 21:29 /Users/XXX/codeTest/testF
    com.apple.ResourceFork  1400487

And run

go run main.go pt ot
Mounted!

then

cp ~/codeTest/testF ./pt
cp: /Users/XXX/codeTest/testF: could not copy extended attributes to ./pt/testF: Argument list too long

At the same time, go crashes and report:

14:15:16.360869 Failed to read from fuse conn: 5=input/output error

I encountered this when I use gocryptfs built above go-fuse, you can see a related issue here: https://github.com/rfjakob/gocryptfs/issues/373 .

hanwen commented 4 years ago

Could you provide debug logs of what is happening? It's hard to tell from the bugreport.

hanwen commented 4 years ago

(not that I don't have a mac, so just a repro scenario won't do).

atYuguo commented 4 years ago

Yes of course

13:10:11.316948 rx 2: INIT i0 {7.19 Ra 0x100000 VOL_RENAME,CASE_INSENSITIVE,ATOMIC_O_TRUNC,XTIMES,0x18000000} 
13:10:11.317197 tx 2:     OK, {7.8 Ra 0x100000  0/0 Wr 0x10000 Tg 0x0}
13:10:11.317338 rx 2: STATFS i1 
13:10:11.317397 tx 2:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.317452 rx 3: STATFS i1 
13:10:11.317482 rx 4: STATFS i1 
13:10:11.317494 tx 3:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.317504 tx 4:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.317598 rx 2: STATFS i1 
13:10:11.317615 tx 2:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.317672 rx 3: STATFS i1 
13:10:11.317689 tx 3:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.321013 rx 4: ACCESS i1 {u=501 g=20 x} 
13:10:11.321069 tx 4:     OK
13:10:11.321374 rx 2: LOOKUP i1 [".go-fuse-epoll-hack"] 20b
13:10:11.321449 tx 2:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.321598 rx 3: ACCESS i1 {u=0 g=0 } 
13:10:11.321619 tx 3:     OK
13:10:11.321746 rx 4: GETATTR i1  
13:10:11.322071 tx 4:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:1 A 1591441692.578274 M 1591441692.578274 C 1591441692.578274}}
13:10:11.322209 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.322238 tx 2:     OK
13:10:11.322216 rx 3: STATFS i1 
13:10:11.322295 tx 3:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.322596 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.322614 tx 4:     OK
13:10:11.322924 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.323044 tx 2:     OK
13:10:11.323292 rx 4: STATFS i1 
13:10:11.323299 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.323319 tx 4:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.323322 tx 3:     OK
13:10:11.323332 rx 2: STATFS i1 
13:10:11.323385 tx 2:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.323745 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.323763 tx 4:     OK
13:10:11.324085 rx 3: ACCESS i1 {u=501 g=20 w} 
13:10:11.324104 tx 3:     OK
13:10:11.324203 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.324229 tx 2:     OK
13:10:11.324529 rx 3: STATFS i1 
13:10:11.324559 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.324573 tx 4:     OK
13:10:11.324576 tx 3:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.324782 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.324798 tx 2:     OK
13:10:11.324902 rx 4: STATFS i1 
13:10:11.324917 tx 4:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.325078 rx 2: STATFS i1 
13:10:11.325094 tx 2:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.325126 rx 3: CREATE i1 {0100644 [RDWR,EXCL,CREAT]} [".go-fuse-epoll-hack"] 20b
13:10:11.325201 tx 3:     OK, {i18446744073709551615 g0 {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000} &{18446744073709551615 0 0}}
13:10:11.325232 rx 5: STATFS i1 
13:10:11.325280 tx 5:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.325280 rx 6: STATFS i1 
13:10:11.325296 tx 6:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.325310 rx 7: STATFS i1 
13:10:11.325321 tx 7:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.325360 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.325374 tx 4:     OK
13:10:11.325440 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.325452 tx 2:     OK
13:10:11.325515 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.325532 tx 3:     OK
13:10:11.325594 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.325608 tx 5:     OK
13:10:11.325666 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.325678 tx 6:     OK
13:10:11.325732 rx 7: GETATTR i1  
13:10:11.325774 tx 7:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:1 A 1591441692.578274 M 1591441692.578274 C 1591441692.578274}}
13:10:11.325876 rx 2: STATFS i1 
13:10:11.325889 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.325890 tx 2:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.325900 rx 3: STATFS i1 
13:10:11.325903 tx 4:     OK
13:10:11.325942 tx 3:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.325982 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.325995 tx 5:     OK
13:10:11.326056 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.326071 tx 6:     OK
13:10:11.326130 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.326145 tx 7:     OK
13:10:11.326244 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.326263 tx 2:     OK
13:10:11.326349 rx 4: STATFS i1 
13:10:11.326363 tx 4:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.326464 rx 3: LOOKUP i1 ["._.go-fuse-epoll-hack"] 22b
13:10:11.326538 tx 3:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.326546 rx 5: STATFS i1 
13:10:11.326558 tx 5:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.326852 rx 6: STATFS i1 
13:10:11.326871 tx 6:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.327011 rx 7: ACCESS i1 {u=0 g=0 } 
13:10:11.327026 tx 7:     OK
13:10:11.327035 rx 2: GETATTR i18446744073709551615  
13:10:11.327060 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.327567 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.327583 tx 4:     OK
13:10:11.327593 rx 3: GETATTR i18446744073709551615  
13:10:11.327651 tx 3:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.327751 rx 6: GETATTR i18446744073709551615  
13:10:11.327777 tx 6:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.327844 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.327859 tx 5:     OK
13:10:11.328092 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.328105 tx 2:     OK
13:10:11.328155 rx 7: FLUSH i18446744073709551615 {Fh 18446744073709551615} 
13:10:11.328162 tx 7:     34=result too large
13:10:11.328985 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.329010 tx 4:     OK
13:10:11.329099 rx 3: RELEASE i18446744073709551615 {Fh 18446744073709551615   L0} 
13:10:11.329105 tx 3:     34=result too large
Mounted!
13:10:11.329246 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.329594 tx 6:     OK
13:10:11.332933 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.332957 tx 5:     OK
13:10:11.337659 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.337682 tx 2:     OK
13:10:11.342828 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.346662 tx 7:     OK
13:10:11.349530 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.349559 tx 4:     OK
13:10:11.351052 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.351104 tx 3:     OK
13:10:11.351436 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.351461 tx 6:     OK
13:10:11.351735 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.351906 tx 5:     OK
13:10:11.352213 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.352239 tx 2:     OK
13:10:11.352345 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.352365 tx 7:     OK
13:10:11.352977 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.352998 tx 4:     OK
13:10:11.353323 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.353339 tx 3:     OK
13:10:11.353597 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.353630 tx 6:     OK
13:10:11.354054 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.354083 tx 5:     OK
13:10:11.354327 rx 2: ACCESS i1 {u=0 g=0 r} 
13:10:11.354341 tx 2:     OK
13:10:11.368747 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.368781 tx 7:     OK
13:10:11.368838 rx 4: ACCESS i1 {u=0 g=0 } 
13:10:11.368857 tx 4:     OK
13:10:11.369005 rx 3: GETXATTR i1 {sz 32} ["com.apple.FinderInfo"] 21b
13:10:11.369036 tx 3:     78=function not implemented
13:10:11.369095 rx 6: LOOKUP i1 ["._."] 4b
13:10:11.369152 tx 6:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.369246 rx 5: STATFS i1 
13:10:11.369268 tx 5:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.430334 rx 2: ACCESS i1 {u=0 g=0 } 
13:10:11.430362 tx 2:     OK
13:10:11.435052 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.435084 tx 7:     OK
13:10:11.435203 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.435239 tx 4:     OK
13:10:11.435580 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.435597 tx 3:     OK
13:10:11.435947 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.435964 tx 6:     OK
13:10:11.536538 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.536566 tx 5:     OK
13:10:11.536794 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.536813 tx 2:     OK
13:10:11.536921 rx 7: ACCESS i1 {u=501 g=20 r} 
13:10:11.536946 tx 7:     OK
13:10:11.536994 rx 4: LOOKUP i1 ["._."] 4b
13:10:11.537057 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.537141 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.537161 tx 3:     OK
13:10:11.537261 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.537285 tx 6:     OK
13:10:11.537399 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.537417 tx 5:     OK
13:10:11.537926 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.537961 tx 2:     OK
13:10:11.538332 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.538350 tx 7:     OK
13:10:11.538454 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.538472 tx 4:     OK
13:10:11.538670 rx 3: STATFS i1 
13:10:11.538693 tx 3:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.538833 rx 6: STATFS i1 
13:10:11.538851 tx 6:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.547471 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.547501 tx 5:     OK
13:10:11.657242 rx 2: STATFS i1 
13:10:11.657286 tx 2:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.688786 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.688818 tx 7:     OK
13:10:11.689232 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.689254 tx 4:     OK
13:10:11.689390 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.689408 tx 3:     OK
13:10:11.689645 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.689664 tx 6:     OK
13:10:11.689809 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.689825 tx 5:     OK
13:10:11.694428 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.694474 tx 2:     OK
13:10:11.695442 rx 7: STATFS i1 
13:10:11.695475 tx 7:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.695680 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.695708 tx 4:     OK
13:10:11.696249 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.696279 tx 3:     OK
13:10:11.696424 rx 6: ACCESS i1 {u=501 g=20 w} 
13:10:11.696440 tx 6:     OK
13:10:11.696519 rx 5: ACCESS i1 {u=501 g=20 r} 
13:10:11.696544 tx 5:     OK
13:10:11.696614 rx 2: ACCESS i1 {u=501 g=20 x} 
13:10:11.696647 tx 2:     OK
13:10:11.696734 rx 4: LOOKUP i1 ["._."] 4b
13:10:11.696770 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.697548 rx 7: STATFS i1 
13:10:11.697574 tx 7:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.698072 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.698089 tx 3:     OK
13:10:11.698295 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.698313 tx 6:     OK
13:10:11.698545 rx 5: STATFS i1 
13:10:11.698585 tx 5:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.732611 rx 2: STATFS i1 
13:10:11.732683 tx 2:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.733595 rx 4: STATFS i1 
13:10:11.733656 tx 4:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.733916 rx 7: STATFS i1 
13:10:11.733940 tx 7:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.734127 rx 3: STATFS i1 
13:10:11.734157 tx 3:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.734460 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.734481 tx 6:     OK
13:10:11.734672 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.734693 tx 5:     OK
13:10:11.734860 rx 2: STATFS i1 
13:10:11.734884 tx 2:     OK, {blocks (326670,313208)/476802 files 4880790775/4882452880 bs1048576 nl0 frs1048576}
13:10:11.740097 rx 4: STATFS i1 
13:10:11.740129 tx 4:     OK, {blocks (326670,313208)/476802 files 4880790774/4882452880 bs1048576 nl0 frs1048576}
13:10:11.740375 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.740558 tx 7:     OK
13:10:11.783877 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.783906 tx 3:     OK
13:10:11.784025 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.784044 tx 6:     OK
13:10:11.784147 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.784164 tx 5:     OK
13:10:11.784213 rx 2: ACCESS i1 {u=501 g=20 w} 
13:10:11.784230 tx 2:     OK
13:10:11.784272 rx 4: ACCESS i1 {u=501 g=20 r} 
13:10:11.784292 tx 4:     OK
13:10:11.784337 rx 7: ACCESS i1 {u=501 g=20 x} 
13:10:11.784351 tx 7:     OK
13:10:11.784395 rx 3: LOOKUP i1 ["._."] 4b
13:10:11.784430 tx 3:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.784596 rx 6: ACCESS i1 {u=501 g=20 } 
13:10:11.784612 tx 6:     OK
13:10:11.784671 rx 5: ACCESS i1 {u=501 g=20 } 
13:10:11.784687 tx 5:     OK
13:10:11.784952 rx 2: ACCESS i1 {u=501 g=20 x} 
13:10:11.784968 tx 2:     OK
13:10:11.785021 rx 4: LOOKUP i1 [".hidden"] 8b
13:10:11.785062 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.785303 rx 7: LOOKUP i1 [".localized"] 11b
13:10:11.785331 tx 7:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.785462 rx 3: LOOKUP i1 [".DS_Store"] 10b
13:10:11.785497 tx 3:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.785608 rx 6: LOOKUP i1 [".DS_Store"] 10b
13:10:11.785634 tx 6:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.785850 rx 5: LOOKUP i1 [".localized"] 11b
13:10:11.785877 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.830824 rx 2: ACCESS i1 {u=501 g=20 } 
13:10:11.830872 tx 2:     OK
13:10:11.833698 rx 4: ACCESS i1 {u=501 g=20 } 
13:10:11.833805 tx 4:     OK
13:10:11.833989 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.834017 tx 7:     OK
13:10:11.834283 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.834311 tx 3:     OK
13:10:11.834450 rx 6: ACCESS i1 {u=501 g=20 w} 
13:10:11.834516 tx 6:     OK
13:10:11.834629 rx 5: ACCESS i1 {u=501 g=20 r} 
13:10:11.834651 tx 5:     OK
13:10:11.834755 rx 2: ACCESS i1 {u=501 g=20 x} 
13:10:11.834776 tx 2:     OK
13:10:11.834841 rx 4: LOOKUP i1 ["._."] 4b
13:10:11.835051 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:10:11.835974 rx 7: ACCESS i1 {u=501 g=20 } 
13:10:11.835993 tx 7:     OK
13:10:11.836239 rx 3: ACCESS i1 {u=501 g=20 } 
13:10:11.836256 tx 3:     OK
13:10:12.267223 rx 6: ACCESS i1 {u=501 g=20 x} 
13:10:12.267270 tx 6:     OK
13:10:12.267363 rx 5: ACCESS i18446744073709551615 {u=501 g=20 } 
13:10:12.267434 tx 5:     34=result too large
13:10:29.115927 rx 2: STATFS i1 
13:10:29.115968 tx 2:     OK, {blocks (326670,313207)/476802 files 4880790773/4882452880 bs1048576 nl0 frs1048576}
13:10:47.927082 rx 4: GETATTR i1  
13:10:47.927154 tx 4:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:1 A 1591441692.578274 M 1591441692.578274 C 1591441692.578274}}
13:10:47.927234 rx 7: ACCESS i1 {u=501 g=20 r} 
13:10:47.927253 tx 7:     OK
13:10:47.927314 rx 3: OPENDIR i1 
13:10:47.927435 tx 3:     OK, {Fh 1 }
13:10:47.927523 rx 6: STATFS i1 
13:10:47.927555 tx 6:     OK, {blocks (326669,313207)/476802 files 4880790769/4882452880 bs1048576 nl0 frs1048576}
13:10:47.927618 rx 5: READDIR i1 {Fh 1 [0 +6550) } 
13:10:47.927762 tx 5:     OK
13:10:47.927845 rx 2: RELEASEDIR i1 {Fh 1   L0} 
13:10:47.927855 tx 2:     OK
13:10:56.025502 rx 4: GETATTR i1  
13:10:56.025568 tx 4:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:1 A 1591441692.578274 M 1591441692.578274 C 1591441692.578274}}
13:10:56.025652 rx 7: ACCESS i1 {u=501 g=20 r} 
13:10:56.025677 tx 7:     OK
13:10:56.025802 rx 3: OPENDIR i1 
13:10:56.025909 tx 3:     OK, {Fh 1 }
13:10:56.026057 rx 6: STATFS i1 
13:10:56.026131 tx 6:     OK, {blocks (326669,313207)/476802 files 4880790769/4882452880 bs1048576 nl0 frs1048576}
13:10:56.026257 rx 5: READDIR i1 {Fh 1 [0 +6550) } 
13:10:56.026354 tx 5:     OK
13:10:56.026491 rx 2: RELEASEDIR i1 {Fh 1   L0} 
13:10:56.026499 tx 2:     OK
13:11:05.676951 rx 4: STATFS i1 
13:11:05.676989 tx 4:     OK, {blocks (326669,313207)/476802 files 4880790770/4882452880 bs1048576 nl0 frs1048576}
13:11:14.773223 rx 7: ACCESS i1 {u=501 g=20 } 
13:11:14.773250 tx 7:     OK
13:11:14.773294 rx 3: GETATTR i1  
13:11:14.773328 tx 3:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:1 A 1591441692.578274 M 1591441692.578274 C 1591441692.578274}}
13:11:14.773409 rx 6: ACCESS i1 {u=501 g=20 x} 
13:11:14.773425 tx 6:     OK
13:11:14.773470 rx 5: LOOKUP i1 ["testF"] 6b
13:11:14.773520 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:11:14.773679 rx 2: LOOKUP i1 ["testF"] 6b
13:11:14.773725 tx 2:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:11:14.773858 rx 4: ACCESS i1 {u=501 g=20 w} 
13:11:14.773897 tx 4:     OK
13:11:14.774002 rx 7: CREATE i1 {0100644 [RDWR,EXCL,CREAT]} ["testF"] 6b
13:11:14.774240 tx 7:     OK, {i13850058 g1 {M0100644 SZ=0 L=1 501:20 0 0:13850058 A 1591441874.774087 M 1591441874.774087 C 1591441874.774087} &{1 0 0}}
13:11:14.774348 rx 3: LOOKUP i1 ["._testF"] 8b
13:11:14.774447 tx 3:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:11:14.774509 rx 6: STATFS i1 
13:11:14.774547 tx 6:     OK, {blocks (326669,313207)/476802 files 4880790769/4882452880 bs1048576 nl0 frs1048576}
13:11:14.774639 rx 5: ACCESS i13850058 {u=501 g=20 } 
13:11:14.774665 tx 5:     OK
13:11:14.774726 rx 2: SETATTR i13850058 {mode 0100600, fh 1} 
13:11:14.774833 tx 2:     OK, {tA=0s {M0100600 SZ=0 L=1 501:20 0 0:13850058 A 1591441874.774087 M 1591441874.774087 C 1591441874.774762}}
13:11:14.774895 rx 4: LOOKUP i1 ["._testF"] 8b
13:11:14.774928 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:11:14.774970 rx 7: GETATTR i13850058  
13:11:14.775014 tx 7:     OK, {tA=1s {M0100600 SZ=0 L=1 501:20 0 0:13850058 A 1591441874.774087 M 1591441874.774087 C 1591441874.774762}}
13:11:14.775143 rx 3: ACCESS i13850058 {u=501 g=20 } 
13:11:14.775162 tx 3:     OK
13:11:14.775248 rx 6: SETATTR i13850058 {mode 0100644, fh 1} 
13:11:14.775349 tx 6:     OK, {tA=0s {M0100644 SZ=0 L=1 501:20 0 0:13850058 A 1591441874.774087 M 1591441874.774087 C 1591441874.775273}}
13:11:14.775406 rx 5: LOOKUP i1 ["._testF"] 8b
13:11:14.775449 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:11:14.775511 rx 2: GETATTR i13850058  
13:11:14.775561 tx 2:     OK, {tA=1s {M0100644 SZ=0 L=1 501:20 0 0:13850058 A 1591441874.774087 M 1591441874.774087 C 1591441874.775273}}
13:11:14.775706 rx 4: ACCESS i13850058 {u=501 g=20 } 
13:11:14.775724 tx 4:     OK
13:11:14.775844 rx 7: SETATTR i13850058 {mode 0100644, fh 1} 
13:11:14.775948 tx 7:     OK, {tA=0s {M0100644 SZ=0 L=1 501:20 0 0:13850058 A 1591441874.774087 M 1591441874.774087 C 1591441874.775890}}
13:11:14.776035 rx 3: LOOKUP i1 ["._testF"] 8b
13:11:14.776103 tx 3:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:11:14.776159 rx 6: GETATTR i13850058  
13:11:14.776199 tx 6:     OK, {tA=1s {M0100644 SZ=0 L=1 501:20 0 0:13850058 A 1591441874.774087 M 1591441874.774087 C 1591441874.775890}}
13:11:14.776283 rx 5: ACCESS i13850058 {u=501 g=20 r} 
13:11:14.776314 tx 5:     OK
13:11:14.776379 rx 2: LISTXATTR i13850058 {sz 0} 
13:11:14.776388 tx 2:     78=function not implemented
13:11:14.776456 rx 4: LOOKUP i1 ["._testF"] 8b
13:11:14.776516 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:11:14.784691 rx 7: ACCESS i13850058 {u=501 g=20 w} 
13:11:14.784737 tx 7:     OK
13:11:14.785307 Failed to read from fuse conn: 5=input/output error
hanwen commented 4 years ago

the only suspect bit is this:

13:11:14.776379 rx 2: LISTXATTR i13850058 {sz 0} 13:11:14.776388 tx 2: 78=function not implemented

These are currently not implemented,

https://github.com/hanwen/go-fuse/blob/730713460d4fc41afdc2533bd37ff60c94c0c586/fs/loopback_darwin.go#L31

this should use functions from x/sys instead: https://go.googlesource.com/sys/+/6fdc65e7d9800cc59998e8ac0d9406a20ff5f399/unix/syscall_darwin.go#270

atYuguo commented 4 years ago

However, it won't crash for a smaller extended attribute:

ls -l@ testF
-rw-r--r--@ 1 XXX  XXX  0 Jun  6 13:40 testF
    testattr    128

and the debug output is

13:41:29.670619 rx 2: INIT i0 {7.19 Ra 0x100000 ATOMIC_O_TRUNC,CASE_INSENSITIVE,VOL_RENAME,XTIMES,0x18000000} 
13:41:29.670854 tx 2:     OK, {7.8 Ra 0x100000  0/0 Wr 0x10000 Tg 0x0}
13:41:29.670986 rx 2: STATFS i1 
13:41:29.671034 tx 2:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.673963 rx 2: ACCESS i1 {u=501 g=20 x} 
13:41:29.674014 tx 2:     OK
13:41:29.674209 rx 2: LOOKUP i1 [".go-fuse-epoll-hack"] 20b
13:41:29.674318 tx 2:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.674410 rx 2: ACCESS i1 {u=501 g=20 w} 
13:41:29.674436 tx 2:     OK
13:41:29.674631 rx 2: GETATTR i1  
13:41:29.674801 tx 2:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:1 A 1591443641.504215 M 1591443641.504215 C 1591443641.504215}}
13:41:29.674890 rx 2: CREATE i1 {0100644 [RDWR,CREAT,EXCL]} [".go-fuse-epoll-hack"] 20b
13:41:29.674976 tx 2:     OK, {i18446744073709551615 g0 {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000} &{18446744073709551615 0 0}}
13:41:29.675766 rx 2: LOOKUP i1 ["._.go-fuse-epoll-hack"] 22b
13:41:29.675961 tx 2:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.676071 rx 2: GETATTR i18446744073709551615  
13:41:29.676109 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.676304 rx 2: GETATTR i18446744073709551615  
13:41:29.676340 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.676551 rx 3: ACCESS i1 {u=0 g=0 } 
13:41:29.676590 tx 3:     OK
13:41:29.676628 rx 2: GETATTR i18446744073709551615  
13:41:29.676696 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.676890 rx 3: GETATTR i1  
13:41:29.676958 tx 3:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:1 A 1591443641.504215 M 1591443641.504215 C 1591443641.504215}}
13:41:29.676976 rx 2: FLUSH i18446744073709551615 {Fh 18446744073709551615} 
13:41:29.677018 tx 2:     34=result too large
13:41:29.677230 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.677270 tx 3:     OK
13:41:29.677326 rx 2: RELEASE i18446744073709551615 {Fh 18446744073709551615   L0} 
13:41:29.677340 tx 2:     34=result too large
13:41:29.677372 rx 4: STATFS i1 
13:41:29.677422 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.677437 tx 3:     OK
13:41:29.677445 rx 5: STATFS i1 
13:41:29.677493 tx 5:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.677555 tx 4:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
Mounted!
13:41:29.678087 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.678128 tx 2:     OK
13:41:29.678139 rx 3: STATFS i1 
13:41:29.678187 tx 3:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.678425 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.678452 tx 5:     OK
13:41:29.678513 rx 4: STATFS i1 
13:41:29.678530 tx 4:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.678699 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.678723 tx 2:     OK
13:41:29.678868 rx 3: STATFS i1 
13:41:29.678885 tx 3:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.679042 rx 5: ACCESS i1 {u=0 g=0 } 
13:41:29.679061 tx 5:     OK
13:41:29.679516 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.679545 tx 4:     OK
13:41:29.679640 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.679696 tx 2:     OK
13:41:29.679794 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.679811 tx 3:     OK
13:41:29.679923 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.679954 tx 5:     OK
13:41:29.680129 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.680152 tx 4:     OK
13:41:29.680279 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.680295 tx 2:     OK
13:41:29.680384 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.680400 tx 3:     OK
13:41:29.680510 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.680535 tx 5:     OK
13:41:29.680680 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.680695 tx 4:     OK
13:41:29.680758 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.680797 tx 2:     OK
13:41:29.680915 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.680932 tx 3:     OK
13:41:29.680991 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.681020 tx 5:     OK
13:41:29.681185 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.681219 tx 4:     OK
13:41:29.681308 rx 2: ACCESS i1 {u=0 g=0 r} 
13:41:29.681343 tx 2:     OK
13:41:29.681434 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.681450 tx 3:     OK
13:41:29.681852 rx 5: ACCESS i1 {u=0 g=0 } 
13:41:29.681871 tx 5:     OK
13:41:29.682073 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.682091 tx 4:     OK
13:41:29.682245 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.682263 tx 2:     OK
13:41:29.682491 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.682508 tx 3:     OK
13:41:29.682690 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.682705 tx 5:     OK
13:41:29.691931 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.691991 tx 4:     OK
13:41:29.692149 rx 2: GETXATTR i1 {sz 32} ["com.apple.FinderInfo"] 21b
13:41:29.692231 tx 2:     78=function not implemented
13:41:29.692356 rx 3: LOOKUP i1 ["._."] 4b
13:41:29.692441 tx 3:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.692522 rx 5: STATFS i1 
13:41:29.692542 tx 5:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.703319 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.703347 tx 4:     OK
13:41:29.703594 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.703612 tx 2:     OK
13:41:29.703861 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.703878 tx 3:     OK
13:41:29.704393 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.704411 tx 5:     OK
13:41:29.704661 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.704679 tx 4:     OK
13:41:29.705018 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.705036 tx 2:     OK
13:41:29.705429 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.705456 tx 3:     OK
13:41:29.706094 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.706112 tx 5:     OK
13:41:29.706667 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.706685 tx 4:     OK
13:41:29.707057 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.707121 tx 2:     OK
13:41:29.707768 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.707787 tx 3:     OK
13:41:29.708003 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.708019 tx 5:     OK
13:41:29.708249 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.708266 tx 4:     OK
13:41:29.708918 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.708938 tx 2:     OK
13:41:29.709969 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.709990 tx 3:     OK
13:41:29.710565 rx 5: ACCESS i1 {u=501 g=20 r} 
13:41:29.710584 tx 5:     OK
13:41:29.710636 rx 4: LOOKUP i1 ["._."] 4b
13:41:29.710678 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.711121 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.711138 tx 2:     OK
13:41:29.711618 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.711635 tx 3:     OK
13:41:29.713966 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.713988 tx 5:     OK
13:41:29.714216 rx 4: STATFS i1 
13:41:29.714236 tx 4:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.714490 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.714507 tx 2:     OK
13:41:29.715956 rx 3: STATFS i1 
13:41:29.715984 tx 3:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.716199 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.716218 tx 5:     OK
13:41:29.716506 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.716525 tx 2:     OK
13:41:29.717148 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.717166 tx 5:     OK
13:41:29.717209 rx 4: ACCESS i1 {u=501 g=20 w} 
13:41:29.717224 tx 4:     OK
13:41:29.717315 rx 2: ACCESS i1 {u=501 g=20 r} 
13:41:29.717333 tx 2:     OK
13:41:29.717376 rx 3: ACCESS i1 {u=501 g=20 x} 
13:41:29.717390 tx 3:     OK
13:41:29.717438 rx 5: LOOKUP i1 ["._."] 4b
13:41:29.717470 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.718231 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.718251 tx 4:     OK
13:41:29.718541 rx 2: STATFS i1 
13:41:29.718565 tx 2:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.719091 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.719109 tx 3:     OK
13:41:29.725979 rx 5: ACCESS i1 {u=0 g=0 } 
13:41:29.726038 tx 5:     OK
13:41:29.733950 rx 4: STATFS i1 
13:41:29.733984 tx 4:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.751456 rx 3: STATFS i1 
13:41:29.751500 tx 3:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.751875 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.751896 tx 2:     OK
13:41:29.752379 rx 5: STATFS i1 
13:41:29.752410 tx 5:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.752723 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.752745 tx 4:     OK
13:41:29.752902 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.752920 tx 2:     OK
13:41:29.753073 rx 3: STATFS i1 
13:41:29.753095 tx 3:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.753353 rx 4: STATFS i1 
13:41:29.753371 tx 4:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.753389 rx 2: STATFS i1 
13:41:29.753412 tx 2:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.753587 rx 5: STATFS i1 
13:41:29.753605 tx 5:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.753704 rx 3: STATFS i1 
13:41:29.753746 tx 3:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.754041 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.754057 tx 4:     OK
13:41:29.754313 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.754331 tx 2:     OK
13:41:29.754720 rx 5: STATFS i1 
13:41:29.754748 tx 5:     OK, {blocks (326535,312049)/476802 files 4880790196/4882452880 bs1048576 nl0 frs1048576}
13:41:29.802452 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.802480 tx 3:     OK
13:41:29.870455 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.870483 tx 4:     OK
13:41:29.870713 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:29.870750 tx 2:     OK
13:41:29.871124 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:29.871143 tx 5:     OK
13:41:29.871200 rx 3: ACCESS i1 {u=501 g=20 w} 
13:41:29.871215 tx 3:     OK
13:41:29.871311 rx 4: ACCESS i1 {u=501 g=20 r} 
13:41:29.871328 tx 4:     OK
13:41:29.871383 rx 2: ACCESS i1 {u=501 g=20 x} 
13:41:29.871404 tx 2:     OK
13:41:29.871480 rx 5: LOOKUP i1 ["._."] 4b
13:41:29.871516 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.871858 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:29.871875 tx 3:     OK
13:41:29.871972 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:29.872003 tx 4:     OK
13:41:29.873324 rx 2: ACCESS i1 {u=501 g=20 x} 
13:41:29.873354 tx 2:     OK
13:41:29.873429 rx 5: LOOKUP i1 [".localized"] 11b
13:41:29.873468 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.901149 rx 3: LOOKUP i1 [".DS_Store"] 10b
13:41:29.901213 tx 3:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.901269 rx 4: LOOKUP i1 [".hidden"] 8b
13:41:29.901309 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.901460 rx 2: LOOKUP i1 [".DS_Store"] 10b
13:41:29.901487 tx 2:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:29.901755 rx 5: LOOKUP i1 [".localized"] 11b
13:41:29.901785 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:30.134335 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:30.134365 tx 3:     OK
13:41:30.151238 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:30.151272 tx 4:     OK
13:41:30.151375 rx 2: ACCESS i1 {u=501 g=20 } 
13:41:30.151393 tx 2:     OK
13:41:30.151516 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:30.151531 tx 5:     OK
13:41:30.151581 rx 3: ACCESS i1 {u=501 g=20 w} 
13:41:30.151599 tx 3:     OK
13:41:30.151642 rx 4: ACCESS i1 {u=501 g=20 r} 
13:41:30.151658 tx 4:     OK
13:41:30.151703 rx 2: ACCESS i1 {u=501 g=20 x} 
13:41:30.151715 tx 2:     OK
13:41:30.151763 rx 5: LOOKUP i1 ["._."] 4b
13:41:30.151799 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:30.151996 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:30.152018 tx 3:     OK
13:41:30.152086 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:30.152103 tx 4:     OK
13:41:30.634394 rx 2: ACCESS i1 {u=501 g=20 x} 
13:41:30.634419 tx 2:     OK
13:41:30.634503 rx 5: ACCESS i18446744073709551615 {u=501 g=20 } 
13:41:30.634535 tx 5:     34=result too large
13:41:35.014319 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:35.014346 tx 3:     OK
13:41:35.014448 rx 4: GETATTR i1  
13:41:35.014569 tx 4:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:1 A 1591443641.504215 M 1591443641.504215 C 1591443641.504215}}
13:41:35.014699 rx 2: ACCESS i1 {u=501 g=20 x} 
13:41:35.014730 tx 2:     OK
13:41:35.014873 rx 5: LOOKUP i1 ["testF"] 6b
13:41:35.014952 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.015067 rx 3: LOOKUP i1 ["testF"] 6b
13:41:35.015114 tx 3:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.015181 rx 4: ACCESS i1 {u=501 g=20 w} 
13:41:35.015209 tx 4:     OK
13:41:35.015299 rx 2: CREATE i1 {0100644 [RDWR,CREAT,EXCL]} ["testF"] 6b
13:41:35.015505 tx 2:     OK, {i13852786 g1 {M0100644 SZ=0 L=1 501:20 0 0:13852786 A 1591443695.015361 M 1591443695.015361 C 1591443695.015361} &{1 0 0}}
13:41:35.015579 rx 5: LOOKUP i1 ["._testF"] 8b
13:41:35.015623 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.015698 rx 3: STATFS i1 
13:41:35.015715 tx 3:     OK, {blocks (326535,312049)/476802 files 4880790193/4882452880 bs1048576 nl0 frs1048576}
13:41:35.015822 rx 4: ACCESS i13852786 {u=501 g=20 } 
13:41:35.015844 tx 4:     OK
13:41:35.015914 rx 2: SETATTR i13852786 {mode 0100600, fh 1} 
13:41:35.015982 tx 2:     OK, {tA=0s {M0100600 SZ=0 L=1 501:20 0 0:13852786 A 1591443695.015361 M 1591443695.015361 C 1591443695.015948}}
13:41:35.016065 rx 5: LOOKUP i1 ["._testF"] 8b
13:41:35.016104 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.016155 rx 3: GETATTR i13852786  
13:41:35.016258 tx 3:     OK, {tA=1s {M0100600 SZ=0 L=1 501:20 0 0:13852786 A 1591443695.015361 M 1591443695.015361 C 1591443695.015948}}
13:41:35.016359 rx 4: ACCESS i13852786 {u=501 g=20 } 
13:41:35.016394 tx 4:     OK
13:41:35.016467 rx 2: SETATTR i13852786 {mode 0100644, fh 1} 
13:41:35.016524 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 501:20 0 0:13852786 A 1591443695.015361 M 1591443695.015361 C 1591443695.016492}}
13:41:35.016569 rx 5: LOOKUP i1 ["._testF"] 8b
13:41:35.016635 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.016694 rx 3: GETATTR i13852786  
13:41:35.016768 tx 3:     OK, {tA=1s {M0100644 SZ=0 L=1 501:20 0 0:13852786 A 1591443695.015361 M 1591443695.015361 C 1591443695.016492}}
13:41:35.016909 rx 4: ACCESS i13852786 {u=501 g=20 } 
13:41:35.016925 tx 4:     OK
13:41:35.016968 rx 2: SETATTR i13852786 {mode 0100644, fh 1} 
13:41:35.017094 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 501:20 0 0:13852786 A 1591443695.015361 M 1591443695.015361 C 1591443695.017006}}
13:41:35.017148 rx 5: LOOKUP i1 ["._testF"] 8b
13:41:35.017173 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.017212 rx 3: GETATTR i13852786  
13:41:35.017239 tx 3:     OK, {tA=1s {M0100644 SZ=0 L=1 501:20 0 0:13852786 A 1591443695.015361 M 1591443695.015361 C 1591443695.017006}}
13:41:35.017307 rx 4: ACCESS i13852786 {u=501 g=20 r} 
13:41:35.017322 tx 4:     OK
13:41:35.017369 rx 2: LISTXATTR i13852786 {sz 0} 
13:41:35.017398 tx 2:     78=function not implemented
13:41:35.017449 rx 5: LOOKUP i1 ["._testF"] 8b
13:41:35.017475 tx 5:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.017638 rx 3: ACCESS i13852786 {u=501 g=20 w} 
13:41:35.017678 tx 3:     OK
13:41:35.017725 rx 4: SETXATTR i13852786 {sz 128 f0} ["testattr"] 137b
13:41:35.017733 tx 4:     78=function not implemented
13:41:35.017776 rx 2: LOOKUP i1 ["._testF"] 8b
13:41:35.017803 tx 2:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.017832 rx 5: GETATTR i1  
13:41:35.017862 tx 5:     OK, {tA=1s {M040755 SZ=96 L=3 501:20 0 0:1 A 1591443641.504215 M 1591443695.015374 C 1591443695.015374}}
13:41:35.017907 rx 3: CREATE i1 {0100644 [CREAT,RDWR]} ["._testF"] 8b
13:41:35.018048 tx 3:     OK, {i13852787 g1 {M0100644 SZ=0 L=1 501:20 0 0:13852787 A 1591443695.017963 M 1591443695.017963 C 1591443695.017963} &{2 0 0}}
13:41:35.018130 rx 4: WRITE i13852787 {Fh 2 [0 +4096) }  4096b
13:41:35.018182 tx 4:     OK
13:41:35.018225 rx 2: GETATTR i13852787  
13:41:35.018256 tx 2:     OK, {tA=1s {M0100644 SZ=4096 L=1 501:20 8 0:13852787 A 1591443695.017963 M 1591443695.018178 C 1591443695.018178}}
13:41:35.018448 rx 5: WRITE i13852787 {Fh 2 [0 +4096) }  4096b
13:41:35.018459 tx 5:     OK
13:41:35.018518 rx 3: FLUSH i13852787 {Fh 2} 
13:41:35.018531 tx 3:     OK
13:41:35.018569 rx 4: RELEASE i13852787 {Fh 2   L0} 
13:41:35.018735 tx 4:     OK
13:41:35.018777 rx 2: SETATTR i13852786 {mtime 1591443695.015361154, fh 1} 
13:41:35.509154 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:35.509178 tx 5:     OK
13:41:35.509225 rx 3: GETATTR i1  
13:41:35.509281 tx 3:     OK, {tA=1s {M040755 SZ=128 L=4 501:20 0 0:1 A 1591443641.504215 M 1591443695.017982 C 1591443695.017982}}
13:41:35.509725 rx 4: ACCESS i1 {u=501 g=20 } 
13:41:35.509745 tx 4:     OK
13:41:35.509819 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:35.509835 tx 5:     OK
13:41:35.509994 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:35.510010 tx 3:     OK
13:41:35.510059 rx 4: ACCESS i1 {u=501 g=20 w} 
13:41:35.510074 tx 4:     OK
13:41:35.510156 rx 5: ACCESS i1 {u=501 g=20 r} 
13:41:35.510178 tx 5:     OK
13:41:35.510234 rx 3: ACCESS i1 {u=501 g=20 x} 
13:41:35.510250 tx 3:     OK
13:41:35.510304 rx 4: LOOKUP i1 ["._."] 4b
13:41:35.510368 tx 4:     2=no such file or directory, {i0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
13:41:35.510559 rx 5: ACCESS i1 {u=501 g=20 } 
13:41:35.510575 tx 5:     OK
13:41:35.510672 rx 3: ACCESS i1 {u=501 g=20 } 
13:41:35.510688 tx 3:     OK
13:41:36.008343 rx 4: ACCESS i1 {u=501 g=20 x} 
13:41:36.008366 tx 4:     OK
13:41:41.110686 rx 5: STATFS i1 
13:41:41.110726 tx 5:     OK, {blocks (326535,312049)/476802 files 4880790192/4882452880 bs1048576 nl0 frs1048576}
atYuguo commented 4 years ago

Like I mentioned here, this somehow related to the value MAX_KERNEL_WRITE, but I don't know what causes crash.

atYuguo commented 3 years ago

This is now even weirder with the new API. With the "loopback" example, it exits suddenly with a large 'resourceFork' and it stops responding with a small 'resourceFork'.

Debug info:

Small resourceFork:

$> ls -l@
-rw-r--r--@ 1 xxxxxx  staff     0  7 Aug 20:09 test1
    com.apple.ResourceFork    10

$> cp test1 d1/
20:23:23.955459 rx 2: INIT n0 {7.19 Ra 0x100000 VOL_RENAME,CASE_INSENSITIVE,ATOMIC_O_TRUNC,EXPLICIT_INVAL_DATA,XTIMES,0xc000000} 
20:23:23.955552 tx 2:     OK, {7.8 Ra 0x100000  0/0 Wr 0x10000 Tg 0x0}
20:23:23.955616 rx 3: STATFS n1 
20:23:23.955642 tx 3:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.955677 rx 2: STATFS n1 
20:23:23.955683 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.955906 rx 3: ACCESS n1 {u=501 g=20 x} 
20:23:23.955927 tx 3:     OK
20:23:23.955988 rx 2: LOOKUP n1 [".go-fuse-epoll-hack"] 20b
20:23:23.955993 rx 3: STATFS n1 
20:23:23.956001 tx 3:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.956035 rx 4: STATFS n1 
20:23:23.956046 tx 4:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.956036 tx 2:     OK, {n18446744073709551615 g0 tE=0s tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.956059 rx 3: STATFS n1 
20:23:23.956062 tx 3:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.956085 rx 4: GETATTR n18446744073709551615  
20:23:23.956104 tx 4:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.956105 rx 2: STATFS n1 
20:23:23.956113 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.956137 rx 3: GETATTR n18446744073709551615  
20:23:23.956145 tx 3:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.956177 rx 4: ACCESS n18446744073709551615 {u=501 g=20 r,w} 
20:23:23.956179 tx 4:     OK
20:23:23.956192 rx 2: GETATTR n18446744073709551615  
20:23:23.956198 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.956213 rx 3: OPEN n18446744073709551615 {RDWR} 
20:23:23.956215 tx 3:     OK, {Fh 18446744073709551615 }
20:23:23.956241 rx 4: SETATTR n18446744073709551615 {size 0, fh 18446744073709551615} 
20:23:23.956248 tx 4:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.956263 rx 2: GETATTR n18446744073709551615  
20:23:23.956272 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.956293 rx 3: FLUSH n18446744073709551615 {Fh 18446744073709551615} 
20:23:23.956294 tx 3:     OK
20:23:23.956308 rx 4: RELEASE n18446744073709551615 {Fh 18446744073709551615 RDWR  L0} 
20:23:23.956310 tx 4:     OK
Mounted!
20:23:23.957868 rx 2: ACCESS n1 {u=0 g=0 } 
20:23:23.957874 tx 2:     OK
20:23:23.957907 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.957915 tx 3:     OK
20:23:23.957957 rx 4: GETATTR n1  
20:23:23.957969 tx 4:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:0 A 1628618767.183764 M 1628618764.349650 C 1628618764.349650}}
20:23:23.958017 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.958022 tx 2:     OK
20:23:23.958037 rx 3: STATFS n1 
20:23:23.958041 rx 4: STATFS n1 
20:23:23.958043 tx 3:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.958046 tx 4:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.958063 rx 2: STATFS n1 
20:23:23.958067 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.958078 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.958082 tx 3:     OK
20:23:23.958108 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.958112 tx 4:     OK
20:23:23.958139 rx 2: ACCESS n1 {u=0 g=0 } 
20:23:23.958145 tx 2:     OK
20:23:23.958179 rx 3: ACCESS n1 {u=0 g=0 } 
20:23:23.958184 tx 3:     OK
20:23:23.958228 rx 4: STATFS n1 
20:23:23.958234 tx 4:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.958255 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.958260 tx 2:     OK
20:23:23.958287 rx 3: ACCESS n1 {u=0 g=0 } 
20:23:23.958292 tx 3:     OK
20:23:23.958348 rx 4: ACCESS n1 {u=0 g=0 r} 
20:23:23.958354 tx 4:     OK
20:23:23.958377 rx 2: ACCESS n1 {u=0 g=0 } 
20:23:23.958382 tx 2:     OK
20:23:23.958410 rx 3: GETXATTR n1 {sz 32} ["com.apple.FinderInfo"] 21b
20:23:23.958421 tx 3:     78=function not implemented
20:23:23.958455 rx 4: LOOKUP n1 ["._."] 4b
20:23:23.958468 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.958521 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.958526 tx 2:     OK
20:23:23.958551 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.958557 tx 3:     OK
20:23:23.958586 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.958591 tx 4:     OK
20:23:23.958617 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.958621 tx 2:     OK
20:23:23.958652 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.958655 tx 3:     OK
20:23:23.958709 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.958714 tx 4:     OK
20:23:23.958783 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.958788 tx 2:     OK
20:23:23.958828 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.958833 tx 3:     OK
20:23:23.958895 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.958900 tx 4:     OK
20:23:23.958926 rx 2: ACCESS n1 {u=501 g=20 w} 
20:23:23.958931 tx 2:     OK
20:23:23.958952 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.958961 tx 3:     OK
20:23:23.958990 rx 4: ACCESS n1 {u=501 g=20 r} 
20:23:23.958995 tx 4:     OK
20:23:23.959019 rx 2: ACCESS n1 {u=501 g=20 r} 
20:23:23.959023 tx 2:     OK
20:23:23.959092 rx 3: LOOKUP n1 ["._."] 4b
20:23:23.959103 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.959134 rx 4: ACCESS n1 {u=501 g=20 x} 
20:23:23.959138 tx 4:     OK
20:23:23.959162 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.959166 tx 2:     OK
20:23:23.959192 rx 3: LOOKUP n1 ["._."] 4b
20:23:23.959201 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.959227 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.959232 tx 4:     OK
20:23:23.959254 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.959259 tx 2:     OK
20:23:23.959288 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.959294 tx 3:     OK
20:23:23.959422 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.959426 tx 4:     OK
20:23:23.959456 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.959460 tx 2:     OK
20:23:23.959490 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.959495 tx 3:     OK
20:23:23.959521 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.959526 tx 4:     OK
20:23:23.959553 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.959557 tx 2:     OK
20:23:23.959606 rx 3: STATFS n1 
20:23:23.959611 tx 3:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.959657 rx 4: STATFS n1 
20:23:23.959662 tx 4:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.959698 rx 2: STATFS n1 
20:23:23.959703 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.959740 rx 3: STATFS n1 
20:23:23.959745 tx 3:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.959759 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.959763 tx 4:     OK
20:23:23.959797 rx 2: STATFS n1 
20:23:23.959802 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.959897 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.959903 tx 3:     OK
20:23:23.959936 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.959940 tx 4:     OK
20:23:23.959966 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.959970 tx 2:     OK
20:23:23.959996 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.960001 tx 3:     OK
20:23:23.960026 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.960030 tx 4:     OK
20:23:23.960051 rx 2: STATFS n1 
20:23:23.960057 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.960167 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.960172 tx 3:     OK
20:23:23.960357 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.960363 tx 4:     OK
20:23:23.960592 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.960597 tx 2:     OK
20:23:23.960678 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.960683 tx 3:     OK
20:23:23.960721 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.960726 tx 4:     OK
20:23:23.960755 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.960760 tx 2:     OK
20:23:23.960787 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.960792 tx 3:     OK
20:23:23.960816 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.960821 tx 4:     OK
20:23:23.960844 rx 2: ACCESS n1 {u=501 g=20 w} 
20:23:23.960848 tx 2:     OK
20:23:23.960870 rx 3: ACCESS n1 {u=501 g=20 r} 
20:23:23.960875 tx 3:     OK
20:23:23.960901 rx 4: ACCESS n1 {u=501 g=20 x} 
20:23:23.960904 tx 4:     OK
20:23:23.960929 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.960934 tx 2:     OK
20:23:23.960957 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.960962 tx 3:     OK
20:23:23.960989 rx 4: LOOKUP n1 ["._."] 4b
20:23:23.960997 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.961022 rx 2: ACCESS n1 {u=501 g=20 w} 
20:23:23.961025 tx 2:     OK
20:23:23.961045 rx 3: ACCESS n1 {u=501 g=20 r} 
20:23:23.961050 tx 3:     OK
20:23:23.961073 rx 4: ACCESS n1 {u=501 g=20 x} 
20:23:23.961077 tx 4:     OK
20:23:23.961105 rx 2: LOOKUP n1 ["._."] 4b
20:23:23.961112 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.961145 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.961149 tx 3:     OK
20:23:23.961245 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.961250 tx 4:     OK
20:23:23.961285 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.961291 tx 2:     OK
20:23:23.961316 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.961321 tx 3:     OK
20:23:23.961345 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.961349 tx 4:     OK
20:23:23.961391 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.961396 tx 2:     OK
20:23:23.961480 rx 3: ACCESS n1 {u=501 g=20 x} 
20:23:23.961485 tx 3:     OK
20:23:23.961512 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.961518 tx 4:     OK
20:23:23.961554 rx 2: LOOKUP n1 [".hidden"] 8b
20:23:23.961567 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.961677 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.961682 tx 3:     OK
20:23:23.961709 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.961714 rx 2: STATFS n1 
20:23:23.961715 tx 4:     OK
20:23:23.961719 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534592/9713501800 bs1048576 nl0 frs1048576}
20:23:23.961746 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.961750 tx 3:     OK
20:23:23.961784 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.961789 tx 4:     OK
20:23:23.961815 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.961819 tx 2:     OK
20:23:23.961885 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.961890 tx 3:     OK
20:23:23.961956 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.961961 tx 4:     OK
20:23:23.961989 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.961994 tx 2:     OK
20:23:23.962206 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.962211 tx 3:     OK
20:23:23.962289 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.962294 tx 4:     OK
20:23:23.962349 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:23.962354 tx 2:     OK
20:23:23.962406 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:23.962411 tx 3:     OK
20:23:23.962482 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:23.962487 tx 4:     OK
20:23:23.962625 rx 2: LOOKUP n1 [".DS_Store"] 10b
20:23:23.962636 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:23.962674 rx 3: LOOKUP n1 [".DS_Store"] 10b
20:23:23.962682 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:24.007889 rx 4: ACCESS n1 {u=0 g=0 } 
20:23:24.007909 tx 4:     OK
20:23:24.126533 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:24.126567 tx 2:     OK
20:23:24.126705 rx 3: ACCESS n1 {u=501 g=20 w} 
20:23:24.126724 tx 3:     OK
20:23:24.183955 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:24.184009 tx 4:     OK
20:23:24.281899 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:24.281977 tx 2:     OK
20:23:24.282283 rx 3: ACCESS n1 {u=501 g=20 x} 
20:23:24.282315 tx 3:     OK
20:23:24.282435 rx 4: ACCESS n18446744073709551615 {u=501 g=20 } 
20:23:24.282444 tx 4:     OK
20:23:24.282523 rx 2: GETATTR n18446744073709551615  
20:23:24.282596 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:23:24.283132 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:24.283163 tx 3:     OK
20:23:24.283296 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:24.283317 tx 4:     OK
20:23:24.283588 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:24.283634 tx 2:     OK
20:23:24.283725 rx 3: ACCESS n1 {u=501 g=20 w} 
20:23:24.283755 tx 3:     OK
20:23:24.283847 rx 4: ACCESS n1 {u=501 g=20 r} 
20:23:24.283870 tx 4:     OK
20:23:24.283981 rx 2: ACCESS n1 {u=501 g=20 x} 
20:23:24.283999 tx 2:     OK
20:23:24.284089 rx 3: LOOKUP n1 ["._."] 4b
20:23:24.284156 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:24.284554 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:24.284582 tx 4:     OK
20:23:24.284669 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:24.284690 tx 2:     OK
20:23:30.543006 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:30.543094 tx 3:     OK
20:23:30.543214 rx 4: GETATTR n1  
20:23:30.543296 tx 4:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:0 A 1628618767.183764 M 1628618764.349650 C 1628618764.349650}}
20:23:30.543372 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:30.543387 tx 2:     OK
20:23:30.544313 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:30.544330 tx 3:     OK
20:23:31.327239 rx 4: ACCESS n1 {u=501 g=20 } 
20:23:31.327283 tx 4:     OK
20:23:31.327386 rx 2: ACCESS n1 {u=501 g=20 x} 
20:23:31.327402 tx 2:     OK
20:23:31.327482 rx 3: LOOKUP n1 ["test1"] 6b
20:23:31.327529 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.327675 rx 4: LOOKUP n1 ["test1"] 6b
20:23:31.327703 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.327809 rx 2: ACCESS n1 {u=501 g=20 w} 
20:23:31.327829 tx 2:     OK
20:23:31.327903 rx 3: CREATE n1 {0100644 [EXCL,CREAT,RDWR]} ["test1"] 6b
20:23:31.328165 tx 3:     OK, {n2 g1 {M0100644 SZ=0 L=1 501:20 0 0:1894100 A 1628619811.327998 M 1628619811.327998 C 1628619811.327998} &{1 0 0}}
20:23:31.328244 rx 4: LOOKUP n1 ["._test1"] 8b
20:23:31.328278 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.328360 rx 2: STATFS n1 
20:23:31.328382 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534590/9713501800 bs1048576 nl0 frs1048576}
20:23:31.328483 rx 3: ACCESS n2 {u=501 g=20 } 
20:23:31.328501 tx 3:     OK
20:23:31.328568 rx 4: SETATTR n2 {mode 0100600, fh 1} 
20:23:31.328639 tx 4:     OK, {tA=0s {M0100600 SZ=0 L=1 501:20 0 0:1894100 A 1628619811.327998 M 1628619811.327998 C 1628619811.328607}}
20:23:31.328699 rx 2: LOOKUP n1 ["._test1"] 8b
20:23:31.328727 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.328788 rx 3: GETATTR n2  
20:23:31.328817 tx 3:     OK, {tA=1s {M0100600 SZ=0 L=1 501:20 0 0:1894100 A 1628619811.327998 M 1628619811.327998 C 1628619811.328607}}
20:23:31.328960 rx 4: ACCESS n2 {u=501 g=20 } 
20:23:31.328978 tx 4:     OK
20:23:31.329035 rx 2: SETATTR n2 {mode 0100644, fh 1} 
20:23:31.329103 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 501:20 0 0:1894100 A 1628619811.327998 M 1628619811.327998 C 1628619811.329069}}
20:23:31.329162 rx 3: LOOKUP n1 ["._test1"] 8b
20:23:31.329187 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.329241 rx 4: GETATTR n2  
20:23:31.329262 tx 4:     OK, {tA=1s {M0100644 SZ=0 L=1 501:20 0 0:1894100 A 1628619811.327998 M 1628619811.327998 C 1628619811.329069}}
20:23:31.329384 rx 2: ACCESS n2 {u=501 g=20 } 
20:23:31.329402 tx 2:     OK
20:23:31.329459 rx 3: SETATTR n2 {mode 0100644, fh 1} 
20:23:31.329513 tx 3:     OK, {tA=0s {M0100644 SZ=0 L=1 501:20 0 0:1894100 A 1628619811.327998 M 1628619811.327998 C 1628619811.329489}}
20:23:31.329578 rx 4: LOOKUP n1 ["._test1"] 8b
20:23:31.329602 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.329655 rx 2: GETATTR n2  
20:23:31.329675 tx 2:     OK, {tA=1s {M0100644 SZ=0 L=1 501:20 0 0:1894100 A 1628619811.327998 M 1628619811.327998 C 1628619811.329489}}
20:23:31.329769 rx 3: ACCESS n2 {u=501 g=20 r} 
20:23:31.329787 tx 3:     OK
20:23:31.329839 rx 4: LISTXATTR n2 {sz 0} 
20:23:31.329862 tx 4:     78=function not implemented
20:23:31.329919 rx 2: LOOKUP n1 ["._test1"] 8b
20:23:31.329945 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.330335 rx 3: ACCESS n2 {u=501 g=20 w} 
20:23:31.330352 tx 3:     OK
20:23:31.330409 rx 4: SETXATTR n2 {sz 10 f0} ["com.apple.ResourceFork"] 33b
20:23:31.330425 tx 4:     78=function not implemented
20:23:31.330480 rx 2: LOOKUP n1 ["._test1"] 8b
20:23:31.330507 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.330559 rx 3: GETATTR n1  
20:23:31.330585 tx 3:     OK, {tA=1s {M040755 SZ=96 L=3 501:20 0 0:0 A 1628618767.183764 M 1628619811.328028 C 1628619811.328028}}
20:23:31.330644 rx 4: CREATE n1 {0100644 [CREAT,RDWR]} ["._test1"] 8b
20:23:31.330817 tx 4:     OK, {n3 g1 {M0100644 SZ=0 L=1 501:20 0 0:1894101 A 1628619811.330716 M 1628619811.330716 C 1628619811.330716} &{2 0 0}}
20:23:31.330920 rx 2: WRITE n3 {Fh 2 [0 +4096) } "\x00\x05\x16\a\x00\x02\x00\x00"... 4096b
20:23:31.331006 tx 2:     OK
20:23:31.331071 rx 3: GETATTR n3  
20:23:31.331092 tx 3:     OK, {tA=1s {M0100644 SZ=4096 L=1 501:20 8 0:1894101 A 1628619811.330716 M 1628619811.331002 C 1628619811.331002}}
20:23:31.331235 rx 4: WRITE n3 {Fh 2 [0 +4096) } "\x00\x05\x16\a\x00\x02\x00\x00"... 4096b
20:23:31.331247 tx 4:     OK
20:23:31.331315 rx 2: FLUSH n3 {Fh 2} 
20:23:31.331332 tx 2:     OK
20:23:31.331382 rx 3: RELEASE n3 {Fh 2   L0} 
20:23:31.331518 tx 3:     OK
20:23:31.331604 rx 4: SETATTR n2 {mtime 1628619811.327998471, fh 1} 
20:23:31.332183 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:31.332205 tx 2:     OK
20:23:31.332264 rx 3: GETATTR n1  
20:23:31.332296 tx 3:     OK, {tA=1s {M040755 SZ=128 L=4 501:20 0 0:0 A 1628618767.183764 M 1628619811.330745 C 1628619811.330745}}
20:23:31.332347 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:31.332363 tx 2:     OK
20:23:31.332432 rx 3: ACCESS n1 {u=501 g=20 x} 
20:23:31.332444 tx 3:     OK
20:23:31.332932 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:31.332953 tx 2:     OK
20:23:31.333014 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:31.333026 tx 3:     OK
20:23:31.333134 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:31.333149 tx 2:     OK
20:23:31.333186 rx 3: ACCESS n1 {u=501 g=20 w} 
20:23:31.333198 tx 3:     OK
20:23:31.333232 rx 2: ACCESS n1 {u=501 g=20 r} 
20:23:31.333242 tx 2:     OK
20:23:31.333275 rx 3: ACCESS n1 {u=501 g=20 x} 
20:23:31.333284 tx 3:     OK
20:23:31.333329 rx 2: LOOKUP n1 ["._."] 4b
20:23:31.333375 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:23:31.333521 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:31.333535 tx 3:     OK
20:23:31.333580 rx 2: ACCESS n1 {u=501 g=20 } 
20:23:31.333591 tx 2:     OK
20:23:34.288778 rx 3: ACCESS n1 {u=501 g=20 } 
20:23:34.288813 tx 3:     OK
20:23:34.288872 rx 2: GETATTR n1  
20:23:34.288914 tx 2:     OK, {tA=1s {M040755 SZ=128 L=4 501:20 0 0:0 A 1628618767.183764 M 1628619811.330745 C 1628619811.330745}}
20:23:34.289012 rx 3: ACCESS n1 {u=501 g=20 w} 
20:23:34.289022 tx 3:     OK
20:23:34.291863 rx 2: ACCESS n1 {u=501 g=20 r} 
20:23:34.291883 tx 2:     OK
20:23:34.291933 rx 3: OPENDIR n1 
20:23:34.291976 tx 3:     OK, {Fh 2 }
20:23:34.292060 rx 2: STATFS n1 
20:23:34.292080 tx 2:     OK, {blocks (886870,869798)/948584 files 9712534589/9713501800 bs1048576 nl0 frs1048576}
20:23:34.292285 rx 3: READDIR n1 {Fh 2 [0 +6550) } 
20:23:34.292464 tx 3:     OK,  64b data "\xd5\xe6\x1c\x00\x00\x00\x00\x00"...
20:23:34.292542 rx 2: READDIR n1 {Fh 2 [2 +6550) } 
20:23:34.292553 tx 2:     OK
20:23:34.292641 rx 3: RELEASEDIR n1 {Fh 2   L0} 
20:23:34.292648 tx 3:     OK
20:23:34.292780 rx 2: ACCESS n1 {u=501 g=20 x} 
20:23:34.292794 tx 2:     OK

Large resourceFork

$> ls -l@
-rw-r--r--@ 1 xxxxxx  staff     0 30 Jul 17:10 testF
    com.apple.ResourceFork  3126345

$> cp testF d1/
cp: testF: could not copy extended attributes to d1/testF: Argument list too long
20:27:32.333317 rx 2: INIT n0 {7.19 Ra 0x100000 CASE_INSENSITIVE,EXPLICIT_INVAL_DATA,XTIMES,VOL_RENAME,ATOMIC_O_TRUNC,0xc000000} 
20:27:32.333436 tx 2:     OK, {7.8 Ra 0x100000  0/0 Wr 0x10000 Tg 0x0}
20:27:32.333530 rx 3: STATFS n1 
20:27:32.333570 tx 3:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.333614 rx 2: STATFS n1 
20:27:32.333625 tx 2:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.333923 rx 3: STATFS n1 
20:27:32.333934 tx 3:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.333938 rx 2: STATFS n1 
20:27:32.333948 tx 2:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.334098 rx 3: ACCESS n1 {u=501 g=20 x} 
20:27:32.334126 tx 3:     OK
20:27:32.334223 rx 2: STATFS n1 
20:27:32.334249 rx 3: LOOKUP n1 [".go-fuse-epoll-hack"] 20b
20:27:32.334273 tx 2:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.334287 tx 3:     OK, {n18446744073709551615 g0 tE=0s tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.334329 rx 2: STATFS n1 
20:27:32.334334 tx 2:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.334350 rx 3: GETATTR n18446744073709551615  
20:27:32.334364 tx 3:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.334387 rx 2: GETATTR n18446744073709551615  
20:27:32.334396 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.334456 rx 3: ACCESS n18446744073709551615 {u=501 g=20 w,r} 
20:27:32.334458 tx 3:     OK
20:27:32.334479 rx 2: GETATTR n18446744073709551615  
20:27:32.334486 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.334511 rx 3: OPEN n18446744073709551615 {RDWR} 
20:27:32.334514 tx 3:     OK, {Fh 18446744073709551615 }
20:27:32.334562 rx 2: SETATTR n18446744073709551615 {size 0, fh 18446744073709551615} 
20:27:32.334573 tx 2:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.334594 rx 3: GETATTR n18446744073709551615  
20:27:32.334600 tx 3:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.334630 rx 2: FLUSH n18446744073709551615 {Fh 18446744073709551615} 
20:27:32.334632 tx 2:     OK
20:27:32.334775 rx 3: RELEASE n18446744073709551615 {Fh 18446744073709551615 RDWR  L0} 
20:27:32.334777 tx 3:     OK
Mounted!
20:27:32.336018 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.336043 tx 2:     OK
20:27:32.336088 rx 3: GETATTR n1  
20:27:32.336109 tx 3:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:0 A 1628619943.651990 M 1628619939.316337 C 1628619939.316337}}
20:27:32.336167 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.336173 tx 2:     OK
20:27:32.336196 rx 3: STATFS n1 
20:27:32.336204 tx 3:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.336218 rx 2: ACCESS n1 {u=0 g=0 } 
20:27:32.336223 tx 2:     OK
20:27:32.336287 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.336294 tx 2:     OK
20:27:32.336300 rx 4: STATFS n1 
20:27:32.336305 tx 4:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.336315 rx 3: STATFS n1 
20:27:32.336319 tx 3:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.336380 rx 2: ACCESS n1 {u=0 g=0 } 
20:27:32.336386 tx 2:     OK
20:27:32.336449 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.336456 tx 4:     OK
20:27:32.336482 rx 3: STATFS n1 
20:27:32.336487 tx 3:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.336522 rx 2: ACCESS n1 {u=0 g=0 } 
20:27:32.336528 tx 2:     OK
20:27:32.336574 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.336580 tx 4:     OK
20:27:32.336635 rx 3: ACCESS n1 {u=0 g=0 } 
20:27:32.336640 tx 3:     OK
20:27:32.336686 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.336690 tx 2:     OK
20:27:32.336725 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.336729 tx 4:     OK
20:27:32.336836 rx 3: ACCESS n1 {u=0 g=0 } 
20:27:32.336841 tx 3:     OK
20:27:32.336911 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.336935 tx 2:     OK
20:27:32.337014 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.337029 tx 4:     OK
20:27:32.337123 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.337129 tx 3:     OK
20:27:32.337214 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.337218 tx 2:     OK
20:27:32.337303 rx 4: GETXATTR n1 {sz 32} ["com.apple.FinderInfo"] 21b
20:27:32.337324 tx 4:     78=function not implemented
20:27:32.337408 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.337443 tx 3:     OK
20:27:32.337502 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.337520 tx 2:     OK
20:27:32.337629 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.337635 tx 4:     OK
20:27:32.337730 rx 3: ACCESS n1 {u=501 g=20 w} 
20:27:32.337735 tx 3:     OK
20:27:32.337817 rx 2: ACCESS n1 {u=501 g=20 r} 
20:27:32.337822 tx 2:     OK
20:27:32.337874 rx 4: ACCESS n1 {u=501 g=20 x} 
20:27:32.337929 tx 4:     OK
20:27:32.337981 rx 3: LOOKUP n1 ["._."] 4b
20:27:32.338002 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.338031 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.338035 tx 2:     OK
20:27:32.338141 rx 4: LOOKUP n1 ["._."] 4b
20:27:32.338183 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.338246 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.338275 tx 3:     OK
20:27:32.338402 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.338446 tx 2:     OK
20:27:32.338488 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.338497 tx 4:     OK
20:27:32.338536 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.338543 tx 3:     OK
20:27:32.338582 rx 2: ACCESS n1 {u=0 g=0 r} 
20:27:32.338587 tx 2:     OK
20:27:32.338672 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.338678 tx 4:     OK
20:27:32.338728 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.338734 tx 3:     OK
20:27:32.338905 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.338937 tx 4:     OK
20:27:32.338909 rx 2: STATFS n1 
20:27:32.338948 tx 2:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.339007 rx 3: STATFS n1 
20:27:32.339014 tx 3:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.339098 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.339106 rx 2: STATFS n1 
20:27:32.339120 tx 4:     OK
20:27:32.339123 tx 2:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.339192 rx 3: STATFS n1 
20:27:32.339207 tx 3:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.339282 rx 4: STATFS n1 
20:27:32.339297 tx 4:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.339383 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.339392 tx 2:     OK
20:27:32.339445 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.339492 tx 3:     OK
20:27:32.339571 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.339609 tx 4:     OK
20:27:32.339676 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.339716 tx 2:     OK
20:27:32.339784 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.339790 tx 3:     OK
20:27:32.339810 rx 4: STATFS n1 
20:27:32.339815 tx 4:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.339889 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.339912 tx 2:     OK
20:27:32.340081 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.340096 tx 3:     OK
20:27:32.340131 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.340143 tx 4:     OK
20:27:32.340275 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.340286 tx 2:     OK
20:27:32.340375 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.340383 tx 3:     OK
20:27:32.340433 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.340450 tx 4:     OK
20:27:32.340627 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.340636 tx 2:     OK
20:27:32.340698 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.340715 tx 3:     OK
20:27:32.340774 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.340787 tx 4:     OK
20:27:32.340830 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.340846 tx 2:     OK
20:27:32.340952 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.340980 tx 3:     OK
20:27:32.341066 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.341077 tx 4:     OK
20:27:32.341119 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.341132 tx 2:     OK
20:27:32.341225 rx 3: ACCESS n1 {u=501 g=20 r} 
20:27:32.341233 tx 3:     OK
20:27:32.341335 rx 4: LOOKUP n1 ["._."] 4b
20:27:32.341400 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.341442 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.341447 tx 2:     OK
20:27:32.341546 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.341552 tx 3:     OK
20:27:32.341648 rx 4: ACCESS n1 {u=501 g=20 w} 
20:27:32.341657 tx 4:     OK
20:27:32.341703 rx 2: ACCESS n1 {u=501 g=20 r} 
20:27:32.341721 tx 2:     OK
20:27:32.341771 rx 3: ACCESS n1 {u=501 g=20 x} 
20:27:32.341778 tx 3:     OK
20:27:32.341859 rx 4: LOOKUP n1 ["._."] 4b
20:27:32.341875 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.341921 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.341926 tx 2:     OK
20:27:32.342081 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.342114 tx 3:     OK
20:27:32.342152 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.342163 tx 4:     OK
20:27:32.342224 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.342234 tx 2:     OK
20:27:32.342582 rx 3: ACCESS n1 {u=501 g=20 x} 
20:27:32.342590 tx 3:     OK
20:27:32.342684 rx 4: LOOKUP n1 [".hidden"] 8b
20:27:32.342714 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.342762 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.342769 tx 2:     OK
20:27:32.342953 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.342960 tx 3:     OK
20:27:32.343040 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.343061 tx 4:     OK
20:27:32.343148 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.343169 tx 2:     OK
20:27:32.343272 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.343278 tx 3:     OK
20:27:32.343358 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.343362 tx 4:     OK
20:27:32.343422 rx 2: ACCESS n1 {u=501 g=20 w} 
20:27:32.343429 tx 2:     OK
20:27:32.343464 rx 3: ACCESS n1 {u=501 g=20 r} 
20:27:32.343468 tx 3:     OK
20:27:32.343609 rx 4: ACCESS n1 {u=501 g=20 x} 
20:27:32.343613 tx 4:     OK
20:27:32.343699 rx 2: LOOKUP n1 ["._."] 4b
20:27:32.343714 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.343857 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.343863 tx 3:     OK
20:27:32.343954 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.343960 tx 4:     OK
20:27:32.344079 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.344085 tx 2:     OK
20:27:32.344176 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.344182 tx 3:     OK
20:27:32.344267 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.344272 tx 4:     OK
20:27:32.344320 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.344326 tx 2:     OK
20:27:32.344381 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.344386 tx 3:     OK
20:27:32.344617 rx 4: STATFS n1 
20:27:32.344629 tx 4:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.344638 rx 2: LOOKUP n1 [".DS_Store"] 10b
20:27:32.344654 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.344726 rx 3: LOOKUP n1 [".DS_Store"] 10b
20:27:32.344735 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.388917 rx 2: ACCESS n1 {u=0 g=0 } 
20:27:32.388948 tx 2:     OK
20:27:32.558287 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.558315 tx 4:     OK
20:27:32.636431 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.636448 tx 3:     OK
20:27:32.636497 rx 2: ACCESS n1 {u=501 g=20 w} 
20:27:32.636505 tx 2:     OK
20:27:32.637710 rx 4: ACCESS n1 {u=501 g=20 r} 
20:27:32.637719 tx 4:     OK
20:27:32.637794 rx 3: OPENDIR n1 
20:27:32.637821 tx 3:     OK, {Fh 1 }
20:27:32.637860 rx 2: STATFS n1 
20:27:32.637869 tx 2:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:32.637901 rx 4: READDIR n1 {Fh 1 [0 +6550) } 
20:27:32.637959 tx 4:     OK
20:27:32.637984 rx 3: RELEASEDIR n1 {Fh 1   L0} 
20:27:32.637988 tx 3:     OK
20:27:32.700453 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.700489 tx 2:     OK
20:27:32.700593 rx 4: GETATTR n1  
20:27:32.700627 tx 4:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:0 A 1628619943.651990 M 1628619939.316337 C 1628619939.316337}}
20:27:32.700974 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:32.700980 tx 3:     OK
20:27:32.701064 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.701070 tx 2:     OK
20:27:32.701159 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.701166 tx 4:     OK
20:27:32.701216 rx 3: ACCESS n1 {u=501 g=20 w} 
20:27:32.701223 tx 3:     OK
20:27:32.701254 rx 2: ACCESS n1 {u=501 g=20 r} 
20:27:32.701259 tx 2:     OK
20:27:32.701331 rx 4: ACCESS n1 {u=501 g=20 x} 
20:27:32.701337 tx 4:     OK
20:27:32.701382 rx 3: LOOKUP n1 ["._."] 4b
20:27:32.701397 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:32.701570 rx 2: ACCESS n1 {u=501 g=20 } 
20:27:32.701575 tx 2:     OK
20:27:32.701647 rx 4: ACCESS n1 {u=501 g=20 } 
20:27:32.701652 tx 4:     OK
20:27:33.201123 rx 3: ACCESS n1 {u=501 g=20 x} 
20:27:33.201237 tx 3:     OK
20:27:33.201340 rx 2: ACCESS n18446744073709551615 {u=501 g=20 } 
20:27:33.201353 tx 2:     OK
20:27:33.201442 rx 4: GETATTR n18446744073709551615  
20:27:33.201504 tx 4:     OK, {tA=0s {M0100644 SZ=0 L=1 0:0 0 0:18446744073709551615 A 0.000000 M 0.000000 C 0.000000}}
20:27:44.370356 rx 3: ACCESS n1 {u=501 g=20 } 
20:27:44.370403 tx 3:     OK
20:27:44.370466 rx 2: GETATTR n1  
20:27:44.370509 tx 2:     OK, {tA=1s {M040755 SZ=64 L=2 501:20 0 0:0 A 1628619943.651990 M 1628619939.316337 C 1628619939.316337}}
20:27:44.370592 rx 4: ACCESS n1 {u=501 g=20 x} 
20:27:44.370612 tx 4:     OK
20:27:44.370673 rx 3: LOOKUP n1 ["testF"] 6b
20:27:44.370734 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:44.370840 rx 2: LOOKUP n1 ["testF"] 6b
20:27:44.370870 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:44.370951 rx 4: ACCESS n1 {u=501 g=20 w} 
20:27:44.370969 tx 4:     OK
20:27:44.371030 rx 3: CREATE n1 {0100644 [CREAT,EXCL,RDWR]} ["testF"] 6b
20:27:44.371306 tx 3:     OK, {n2 g1 {M0100644 SZ=0 L=1 501:20 0 0:1894681 A 1628620064.371124 M 1628620064.371124 C 1628620064.371124} &{1 0 0}}
20:27:44.371385 rx 2: LOOKUP n1 ["._testF"] 8b
20:27:44.371427 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:44.371502 rx 4: STATFS n1 
20:27:44.371523 tx 4:     OK, {blocks (886866,869794)/948584 files 9712534585/9713501800 bs1048576 nl0 frs1048576}
20:27:44.371608 rx 3: ACCESS n2 {u=501 g=20 } 
20:27:44.371629 tx 3:     OK
20:27:44.371692 rx 2: SETATTR n2 {mode 0100600, fh 1} 
20:27:44.371773 tx 2:     OK, {tA=0s {M0100600 SZ=0 L=1 501:20 0 0:1894681 A 1628620064.371124 M 1628620064.371124 C 1628620064.371736}}
20:27:44.371824 rx 4: LOOKUP n1 ["._testF"] 8b
20:27:44.371847 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:44.371891 rx 3: GETATTR n2  
20:27:44.371918 tx 3:     OK, {tA=1s {M0100600 SZ=0 L=1 501:20 0 0:1894681 A 1628620064.371124 M 1628620064.371124 C 1628620064.371736}}
20:27:44.372059 rx 2: ACCESS n2 {u=501 g=20 } 
20:27:44.372078 tx 2:     OK
20:27:44.372125 rx 4: SETATTR n2 {mode 0100644, fh 1} 
20:27:44.372183 tx 4:     OK, {tA=0s {M0100644 SZ=0 L=1 501:20 0 0:1894681 A 1628620064.371124 M 1628620064.371124 C 1628620064.372156}}
20:27:44.372229 rx 3: LOOKUP n1 ["._testF"] 8b
20:27:44.372252 tx 3:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:44.372296 rx 2: GETATTR n2  
20:27:44.372314 tx 2:     OK, {tA=1s {M0100644 SZ=0 L=1 501:20 0 0:1894681 A 1628620064.371124 M 1628620064.371124 C 1628620064.372156}}
20:27:44.372480 rx 4: ACCESS n2 {u=501 g=20 } 
20:27:44.372497 tx 4:     OK
20:27:44.372544 rx 3: SETATTR n2 {mode 0100644, fh 1} 
20:27:44.372604 tx 3:     OK, {tA=0s {M0100644 SZ=0 L=1 501:20 0 0:1894681 A 1628620064.371124 M 1628620064.371124 C 1628620064.372578}}
20:27:44.372696 rx 2: LOOKUP n1 ["._testF"] 8b
20:27:44.372718 tx 2:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:44.372773 rx 4: GETATTR n2  
20:27:44.372794 tx 4:     OK, {tA=1s {M0100644 SZ=0 L=1 501:20 0 0:1894681 A 1628620064.371124 M 1628620064.371124 C 1628620064.372578}}
20:27:44.372874 rx 3: ACCESS n2 {u=501 g=20 r} 
20:27:44.372889 tx 3:     OK
20:27:44.372944 rx 2: LISTXATTR n2 {sz 0} 
20:27:44.372970 tx 2:     78=function not implemented
20:27:44.373019 rx 4: LOOKUP n1 ["._testF"] 8b
20:27:44.373045 tx 4:     2=no such file or directory, {n0 g0 tE=0s tA=0s {M00 SZ=0 L=0 0:0 0 0:0 A 0.000000 M 0.000000 C 0.000000}}
20:27:44.374146 rx 3: ACCESS n2 {u=501 g=20 w} 
20:27:44.374175 tx 3:     OK
20:27:44.374881 Failed to read from fuse conn: 5=input/output error

Process finished with the exit code 0
dsxack commented 1 year ago

I just tested it on MacOS 14.2 wind MACFUSE 4.5 and this won't reproduced