trapexit / mergerfs

a featureful union filesystem
http://spawn.link
Other
4.18k stars 170 forks source link

renaming of file failed #989

Closed marc0janssen closed 1 year ago

marc0janssen commented 2 years ago

<Delete text, see below for new entry>

trapexit commented 2 years ago

Please, as the issue template requests, provide all information possible. Also, what is "merge-with-ng-1131-gfe90b72b"? That is not an official build.

marc0janssen commented 2 years ago

Apologies for not following the guidelines

Wiil repost a proper report.

Give me some time and I get back to you

marc0janssen commented 2 years ago

When I rename a file on the mergerfs-mount it gives an error To reproduce:

touch kk.txt

mv kk.txt jj.txt 
mv: can't rename 'kk.txt': No such file or directory

After the erorr the file is renamed to jj.txt I have the same result when I try to rename the file via a CIFS share in Macos

I would have expected that de file was renamed without an error

System information:

Linux DS1513 3.10.108 #41890 SMP Fri Jun 25 02:39:14 CST 2021 x86_64 GNU/Linux synology_cedarview_1513+

mergerfs version: 2.33.1

mergerfs -o nonempty,rw,use_ino,allow_other,func.getattr=newest,category.action=all,category.create=mfs,dropcacheonclose=true /volume1/video:/volume2/video2 /volume1/mergerfs/video

Filesystem Size Used Avail Use% Mounted on
/dev/md0 2.3G 1.4G 845M 62% /
devtmpfs 2.0G 0 2.0G 0% /dev
tmpfs 2.0G 124K 2.0G 1% /dev/shm
tmpfs 2.0G 20M 2.0G 2% /run
tmpfs 2.0G 0 2.0G 0% /sys/fs/cgroup
tmpfs 2.0G 2.2M 2.0G 1% /tmp
/dev/mapper/cachedev_0 5.3T 2.0T 3.3T 38% /volume2
/dev/mapper/cachedev_1 7.9T 5.1T 2.9T 65% /volume1
shm 64M 0 64M 0% /volume1/@docker/containers/60a88b6ecb9e7306bfe005bfcb042fcd443e146d43aabf87d792d38359a11b13/mounts/shm
1/video:2/video2 14T 7.1T 6.1T 54% /volume1/mergerfs/video

trapexit commented 2 years ago

What exactly is everything involved in what is happening so I can replicate it? I need path permissions and anything else relevant to the behaviors. And you should provide me with precise instructions to replicate. I don't have a synology. I don't have your path layouts. I don't have your perms. I need to know everything possible.

marc0janssen commented 2 years ago

I 'm not  noob with Linux but also not  an expert.

Can you give me instructions so I truly get the relevant information. On 12 Dec 2021, 05:45 +0100, trapexit @.***>, wrote:

What exactly is everything involved in what is happening so I can replicate it? I need path permissions and anything else relevant to the behaviors. And you should provide me with precise instructions to replicate. I don't have a synology. I don't have your path layouts. I don't have your perms. I need to know everything possible. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe.

trapexit commented 2 years ago

stat /volume1/video /volume2/video2

The strace instructions is in the docs and in the issue template.

Preferably you'd have step by step instructions where you reproduce the issue without any assumptions about your setup. The version built appeared to be custom and as was mentioned in a different thread synology has their own acls and patches which are non-standard. Helping narrow down if this is a synology thing or not would be useful. I don't have the means to test this as you have setup so I need the most precise and simple reproduction possible to narrow down what is going on. What you have provided so far works completely fine on my machines.

marc0janssen commented 2 years ago

Stat instructions

File: /volume1/video Size: 104 Blocks: 0 IO Block: 4096 directory Device: 3ah/58d Inode: 256 Links: 1 Access: (0777/drwxrwxrwx) Uid: ( 1032/networkuser) Gid: ( 100/ users) Access: 2021-12-11 23:06:14.370285988 +0100 Modify: 2021-12-11 23:06:14.045288572 +0100 Change: 2021-12-11 23:06:14.045288572 +0100 Birth: - File: /volume2/video2/ Size: 96 Blocks: 0 IO Block: 4096 directory Device: 23h/35d Inode: 256 Links: 1 Access: (0777/drwxrwxrwx) Uid: ( 1032/networkuser) Gid: ( 100/ users) Access: 2021-12-12 08:29:00.035602220 +0100 Modify: 2021-12-12 08:28:55.965636217 +0100 Change: 2021-12-12 08:28:55.965636217 +0100 Birth: -

marc0janssen commented 2 years ago

19882 08:47:02.372185 execve("/bin/mv", ["mv", "s.txt", "t.txt"], ["LC_ALL=en_US.UTF-8", "LANG=en_US.UTF-8", "SUDO_GID=100", "SUDO_COMMAND=/bin/su", "USER=root", "PWD=/volume1/videom", "HOME=/root", "SUDO_USER=beheer", "SUDOUID=1031", "MAIL=/var/mail/root", "SHELL=/bin/ash", "TERM=xterm", "SHLVL=1", "LOGNAME=root", "PATH=/opt/bin:/opt/sbin:/sbin:/bin:/usr/sbin:/usr/bin:/usr/syno/sbin:/usr/syno/bin:/usr/local/sbin:/usr/local/bin", "=/opt/bin/strace"]) = 0 <0.024460> 19882 08:47:02.397313 brk(NULL) = 0x1442000 <0.000020> 19882 08:47:02.397496 access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory) <0.000031> 19882 08:47:02.397944 openat(AT_FDCWD, "/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000035> 19882 08:47:02.398206 openat(AT_FDCWD, "/lib64/tls/x86_64/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000030> 19882 08:47:02.398336 stat("/lib64/tls/x86_64/x86_64", 0x7fff4c634e10) = -1 ENOENT (No such file or directory) <0.000026> 19882 08:47:02.398481 openat(AT_FDCWD, "/lib64/tls/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000029> 19882 08:47:02.398599 stat("/lib64/tls/x86_64", 0x7fff4c634e10) = -1 ENOENT (No such file or directory) <0.000050> 19882 08:47:02.398743 openat(AT_FDCWD, "/lib64/tls/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000029> 19882 08:47:02.398865 stat("/lib64/tls/x86_64", 0x7fff4c634e10) = -1 ENOENT (No such file or directory) <0.000029> 19882 08:47:02.398987 openat(AT_FDCWD, "/lib64/tls/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000028> 19882 08:47:02.399102 stat("/lib64/tls", 0x7fff4c634e10) = -1 ENOENT (No such file or directory) <0.000025> 19882 08:47:02.399214 openat(AT_FDCWD, "/lib64/x86_64/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000028> 19882 08:47:02.399327 stat("/lib64/x86_64/x86_64", 0x7fff4c634e10) = -1 ENOENT (No such file or directory) <0.000025> 19882 08:47:02.399438 openat(AT_FDCWD, "/lib64/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000034> 19882 08:47:02.399561 stat("/lib64/x86_64", 0x7fff4c634e10) = -1 ENOENT (No such file or directory) <0.000031> 19882 08:47:02.399732 openat(AT_FDCWD, "/lib64/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000046> 19882 08:47:02.399918 stat("/lib64/x86_64", 0x7fff4c634e10) = -1 ENOENT (No such file or directory) <0.000035> 19882 08:47:02.400090 openat(AT_FDCWD, "/lib64/libattr.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000046> 19882 08:47:02.400245 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\300\23\0\0\0\0\0\0@\0\0\0\0\0\0\08B\0\0\0\0\0\0\0\0\0\0@\08\0\6\0@\0\33\0\32\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0004:\0\0\0\0\0\0004:\0\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\370=\0\0\0\0\0\0\370= \0\0\0\0\0\370= \0\0\0\0\0X\3\0\0\0\0\0\0p\3\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\30>\0\0\0\0\0\0\30> \0\0\0\0\0\30> \0\0\0\0\0\300\1\0\0\0\0\0\0\300\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0P\345td\4\0\0\0\3\0\0\0\0\0\0\3\0\0\0\0\0\0"..., 832) = 832 <0.000028> 19882 08:47:02.400425 fstat(3, {st_dev=makedev(0x9, 0), st_ino=14020, st_mode=S_IFREG|0755, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=40, st_size=18680, st_atime=1639292645 / 2021-12-12T08:04:05.120742509+0100 /, st_atime_nsec=120742509, st_mtime=1585276567 / 2020-03-27T03:36:07+0100 /, st_mtime_nsec=0, st_ctime=1625208765 / 2021-07-02T08:52:45.251001345+0200 /, st_ctime_nsec=251001345}) = 0 <0.000025> 19882 08:47:02.400795 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fedf0fbb000 <0.000043> 19882 08:47:02.401002 mmap(NULL, 2113896, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedf0b94000 <0.000049> 19882 08:47:02.401176 mprotect(0x7fedf0b98000, 2093056, PROT_NONE) = 0 <0.000040> 19882 08:47:02.401300 mmap(0x7fedf0d97000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3000) = 0x7fedf0d97000 <0.000043> 19882 08:47:02.401474 close(3) = 0 <0.000030> 19882 08:47:02.401650 openat(AT_FDCWD, "/lib64/libsynoacl.so", O_RDONLY|O_CLOEXEC) = 3 <0.000058> 19882 08:47:02.401891 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320)\0\0\0\0\0\0@\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0@\08\0\7\0@\0\0\0\0\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\200\252\0\0\0\0\0\0\200\252\0\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\0\255\0\0\0\0\0\0\0\255 \0\0\0\0\0\0\255 \0\0\0\0\0000\7\0\0\0\0\0\0@\7\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\320\255\0\0\0\0\0\0\320\255 \0\0\0\0\0\320\255 \0\0\0\0\0\300\1\0\0\0\0\0\0\300\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0\7\0\0\0\4\0\0\0\0\255\0\0\0\0\0\0\0\255 \0\0\0\0\0"..., 832) = 832 <0.000023> 19882 08:47:02.402033 fstat(3, {st_dev=makedev(0x9, 0), st_ino=13574, st_mode=S_IFREG|0755, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=96, st_size=46128, st_atime=1639292645 / 2021-12-12T08:04:05.118742525+0100 /, st_atime_nsec=118742525, st_mtime=1619161185 / 2021-04-23T08:59:45+0200 /, st_mtime_nsec=0, st_ctime=1625208763 / 2021-07-02T08:52:43.508001297+0200 /, st_ctime_nsec=508001297}) = 0 <0.000019> 19882 08:47:02.402288 mmap(NULL, 2143296, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedf0988000 <0.000041> 19882 08:47:02.402439 mprotect(0x7fedf0993000, 2093056, PROT_NONE) = 0 <0.000054> 19882 08:47:02.402594 mmap(0x7fedf0b92000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xa000) = 0x7fedf0b92000 <0.000076> 19882 08:47:02.402801 close(3) = 0 <0.000028> 19882 08:47:02.402970 openat(AT_FDCWD, "/lib64/libc.so.6", O_RDONLY|O_CLOEXEC) = 3 <0.000055> 19882 08:47:02.403163 read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\340\20\2\0\0\0\0\0@\0\0\0\0\0\0\0(\306\32\0\0\0\0\0\0\0\0\0@\08\0\n\0@\0F\0E\0\6\0\0\0\4\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0000\2\0\0\0\0\0\0000\2\0\0\0\0\0\0\10\0\0\0\0\0\0\0\3\0\0\0\4\0\0\0\300\310\27\0\0\0\0\0\300\310\27\0\0\0\0\0\300\310\27\0\0\0\0\0\34\0\0\0\0\0\0\0\34\0\0\0\0\0\0\0\20\0\0\0\0\0\0\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0Db\32\0\0\0\0\0Db\32\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0pg\32\0\0\0\0\0pg:\0\0\0\0\0"..., 832) = 832 <0.000030> 19882 08:47:02.403331 fstat(3, {st_dev=makedev(0x9, 0), st_ino=13669, st_mode=S_IFREG|0555, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=3440, st_size=1759144, st_atime=1639292214 / 2021-12-12T07:56:54.583218900+0100 /, st_atime_nsec=583218900, st_mtime=1618209892 / 2021-04-12T08:44:52+0200 /, st_mtime_nsec=0, st_ctime=1625208764 / 2021-07-02T08:52:44.432001323+0200 /, st_ctime_nsec=432001323}) = 0 <0.000019> 19882 08:47:02.403570 mmap(NULL, 3865216, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedf05d8000 <0.000071> 19882 08:47:02.403763 mprotect(0x7fedf077f000, 2093056, PROT_NONE) = 0 <0.000046> 19882 08:47:02.403908 mmap(0x7fedf097e000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1a6000) = 0x7fedf097e000 <0.000039> 19882 08:47:02.404051 mmap(0x7fedf0984000, 14976, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fedf0984000 <0.000031> 19882 08:47:02.404181 close(3) = 0 <0.000015> 19882 08:47:02.404303 openat(AT_FDCWD, "/lib64/libsynocore.so.7", O_RDONLY|O_CLOEXEC) = 3 <0.000043> 19882 08:47:02.404461 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\300\256\0\0\0\0\0\0@\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0@\08\0\7\0@\0\0\0\0\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\360\260\2\0\0\0\0\0\360\260\2\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\0\271\2\0\0\0\0\0\0\271\"\0\0\0\0\0\0\271\"\0\0\0\0\0\214\24\0\0\0\0\0\0 +\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\330\274\2\0\0\0\0\0\330\274\"\0\0\0\0\0\330\274\"\0\0\0\0\0000\2\0\0\0\0\0\0000\2\0\0\0\0\0\0\10\0\0\0\0\0\0\0\7\0\0\0\4\0\0\0\0\271\2\0\0\0\0\0\0\271\"\0\0\0\0\0"..., 832) = 832 <0.000018> 19882 08:47:02.404577 fstat(3, {st_dev=makedev(0x9, 0), st_ino=14040, st_mode=S_IFREG|0644, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=360, st_size=183692, st_atime=1639292645 / 2021-12-12T08:04:05.114742556+0100 /, st_atime_nsec=114742556, st_mtime=1624266088 / 2021-06-21T11:01:28+0200 /, st_mtime_nsec=0, st_ctime=1625208765 / 2021-07-02T08:52:45.504001352+0200 /, st_ctime_nsec=504001352}) = 0 <0.000020> 19882 08:47:02.404865 mmap(NULL, 2286624, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedf03a9000 <0.000038> 19882 08:47:02.404995 mprotect(0x7fedf03d5000, 2093056, PROT_NONE) = 0 <0.000039> 19882 08:47:02.405114 mmap(0x7fedf05d4000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2b000) = 0x7fedf05d4000 <0.000035> 19882 08:47:02.405254 mmap(0x7fedf05d6000, 5152, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fedf05d6000 <0.000031> 19882 08:47:02.405386 close(3) = 0 <0.000015> 19882 08:47:02.405505 openat(AT_FDCWD, "/lib64/libsynocredentials.so.7", O_RDONLY|O_CLOEXEC) = 3 <0.000046> 19882 08:47:02.405785 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0@\20\0\0\0\0\0\0@\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0@\08\0\6\0@\0\0\0\0\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0 (\0\0\0\0\0\0 (\0\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0 .\0\0\0\0\0\0 . \0\0\0\0\0 . \0\0\0\0\0\313\2\0\0\0\0\0\0\340\2\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0@.\0\0\0\0\0\0@. \0\0\0\0\0@. \0\0\0\0\0\240\1\0\0\0\0\0\0\240\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0P\345td\4\0\0\0#\0\0\0\0\0\0#\0\0\0\0\0\0"..., 832) = 832 <0.000033> 19882 08:47:02.405957 fstat(3, {st_dev=makedev(0x9, 0), st_ino=13586, st_mode=S_IFREG|0755, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=32, st_size=12523, st_atime=1639292645 / 2021-12-12T08:04:05.118742525+0100 /, st_atime_nsec=118742525, st_mtime=1613702418 / 2021-02-19T03:40:18+0100 /, st_mtime_nsec=0, st_ctime=1625208763 / 2021-07-02T08:52:43.509001297+0200 /, st_ctime_nsec=509001297}) = 0 <0.000016> 19882 08:47:02.406182 mmap(NULL, 2109696, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedf01a5000 <0.000035> 19882 08:47:02.406332 mprotect(0x7fedf01a8000, 2093056, PROT_NONE) = 0 <0.000038> 19882 08:47:02.406448 mmap(0x7fedf03a7000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x7fedf03a7000 <0.000040> 19882 08:47:02.406602 close(3) = 0 <0.000039> 19882 08:47:02.406774 openat(AT_FDCWD, "/lib64/libicui18n.so.64", O_RDONLY|O_CLOEXEC) = 3 <0.000073> 19882 08:47:02.407023 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20T\17\0\0\0\0\0@\0\0\0\0\0\0\0\270t-\0\0\0\0\0\0\0\0\0@\08\0\6\0@\0\34\0\33\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\237h,\0\0\0\0\0\237h,\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\300w,\0\0\0\0\0\300wL\0\0\0\0\0\300wL\0\0\0\0\0\0\374\0\0\0\0\0\0x\f\1\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\200\-\0\0\0\0\0\200\M\0\0\0\0\0\200\M\0\0\0\0\0\360\1\0\0\0\0\0\0\360\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0P\345td\4\0\0\0\360p&\0\0\0\0\0\360p&\0\0\0\0\0"..., 832) = 832 <0.000021> 19882 08:47:02.407167 fstat(3, {st_dev=makedev(0x9, 0), st_ino=14290, st_mode=S_IFREG|0755, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=5824, st_size=2980792, st_atime=1639292645 / 2021-12-12T08:04:05.119742517+0100 /, st_atime_nsec=119742517, st_mtime=1599618744 / 2020-09-09T04:32:24+0200 /, st_mtime_nsec=0, st_ctime=1625208769 / 2021-07-02T08:52:49.274001458+0200 /, st_ctime_nsec=274001458}) = 0 <0.000025> 19882 08:47:02.407419 mmap(NULL, 5080120, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedefccc000 <0.000051> 19882 08:47:02.407569 mprotect(0x7fedeff93000, 2097152, PROT_NONE) = 0 <0.000081> 19882 08:47:02.407753 mmap(0x7fedf0193000, 69632, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2c7000) = 0x7fedf0193000 <0.000042> 19882 08:47:02.407917 mmap(0x7fedf01a4000, 1080, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fedf01a4000 <0.000032> 19882 08:47:02.408058 close(3) = 0 <0.000016> 19882 08:47:02.408248 openat(AT_FDCWD, "/lib64/libicuuc.so.64", O_RDONLY|O_CLOEXEC) = 3 <0.000070> 19882 08:47:02.408499 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 [\6\0\0\0\0\0@\0\0\0\0\0\0\0hs\34\0\0\0\0\0\0\0\0\0@\08\0\6\0@\0\34\0\33\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0wJ\33\0\0\0\0\0wJ\33\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0T\33\0\0\0\0\0T;\0\0\0\0\0T;\0\0\0\0\0\20\36\1\0\0\0\0\0@?\1\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\330l\34\0\0\0\0\0\330l<\0\0\0\0\0\330l<\0\0\0\0\0\20\2\0\0\0\0\0\0\20\2\0\0\0\0\0\0\10\0\0\0\0\0\0\0P\345td\4\0\0\0$<\30\0\0\0\0\0$<\30\0\0\0\0\0"..., 832) = 832 <0.000026> 19882 08:47:02.408725 fstat(3, {st_dev=makedev(0x9, 0), st_ino=14823, st_mode=S_IFREG|0755, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=3648, st_size=1866344, st_atime=1639292645 /* 2021-12-12T08:04:05.120742509+0100 */, st_atime_nsec=120742509, st_mtime=1599618744 /* 2020-09-09T04:32:24+0200 */, st_mtime_nsec=0, st_ctime=1625208772 /* 2021-07-02T08:52:52.412001545+0200 */, st_ctime_nsec=412001545}) = 0 <0.000017> 19882 08:47:02.408982 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fedf0fb9000 <0.000027> 19882 08:47:02.409101 mmap(NULL, 3969952, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedef902000 <0.000033> 19882 08:47:02.409214 mprotect(0x7fedefab7000, 2097152, PROT_NONE) = 0 <0.000034> 19882 08:47:02.409453 mmap(0x7fedefcb7000, 77824, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1b5000) = 0x7fedefcb7000 <0.000053> 19882 08:47:02.409645 mmap(0x7fedefcca000, 5024, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fedefcca000 <0.000031> 19882 08:47:02.409833 close(3) = 0 <0.000017> 19882 08:47:02.409963 openat(AT_FDCWD, "/lib64/libpthread.so.0", O_RDONLY|O_CLOEXEC) = 3 <0.000043> 19882 08:47:02.410111 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 a\0\0\0\0\0\0@\0\0\0\0\0\0\0\210\225\1\0\0\0\0\0\0\0\0\0@\08\0\t\0@\0$\0#\0\6\0\0\0\4\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0\370\1\0\0\0\0\0\0\370\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0\3\0\0\0\4\0\0\0 @\1\0\0\0\0\0 @\1\0\0\0\0\0 @\1\0\0\0\0\0\34\0\0\0\0\0\0\0\34\0\0\0\0\0\0\0\20\0\0\0\0\0\0\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0$\205\1\0\0\0\0\0$\205\1\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\260\213\1\0\0\0\0\0\260\213!\0\0\0\0\0"..., 832) = 832 <0.000022> 19882 08:47:02.410247 fstat(3, {st_dev=makedev(0x9, 0), st_ino=15747, st_mode=S_IFREG|0555, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=208, st_size=106120, st_atime=1639292285 /* 2021-12-12T07:58:05.123645461+0100 */, st_atime_nsec=123645461, st_mtime=1618209892 /* 2021-04-12T08:44:52+0200 */, st_mtime_nsec=0, st_ctime=1625208774 /* 2021-07-02T08:52:54.451001602+0200 */, st_ctime_nsec=451001602}) = 0 <0.000016> 19882 08:47:02.410481 mmap(NULL, 2217064, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedef6e4000 <0.000031> 19882 08:47:02.410593 mprotect(0x7fedef6fd000, 2093056, PROT_NONE) = 0 <0.000180> 19882 08:47:02.410868 mmap(0x7fedef8fc000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x18000) = 0x7fedef8fc000 <0.000049> 19882 08:47:02.411062 mmap(0x7fedef8fe000, 13416, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fedef8fe000 <0.000039> 19882 08:47:02.411199 close(3) = 0 <0.000019> 19882 08:47:02.411313 openat(AT_FDCWD, "/lib64/libcrypt.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000041> 19882 08:47:02.411441 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\v\0\0\0\0\0\0@\0\0\0\0\0\0\0\240\201\0\0\0\0\0\0\0\0\0\0@\08\0\7\0@\0\34\0\33\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\360|\0\0\0\0\0\0\360|\0\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\330}\0\0\0\0\0\0\330} \0\0\0\0\0\330} \0\0\0\0\0\320\2\0\0\0\0\0\0(\344\2\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\370}\0\0\0\0\0\0\370} \0\0\0\0\0\370} \0\0\0\0\0\320\1\0\0\0\0\0\0\320\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0\4\0\0\0\4\0\0\0\310\1\0\0\0\0\0\0\310\1\0\0\0\0\0\0"..., 832) = 832 <0.000021> 19882 08:47:02.411546 fstat(3, {st_dev=makedev(0x9, 0), st_ino=15706, st_mode=S_IFREG|0555, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=72, st_size=34976, st_atime=1639292645 /* 2021-12-12T08:04:05.119742517+0100 */, st_atime_nsec=119742517, st_mtime=1618209892 /* 2021-04-12T08:44:52+0200 */, st_mtime_nsec=0, st_ctime=1625208774 /* 2021-07-02T08:52:54.240001596+0200 */, st_ctime_nsec=240001596}) = 0 <0.000018> 19882 08:47:02.411779 mmap(NULL, 2318848, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedef4ad000 <0.000029> 19882 08:47:02.411878 mprotect(0x7fedef4b5000, 2093056, PROT_NONE) = 0 <0.000033> 19882 08:47:02.411970 mmap(0x7fedef6b4000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x7000) = 0x7fedef6b4000 <0.000032> 19882 08:47:02.412086 mmap(0x7fedef6b6000, 184832, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fedef6b6000 <0.000027> 19882 08:47:02.412195 close(3) = 0 <0.000017> 19882 08:47:02.412294 openat(AT_FDCWD, "/lib64/libapparmor.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000035> 19882 08:47:02.412407 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\35\0\0\0\0\0\0@\0\0\0\0\0\0\0\330\304\0\0\0\0\0\0\0\0\0\0@\08\0\6\0@\0\33\0\32\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0,\266\0\0\0\0\0\0,\266\0\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\330\275\0\0\0\0\0\0\330\275 \0\0\0\0\0\330\275 \0\0\0\0\0\30\6\0\0\0\0\0\0P\6\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\370\275\0\0\0\0\0\0\370\275 \0\0\0\0\0\370\275 \0\0\0\0\0\320\1\0\0\0\0\0\0\320\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0P\345td\4\0\0\0d\250\0\0\0\0\0\0d\250\0\0\0\0\0\0"..., 832) = 832 <0.000020> 19882 08:47:02.412505 fstat(3, {st_dev=makedev(0x9, 0), st_ino=14102, st_mode=S_IFREG|0755, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=104, st_size=52120, st_atime=1639292585 /* 2021-12-12T08:03:05.116216646+0100 */, st_atime_nsec=116216646, st_mtime=1600830415 /* 2020-09-23T05:06:55+0200 */, st_mtime_nsec=0, st_ctime=1625208766 /* 2021-07-02T08:52:46.850001390+0200 */, st_ctime_nsec=850001390}) = 0 <0.000017> 19882 08:47:02.412733 mmap(NULL, 2147368, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedef2a0000 <0.000039> 19882 08:47:02.412879 mprotect(0x7fedef2ac000, 2093056, PROT_NONE) = 0 <0.000035> 19882 08:47:02.412982 mmap(0x7fedef4ab000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xb000) = 0x7fedef4ab000 <0.000034> 19882 08:47:02.413114 close(3) = 0 <0.000018> 19882 08:47:02.413235 openat(AT_FDCWD, "/lib64/libstdc++.so.6", O_RDONLY|O_CLOEXEC) = 3 <0.000037> 19882 08:47:02.413357 read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\235\t\0\0\0\0\0@\0\0\0\0\0\0\0P\302\23\0\0\0\0\0\0\0\0\0@\08\0\7\0@\0\37\0\36\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\20\365\22\0\0\0\0\0\20\365\22\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0p\366\22\0\0\0\0\0p\3662\0\0\0\0\0p\3662\0\0\0\0\0\310\312\0\0\0\0\0\0p\377\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0H\201\23\0\0\0\0\0H\2013\0\0\0\0\0H\2013\0\0\0\0\0\20\2\0\0\0\0\0\0\20\2\0\0\0\0\0\0\10\0\0\0\0\0\0\0\7\0\0\0\4\0\0\0p\366\22\0\0\0\0\0p\3662\0\0\0\0\0"..., 832) = 832 <0.000022> 19882 08:47:02.413462 fstat(3, {st_dev=makedev(0x9, 0), st_ino=14053, st_mode=S_IFREG|0555, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=2536, st_size=1296912, st_atime=1639292645 /* 2021-12-12T08:04:05.112742572+0100 */, st_atime_nsec=112742572, st_mtime=1618209892 /* 2021-04-12T08:44:52+0200 */, st_mtime_nsec=0, st_ctime=1625208765 /* 2021-07-02T08:52:45.606001355+0200 */, st_ctime_nsec=606001355}) = 0 <0.000019> 19882 08:47:02.413637 mmap(NULL, 3405280, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedeef60000 <0.000030> 19882 08:47:02.413778 mprotect(0x7fedef090000, 2093056, PROT_NONE) = 0 <0.000036> 19882 08:47:02.413881 mmap(0x7fedef28f000, 57344, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x12f000) = 0x7fedef28f000 <0.000035> 19882 08:47:02.414001 mmap(0x7fedef29d000, 9696, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fedef29d000 <0.000028> 19882 08:47:02.414114 close(3) = 0 <0.000020> 19882 08:47:02.414235 openat(AT_FDCWD, "/lib64/libm.so.6", O_RDONLY|O_CLOEXEC) = 3 <0.000038> 19882 08:47:02.414360 read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0Pw\0\0\0\0\0\0@\0\0\0\0\0\0\0\370\203\24\0\0\0\0\0\0\0\0\0@\08\0\7\0@\0\34\0\33\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0004z\24\0\0\0\0\0004z\24\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\260}\24\0\0\0\0\0\260}4\0\0\0\0\0\260}4\0\0\0\0\0P\5\0\0\0\0\0\0h\5\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\320}\24\0\0\0\0\0\320}4\0\0\0\0\0\320}4\0\0\0\0\0\340\1\0\0\0\0\0\0\340\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0\4\0\0\0\4\0\0\0\310\1\0\0\0\0\0\0\310\1\0\0\0\0\0\0"..., 832) = 832 <0.000021> 19882 08:47:02.414465 fstat(3, {st_dev=makedev(0x9, 0), st_ino=13591, st_mode=S_IFREG|0555, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=2632, st_size=1346296, st_atime=1639292645 /* 2021-12-12T08:04:05.115742548+0100 */, st_atime_nsec=115742548, st_mtime=1618209892 /* 2021-04-12T08:44:52+0200 */, st_mtime_nsec=0, st_ctime=1625208763 /* 2021-07-02T08:52:43.833001306+0200 */, st_ctime_nsec=833001306}) = 0 <0.000019> 19882 08:47:02.414643 mmap(NULL, 3441432, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedeec17000 <0.000039> 19882 08:47:02.414803 mprotect(0x7fedeed5f000, 2093056, PROT_NONE) = 0 <0.000040> 19882 08:47:02.414929 mmap(0x7fedeef5e000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x147000) = 0x7fedeef5e000 <0.000038> 19882 08:47:02.415068 close(3) = 0 <0.000018> 19882 08:47:02.415187 openat(AT_FDCWD, "/lib64/libgcc_s.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000037> 19882 08:47:02.415311 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\370-\0\0\0\0\0\0@\0\0\0\0\0\0\0P\"\1\0\0\0\0\0\0\0\0\0@\08\0\6\0@\0\34\0\33\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\214\16\1\0\0\0\0\0\214\16\1\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0\310\35\1\0\0\0\0\0\310\35!\0\0\0\0\0\310\35!\0\0\0\0\0\230\3\0\0\0\0\0\0 \6\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\360\35\1\0\0\0\0\0\360\35!\0\0\0\0\0\360\35!\0\0\0\0\0\340\1\0\0\0\0\0\0\340\1\0\0\0\0\0\0\10\0\0\0\0\0\0\0P\345td\4\0\0\0\324\360\0\0\0\0\0\0\324\360\0\0\0\0\0\0"..., 832) = 832 <0.000022> 19882 08:47:02.415417 fstat(3, {st_dev=makedev(0x9, 0), st_ino=14664, st_mode=S_IFREG|0444, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=152, st_size=76112, st_atime=1639292645 /* 2021-12-12T08:04:05.113742564+0100 */, st_atime_nsec=113742564, st_mtime=1618209892 /* 2021-04-12T08:44:52+0200 */, st_mtime_nsec=0, st_ctime=1625208771 /* 2021-07-02T08:52:51.391001517+0200 */, st_ctime_nsec=391001517}) = 0 <0.000020> 19882 08:47:02.415595 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fedf0fb7000 <0.000024> 19882 08:47:02.415730 mmap(NULL, 2171880, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedeea04000 <0.000029> 19882 08:47:02.415833 mprotect(0x7fedeea15000, 2097152, PROT_NONE) = 0 <0.000035> 19882 08:47:02.415929 mmap(0x7fedeec15000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x11000) = 0x7fedeec15000 <0.000033> 19882 08:47:02.416052 close(3) = 0 <0.000017> 19882 08:47:02.416164 openat(AT_FDCWD, "/lib64/libicudata.so.64", O_RDONLY|O_CLOEXEC) = 3 <0.000038> 19882 08:47:02.416284 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0f\2\0\0\0\0\0\0@\0\0\0\0\0\0\0\20\0\0\0\0\0\0\0\0\0\0@\08\0\5\0@\0\n\0\t\0\1\0\0\0\4\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\270\2\0\0\0\0\0\0\270\2\0\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0 \17\0\0\0\0\0\0 \17 \0\0\0\0\0 \17 \0\0\0\0\0\340\0\0\0\0\0\0\0\340\0\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0 \17\0\0\0\0\0\0 \17 \0\0\0\0\0 \17 \0\0\0\0\0\340\0\0\0\0\0\0\0\340\0\0\0\0\0\0\0\10\0\0\0\0\0\0\0Q\345td\6\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 832) = 832 <0.000020> 19882 08:47:02.416383 fstat(3, {st_dev=makedev(0x9, 0), st_ino=13717, st_mode=S_IFREG|0755, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=16, st_size=4832, st_atime=1639292645 / 2021-12-12T08:04:05.120742509+0100 /, st_atime_nsec=120742509, st_mtime=1599618744 / 2020-09-09T04:32:24+0200 /, st_mtime_nsec=0, st_ctime=1625208764 / 2021-07-02T08:52:44.515001325+0200 /, st_ctime_nsec=515001325}) = 0 <0.000018> 19882 08:47:02.416567 mmap(NULL, 2101248, PROT_READ, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedee803000 <0.000028> 19882 08:47:02.416692 mprotect(0x7fedee804000, 2093056, PROT_NONE) = 0 <0.000046> 19882 08:47:02.416841 mmap(0x7fedeea03000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0) = 0x7fedeea03000 <0.000037> 19882 08:47:02.416981 close(3) = 0 <0.000019> 19882 08:47:02.417104 openat(AT_FDCWD, "/lib64/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3 <0.000040> 19882 08:47:02.417229 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\r\0\0\0\0\0\0@\0\0\0\0\0\0\0\2201\0\0\0\0\0\0\0\0\0\0@\08\0\7\0@\0\36\0\35\0\1\0\0\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0x \0\0\0\0\0\0x \0\0\0\0\0\0\0\0 \0\0\0\0\0\1\0\0\0\6\0\0\0-\0\0\0\0\0\0- \0\0\0\0\0`- \0\0\0\0\0 \3\0\0\0\0\0\0\220\3\0\0\0\0\0\0\0\0 \0\0\0\0\0\2\0\0\0\6\0\0\0\220-\0\0\0\0\0\0\220- \0\0\0\0\0\220- \0\0\0\0\0\20\2\0\0\0\0\0\0\20\2\0\0\0\0\0\0\10\0\0\0\0\0\0\0\4\0\0\0\4\0\0\0\310\1\0\0\0\0\0\0\310\1\0\0\0\0\0\0"..., 832) = 832 <0.000022> 19882 08:47:02.417333 fstat(3, {st_dev=makedev(0x9, 0), st_ino=14083, st_mode=S_IFREG|0555, st_nlink=1, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=32, st_size=14608, st_atime=1639292401 / 2021-12-12T08:00:01.005706485+0100 /, st_atime_nsec=5706485, st_mtime=1618209892 / 2021-04-12T08:44:52+0200 /, st_mtime_nsec=0, st_ctime=1625208766 / 2021-07-02T08:52:46.818001389+0200 /, st_ctime_nsec=818001389}) = 0 <0.000019> 19882 08:47:02.417512 mmap(NULL, 2109680, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7fedee5ff000 <0.000031> 19882 08:47:02.417611 mprotect(0x7fedee602000, 2093056, PROT_NONE) = 0 <0.000064> 19882 08:47:02.417743 mmap(0x7fedee801000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x7fedee801000 <0.000034> 19882 08:47:02.417878 close(3) = 0 <0.000017> 19882 08:47:02.418096 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fedf0fb5000 <0.000024> 19882 08:47:02.418219 mmap(NULL, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fedf0fb2000 <0.000021> 19882 08:47:02.418320 arch_prctl(ARCH_SET_FS, 0x7fedf0fb2b00) = 0 <0.000017> 19882 08:47:02.418612 mprotect(0x7fedf097e000, 16384, PROT_READ) = 0 <0.000046> 19882 08:47:02.418838 mprotect(0x7fedee801000, 4096, PROT_READ) = 0 <0.000037> 19882 08:47:02.418967 mprotect(0x7fedeea03000, 4096, PROT_READ) = 0 <0.000021> 19882 08:47:02.419076 mprotect(0x7fedeec15000, 4096, PROT_READ) = 0 <0.000026> 19882 08:47:02.419216 mprotect(0x7fedeef5e000, 4096, PROT_READ) = 0 <0.000027> 19882 08:47:02.421898 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fedf0fb0000 <0.000036> 19882 08:47:02.422390 mprotect(0x7fedef28f000, 40960, PROT_READ) = 0 <0.000040> 19882 08:47:02.422565 mprotect(0x7fedef8fc000, 4096, PROT_READ) = 0 <0.000032> 19882 08:47:02.422707 mprotect(0x7fedef4ab000, 4096, PROT_READ) = 0 <0.000033> 19882 08:47:02.422830 mprotect(0x7fedef6b4000, 4096, PROT_READ) = 0 <0.000029> 19882 08:47:02.423208 mprotect(0x7fedefcb7000, 73728, PROT_READ) = 0 <0.000036> 19882 08:47:02.424068 mprotect(0x7fedf0193000, 61440, PROT_READ) = 0 <0.000039> 19882 08:47:02.424243 mprotect(0x7fedf03a7000, 4096, PROT_READ) = 0 <0.000030> 19882 08:47:02.424388 mprotect(0x7fedf05d4000, 4096, PROT_READ) = 0 <0.000029> 19882 08:47:02.424501 mprotect(0x7fedf0d97000, 4096, PROT_READ) = 0 <0.000029> 19882 08:47:02.424613 mprotect(0x7fedf0b92000, 4096, PROT_READ) = 0 <0.000056> 19882 08:47:02.424769 mprotect(0x61e000, 4096, PROT_READ) = 0 <0.000025> 19882 08:47:02.424882 mprotect(0x7fedf0fbd000, 4096, PROT_READ) = 0 <0.000029> 19882 08:47:02.424975 set_tid_address(0x7fedf0fb2dd0) = 19882 <0.000016> 19882 08:47:02.425050 set_robust_list(0x7fedf0fb2de0, 24) = 0 <0.000016> 19882 08:47:02.425143 rt_sigaction(SIGRTMIN, {sa_handler=0x7fedef6e9bc0, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7fedef6f5c20}, NULL, 8) = 0 <0.000020> 19882 08:47:02.425274 rt_sigaction(SIGRT_1, {sa_handler=0x7fedef6e9c60, sa_mask=[], sa_flags=SA_RESTORER|SA_RESTART|SA_SIGINFO, sa_restorer=0x7fedef6f5c20}, NULL, 8) = 0 <0.000017> 19882 08:47:02.425368 rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0 <0.000017> 19882 08:47:02.425469 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=81921024, rlim_max=RLIM64_INFINITY}) = 0 <0.000017> 19882 08:47:02.425865 brk(NULL) = 0x1442000 <0.000021> 19882 08:47:02.425989 brk(0x1463000) = 0x1463000 <0.000026> 19882 08:47:02.426240 open("/usr/lib/locale/locale-archive", O_RDONLY|O_CLOEXEC) = 3 <0.000038> 19882 08:47:02.426385 fstat(3, {st_dev=makedev(0x9, 0), st_ino=2245, st_mode=S_IFREG|0644, st_nlink=2, st_uid=0, st_gid=0, st_blksize=4096, st_blocks=28064, st_size=14367440, st_atime=1639238751 / 2021-12-11T17:05:51.816751224+0100 /, st_atime_nsec=816751224, st_mtime=1586930174 / 2020-04-15T07:56:14+0200 /, st_mtime_nsec=0, st_ctime=1625208818 / 2021-07-02T08:53:38.286000063+0200 */, st_ctime_nsec=286000063}) = 0 <0.000019> 19882 08:47:02.426564 mmap(NULL, 14367440, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7feded84b000 <0.000030> 19882 08:47:02.426700 close(3) = 0 <0.000021> 19882 08:47:02.426880 geteuid() = 0 <0.000016> 19882 08:47:02.426974 ioctl(0, TCGETS, {c_iflags=0x500, c_oflags=0x5, c_cflags=0xbf, c_lflags=0x8a3b, c_line=0, c_cc="\x03\x1c\x7f\x15\x04\x00\x01\x00\x11\x13\x1a\x00\x12\x0f\x17\x16\x00\x00\x00"}) = 0 <0.000023> 19882 08:47:02.427118 renameat2(AT_FDCWD, "s.txt", AT_FDCWD, "t.txt", RENAME_NOREPLACE) = -1 EINVAL (Invalid argument) <0.000230> 19882 08:47:02.427469 newfstatat(AT_FDCWD, "t.txt", 0x7fff4c6355d0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) <0.000099> 19882 08:47:02.427837 renameat(AT_FDCWD, "s.txt", AT_FDCWD, "t.txt") = 0 <0.000586> 19882 08:47:02.428623 lseek(0, 0, SEEK_CUR) = -1 ESPIPE (Illegal seek) <0.000020> 19882 08:47:02.428808 close(0) = 0 <0.000019> 19882 08:47:02.428907 close(1) = 0 <0.000018> 19882 08:47:02.428989 close(2) = 0 <0.000017> 19882 08:47:02.429125 exit_group(0) = ? 19882 08:47:02.429718 +++ exited with 0 +++

marc0janssen commented 2 years ago

mergerfs.strace.txt

marc0janssen commented 2 years ago

Hope you can help me, because this software is super useful if it works on Synology

marc0janssen commented 2 years ago

By the way the version is NOT custom.

I changed it to

mergerfs version: 2.33.1

trapexit commented 2 years ago

The strace you provided for mergerfs contains no evidence of rename being called. Instead perhaps writing out a movie.

Please set it up so that there is nothing else going on. A completely bespoke and as simple setup as possible. Then start tracing then run "mv".

marc0janssen commented 2 years ago

ash-4.4# mergerfs -v mergerfs version: 2.33.1

Log files

ash-4.4# stat /volume1/video /volume2/video2 File: /volume1/video Size: 104 Blocks: 0 IO Block: 4096 directory Device: 3ah/58d Inode: 256 Links: 1 Access: (0700/drwx------) Uid: ( 1032/networkuser) Gid: ( 100/ users) Access: 2021-12-11 23:06:14.370285988 +0100 Modify: 2021-12-11 23:06:14.045288572 +0100 Change: 2021-12-11 23:06:14.045288572 +0100 Birth: - File: /volume2/video2 Size: 86 Blocks: 0 IO Block: 4096 directory Device: 23h/35d Inode: 256 Links: 1 Access: (0777/drwxrwxrwx) Uid: ( 1032/networkuser) Gid: ( 100/ users) Access: 2021-12-12 11:59:29.787051355 +0100 Modify: 2021-12-12 11:59:26.506078388 +0100 Change: 2021-12-12 11:59:26.506078388 +0100 Birth: -

trapexit commented 2 years ago

mv shows

18469 18:49:24.808900 renameat2(AT_FDCWD, "aa.txt", AT_FDCWD, "bb.txt", RENAME_NOREPLACE) = -1 EINVAL (Invalid argument) <0.000315>
18469 18:49:24.809335 newfstatat(AT_FDCWD, "bb.txt", 0x7fffb9ee19c0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) <0.000089>
18469 18:49:24.809542 renameat(AT_FDCWD, "aa.txt", AT_FDCWD, "bb.txt") = 0 <0.000611>

Rename returns 0 as it should and there is no logging of any error.

marc0janssen commented 2 years ago

Weird I get the following on the prompt

uruk:/mnt/video# mv bb.txt aa.txt mv: can't rename 'bb.txt': No such file or directory On 12 Dec 2021, 19:19 +0100, trapexit @.***>, wrote:

mv shows 18469 18:49:24.808900 renameat2(AT_FDCWD, "aa.txt", AT_FDCWD, "bb.txt", RENAME_NOREPLACE) = -1 EINVAL (Invalid argument) <0.000315> 18469 18:49:24.809335 newfstatat(AT_FDCWD, "bb.txt", 0x7fffb9ee19c0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) <0.000089> 18469 18:49:24.809542 renameat(AT_FDCWD, "aa.txt", AT_FDCWD, "bb.txt") = 0 <0.000611> Rename returns 0 as it should and there is no logging of any error. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe.

trapexit commented 2 years ago

simply run strace -f -e write mv bb.txt aa.txt and you will see the writing to stderr if there are errors. You can look at the trace you sent me and there are no writes to stderr. write(2,...)

marc0janssen commented 2 years ago

Yes I see… Thanks so far.. I will investigate further. On 12 Dec 2021, 19:24 +0100, trapexit/mergerfs @.***>, wrote:

strace -f -e write mv bb.txt aa.txt

trapexit commented 2 years ago

I need traces where you reproduce that situation.

marc0janssen commented 2 years ago

@.:/volume1/videom$ strace -f -e write mv bb.txt aa.txt +++ exited with 0 +++ On 12 Dec 2021, 19:46 +0100, trapexit @.>, wrote:

I need traces where you reproduce that situation. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe.

marc0janssen commented 2 years ago

I think one of the volumes on the Synology is faulty….

When I do a mv/rename directly on the volume, I get the behaviour too.

SO I need to investigate on the Synology On 12 Dec 2021, 19:47 +0100, Marco Janssen @.***>, wrote:

@.:/volume1/videom$ strace -f -e write mv bb.txt aa.txt +++ exited with 0 +++ On 12 Dec 2021, 19:46 +0100, trapexit @.>, wrote:

I need traces where you reproduce that situation. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe.

trapexit commented 2 years ago

What's the trace when you do that?

marc0janssen commented 2 years ago

+++ exited with 0 +++ On 12 Dec 2021, 19:50 +0100, Marco Janssen @.***>, wrote:

+++ exited with 0 +++

trapexit commented 2 years ago

A full trace. Remove the -e write

trapexit commented 2 years ago

The trace will likely show you where that error comes from. Unless the error is generated by mv itself rather than a syscall.

marc0janssen commented 2 years ago

@.:/volume2/video2$ strace -f write mv bb.txt aa.txt strace: Can't stat 'write': No such file or directory On 12 Dec 2021, 19:53 +0100, trapexit @.>, wrote:

The trace will likely show you where that error comes from. Unless the error is generated by mv itself rather than a syscall. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe.

trapexit commented 2 years ago

No. Remove -e write.

strace -f mv bb.txt aa.txt

marc0janssen commented 2 years ago

SORRY for that.

@.:/volume1/videom$ strace -f mv aa.txt bb.txt execve("/bin/mv", ["mv", "aa.txt", "bb.txt"], 0x7fffff51efc8 / 20 vars */) = 0 brk(NULL)                               = 0xf2a000 access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/lib64/tls/x86_64/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) stat("/lib64/tls/x86_64/x86_64", 0x7ffee6c16630) = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/lib64/tls/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) stat("/lib64/tls/x86_64", 0x7ffee6c16630) = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/lib64/tls/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) stat("/lib64/tls/x86_64", 0x7ffee6c16630) = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/lib64/tls/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) stat("/lib64/tls", 0x7ffee6c16630)      = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/lib64/x86_64/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) stat("/lib64/x86_64/x86_64", 0x7ffee6c16630) = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/lib64/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) stat("/lib64/x86_64", 0x7ffee6c16630)   = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/lib64/x86_64/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) stat("/lib64/x86_64", 0x7ffee6c16630)   = -1 ENOENT (No such file or directory) openat(AT_FDCWD, "/lib64/libattr.so.1", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\300\23\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0755, st_size=18680, ...}) = 0 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f873388b000 mmap(NULL, 2113896, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8733464000 mprotect(0x7f8733468000, 2093056, PROT_NONE) = 0 mmap(0x7f8733667000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3000) = 0x7f8733667000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libsynoacl.so", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320)\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0755, st_size=46128, ...}) = 0 mmap(NULL, 2143296, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8733258000 mprotect(0x7f8733263000, 2093056, PROT_NONE) = 0 mmap(0x7f8733462000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xa000) = 0x7f8733462000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libc.so.6", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\340\20\2\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0555, st_size=1759144, ...}) = 0 mmap(NULL, 3865216, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8732ea8000 mprotect(0x7f873304f000, 2093056, PROT_NONE) = 0 mmap(0x7f873324e000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1a6000) = 0x7f873324e000 mmap(0x7f8733254000, 14976, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f8733254000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libsynocore.so.7", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\300\256\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0644, st_size=183692, ...}) = 0 mmap(NULL, 2286624, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8732c79000 mprotect(0x7f8732ca5000, 2093056, PROT_NONE) = 0 mmap(0x7f8732ea4000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2b000) = 0x7f8732ea4000 mmap(0x7f8732ea6000, 5152, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f8732ea6000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libsynocredentials.so.7", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0@\20\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0755, st_size=12523, ...}) = 0 mmap(NULL, 2109696, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8732a75000 mprotect(0x7f8732a78000, 2093056, PROT_NONE) = 0 mmap(0x7f8732c77000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x7f8732c77000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libicui18n.so.64", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20T\17\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0755, st_size=2980792, ...}) = 0 mmap(NULL, 5080120, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f873259c000 mprotect(0x7f8732863000, 2097152, PROT_NONE) = 0 mmap(0x7f8732a63000, 69632, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2c7000) = 0x7f8732a63000 mmap(0x7f8732a74000, 1080, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f8732a74000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libicuuc.so.64", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 [\6\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0755, st_size=1866344, ...}) = 0 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f8733889000 mmap(NULL, 3969952, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f87321d2000 mprotect(0x7f8732387000, 2097152, PROT_NONE) = 0 mmap(0x7f8732587000, 77824, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1b5000) = 0x7f8732587000 mmap(0x7f873259a000, 5024, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f873259a000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libpthread.so.0", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 a\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0555, st_size=106120, ...}) = 0 mmap(NULL, 2217064, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8731fb4000 mprotect(0x7f8731fcd000, 2093056, PROT_NONE) = 0 mmap(0x7f87321cc000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x18000) = 0x7f87321cc000 mmap(0x7f87321ce000, 13416, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f87321ce000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libcrypt.so.1", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\v\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0555, st_size=34976, ...}) = 0 mmap(NULL, 2318848, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8731d7d000 mprotect(0x7f8731d85000, 2093056, PROT_NONE) = 0 mmap(0x7f8731f84000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x7000) = 0x7f8731f84000 mmap(0x7f8731f86000, 184832, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f8731f86000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libapparmor.so.1", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\35\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0755, st_size=52120, ...}) = 0 mmap(NULL, 2147368, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8731b70000 mprotect(0x7f8731b7c000, 2093056, PROT_NONE) = 0 mmap(0x7f8731d7b000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xb000) = 0x7f8731d7b000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libstdc++.so.6", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\235\t\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0555, st_size=1296912, ...}) = 0 mmap(NULL, 3405280, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8731830000 mprotect(0x7f8731960000, 2093056, PROT_NONE) = 0 mmap(0x7f8731b5f000, 57344, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x12f000) = 0x7f8731b5f000 mmap(0x7f8731b6d000, 9696, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f8731b6d000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libm.so.6", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0Pw\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0555, st_size=1346296, ...}) = 0 mmap(NULL, 3441432, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f87314e7000 mprotect(0x7f873162f000, 2093056, PROT_NONE) = 0 mmap(0x7f873182e000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x147000) = 0x7f873182e000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libgcc_s.so.1", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\370-\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0444, st_size=76112, ...}) = 0 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f8733887000 mmap(NULL, 2171880, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f87312d4000 mprotect(0x7f87312e5000, 2097152, PROT_NONE) = 0 mmap(0x7f87314e5000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x11000) = 0x7f87314e5000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libicudata.so.64", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0f\2\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0755, st_size=4832, ...}) = 0 mmap(NULL, 2101248, PROT_READ, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f87310d3000 mprotect(0x7f87310d4000, 2093056, PROT_NONE) = 0 mmap(0x7f87312d3000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0) = 0x7f87312d3000 close(3)                                = 0 openat(AT_FDCWD, "/lib64/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\r\0\0\0\0\0\0"..., 832) = 832 fstat(3, {st_mode=S_IFREG|0555, st_size=14608, ...}) = 0 mmap(NULL, 2109680, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f8730ecf000 mprotect(0x7f8730ed2000, 2093056, PROT_NONE) = 0 mmap(0x7f87310d1000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x7f87310d1000 close(3)                                = 0 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f8733885000 mmap(NULL, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f8733882000 arch_prctl(ARCH_SET_FS, 0x7f8733882b00) = 0 mprotect(0x7f873324e000, 16384, PROT_READ) = 0 mprotect(0x7f87310d1000, 4096, PROT_READ) = 0 mprotect(0x7f87312d3000, 4096, PROT_READ) = 0 mprotect(0x7f87314e5000, 4096, PROT_READ) = 0 mprotect(0x7f873182e000, 4096, PROT_READ) = 0 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f8733880000 mprotect(0x7f8731b5f000, 40960, PROT_READ) = 0 mprotect(0x7f87321cc000, 4096, PROT_READ) = 0 mprotect(0x7f8731d7b000, 4096, PROT_READ) = 0 mprotect(0x7f8731f84000, 4096, PROT_READ) = 0 mprotect(0x7f8732587000, 73728, PROT_READ) = 0 mprotect(0x7f8732a63000, 61440, PROT_READ) = 0 mprotect(0x7f8732c77000, 4096, PROT_READ) = 0 mprotect(0x7f8732ea4000, 4096, PROT_READ) = 0 mprotect(0x7f8733667000, 4096, PROT_READ) = 0 mprotect(0x7f8733462000, 4096, PROT_READ) = 0 mprotect(0x61e000, 4096, PROT_READ)     = 0 mprotect(0x7f873388d000, 4096, PROT_READ) = 0 set_tid_address(0x7f8733882dd0)         = 14872 set_robust_list(0x7f8733882de0, 24)     = 0 rt_sigaction(SIGRTMIN, {sa_handler=0x7f8731fb9bc0, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f8731fc5c20}, NULL, 8) = 0 rt_sigaction(SIGRT_1, {sa_handler=0x7f8731fb9c60, sa_mask=[], sa_flags=SA_RESTORER|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f8731fc5c20}, NULL, 8) = 0 rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0 prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 brk(NULL)                               = 0xf2a000 brk(0xf4b000)                           = 0xf4b000 open("/usr/lib/locale/locale-archive", O_RDONLY|O_CLOEXEC) = 3 fstat(3, {st_mode=S_IFREG|0644, st_size=14367440, ...}) = 0 mmap(NULL, 14367440, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7f873011b000 close(3)                                = 0 geteuid()                               = 1031 ioctl(0, TCGETS, {B9600 opost isig icanon echo ...}) = 0 renameat2(AT_FDCWD, "aa.txt", AT_FDCWD, "bb.txt", RENAME_NOREPLACE) = -1 EINVAL (Invalid argument) newfstatat(AT_FDCWD, "bb.txt", 0x7ffee6c16df0, AT_SYMLINK_NOFOLLOW) = -1 ENOENT (No such file or directory) renameat(AT_FDCWD, "aa.txt", AT_FDCWD, "bb.txt") = 0 lseek(0, 0, SEEK_CUR)                   = -1 ESPIPE (Illegal seek) close(0)                                = 0 close(1)                                = 0 close(2)                                = 0 exit_group(0)                           = ? +++ exited with 0 +++ **@.:/volume1/videom$ On 12 Dec 2021, 19:55 +0100, trapexit/mergerfs @.>, wrote:

strace -f mv bb.txt aa.txt

trapexit commented 2 years ago

That's on the volume you said was having an issue? This is succeeding. No errors.

marc0janssen commented 2 years ago

Yes it’s weird… the issue seems to be gone… Also on the “mergerfs mount”.

Weird sh*t is happening... On 12 Dec 2021, 19:58 +0100, trapexit @.***>, wrote:

That's on the volume you said was having an issue? This is succeeding. No errors. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe.

marc0janssen commented 2 years ago

Thanks for all your help Antonio, Sponsored you on Paypal! Great support and software!!

On 12 Dec 2021, 20:00 +0100, Marco Janssen @.***>, wrote:

Yes it’s weird… the issue seems to be gone… Also on the “mergerfs mount”.

Weird sh*t is happening... On 12 Dec 2021, 19:58 +0100, trapexit @.***>, wrote:

That's on the volume you said was having an issue? This is succeeding. No errors. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe.

trapexit commented 2 years ago

Thanks for the support. If you figure out what's going on please report back.

marc0janssen commented 2 years ago

I will! On 12 Dec 2021, 20:14 +0100, trapexit @.***>, wrote:

Thanks for the support. If you figure out what's going on please report back. — You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub, or unsubscribe.

marc0janssen commented 2 years ago

It has something to do with the incompatiblity of the Synology.

When I do the move on a "remote" Alpine linux node via a CIFS share. I get the errors.

eridu:/mnt/video# strace -f mv gg.txt cc.txt execve("/bin/mv", ["mv", "gg.txt", "cc.txt"], 0x7ffd46838c88 / 18 vars /) = 0 arch_prctl(ARCH_SET_FS, 0x7f0176957b48) = 0 set_tid_address(0x7f0176957f90) = 11974 brk(NULL) = 0x556cf6dc1000 brk(0x556cf6dc3000) = 0x556cf6dc3000 mmap(0x556cf6dc1000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x556cf6dc1000 mprotect(0x7f0176954000, 4096, PROT_READ) = 0 mprotect(0x556cf4f4a000, 16384, PROT_READ) = 0 getuid() = 0 stat("cc.txt", 0x7ffeb6a9a400) = -1 ENOENT (No such file or directory) rename("gg.txt", "cc.txt") = -1 ENOENT (No such file or directory) write(2, "mv: can't rename 'gg.txt': No su"..., 53mv: can't rename 'gg.txt': No such file or directory ) = 53 exit_group(1) = ? +++ exited with 1 +++ eridu:/mnt/video#

marc0janssen commented 2 years ago

I guess mergerfs is not compatible with Synology.

trapexit commented 2 years ago

How's that? You said the behavior happened regardless of mergerfs. I'm positive there are a number of Synology users using mergerfs quite successfully.

marc0janssen commented 2 years ago

I didn't see that correct... mixed up the shells....

Yeah probably there are Synology getting it right.. But for me it doesn't seems to work... Not with the setup in the wiki, .t least,

trapexit commented 2 years ago

I still don't follow. As you have described this has nothing at all to do with mergerfs and is instead something to do with cifs or something.

marc0janssen commented 2 years ago

My guess is => mergerfs is fine... Synology is fine.... but the combo is faulty

trapexit commented 2 years ago

Wait. You had said that it happened outside of mergerfs and have yet to provide a trace of this happening. Are you claiming it DOES happen ONLY with mergerfs? If so how is it that you can't provide a trace replicating the situation?

trapexit commented 2 years ago

I can't stress enough how important it is for you to very clearly layout exactly what you are doing, literally every little step to reproduce the situation, if you want me to help.

marc0janssen commented 2 years ago

Yes I do understand Antoino. And that is very much appreciated, hence the token of support.

As I pointed out in another post, mergerfs does something with the ACL on a synology mount point. After initiating mergerfs, the mount point is not reaching anymore from the synology gui regarding the ACL settings. Synology reports that the volume does not have ACL support.

This is a sign mergerfs is not compatible.

Also hyperbackup and configurationmanager of synology report that they "can not backup the settings" of the synology after mergerfs has started.  When you umout mergerfs, all is fine again.

And now I found the renaming issue.  My guess is there are more issues which have not surfaced yet.

Again mergerfs is fine probably, synology is fine. But the combo does not work.

Probably because synology altered Linux for. the device. On 12 Dec 2021, 22:43 +0100, trapexit @.***>, wrote:

I can't stress enough how important it is for you to very clearly layout exactly what you are doing, literally every little step to reproduce the situation, if you want me to help. — You are receiving this because you are subscribed to this thread. Reply to this email directly, view it on GitHub, or unsubscribe.

trapexit commented 2 years ago

Not having advanced ACL support should not impact regular use. Lots of filesystems have secondary ACLs and still work with standard POSIX ACLs and the symptoms you've described in this thread are not obviously related to ACLs. It's literally returning ENOENT. Not EPERM or similar. And if the issue was mergerfs then all other FUSE or union filesystems would have the same problem.

marc0janssen commented 2 years ago

It is probably the combo with synology. Maybe the setup as described Iin the wiki.

I  feel sorry I can't use mergerfs. Later I will do another strace from the alpine Linux nodes. As I failed doing it the right way. On 12 Dec 2021, 23:17 +0100, trapexit @.***>, wrote:

Not having advanced ACL support should not impact regular use. Lots of filesystems have secondary ACLs and still work with standard POSIX ACLs and the symptoms you've described in this thread are not obviously related to ACLs. It's literally returning ENOENT. Not EPERM or similar. And if the issue was mergerfs then all other FUSE or union filesystems would have the same problem. — You are receiving this because you are subscribed to this thread. Reply to this email directly, view it on GitHub, or unsubscribe.

marc0janssen commented 2 years ago

Hi Antonio, if you still feel like it... I made a new trace,,,, I am sure I did it the right way now. Log files

trapexit commented 2 years ago

Your trace of mergerfs shows 4 successful renames. Your app trace shows one failure. The timestamps indicate they were taken at minutes apart.

13110 08:55:21.977864 rename("aa.txt", "bb.txt") = -1 ENOENT (No such file or directory) <0.037236>

    Line 213: 6912  08:57:08.079775 rename("/volume2/video2/bb.txt", "/volume2/video2/aa.txt") = 0 <0.000188>
    Line 509: 6912  08:57:09.587786 rename("/volume2/video2/aa.txt", "/volume2/video2/bb.txt") = 0 <0.000166>
    Line 736: 6913  08:57:10.977639 rename("/volume2/video2/bb.txt", "/volume2/video2/aa.txt") = 0 <0.000198>
    Line 1029: 6913  08:57:12.592554 rename("/volume2/video2/aa.txt", "/volume2/video2/bb.txt") = 0 <0.000241>
marc0janssen commented 2 years ago

In the logs I sent you it saids: it ended in EXITCODE = 1

3110 08:55:21.947860 execve("/bin/mv", ["mv", "aa.txt", "bb.txt"], ["MAIL=/var/mail/root", "USER=root", "SSH_CLIENT=192.168.178.13 59101 22", "SHLVL=1", "HOME=/root", "OLDPWD=/mnt", "SSH_TTY=/dev/pts/0", "PAGER=less", "PS1=\h:\w\$ ", "LOGNAME=root", "TERM=xterm-256color", "LC_COLLATE=C", "PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin", "LANG=C.UTF-8", "SHELL=/bin/ash", "PWD=/mnt/videom", "SSH_CONNECTION=192.168.178.13 59101 192.168.178.7 22", "CHARSET=UTF-8"]) = 0 <0.000549> 13110 08:55:21.948803 arch_prctl(ARCH_SET_FS, 0x7fb46b15eb48) = 0 <0.000120> 13110 08:55:21.975269 set_tid_address(0x7fb46b15ef90) = 13110 <0.000099> 13110 08:55:21.975567 brk(NULL) = 0x56002dabe000 <0.000102> 13110 08:55:21.975835 brk(0x56002dac0000) = 0x56002dac0000 <0.000029> 13110 08:55:21.975940 mmap(0x56002dabe000, 4096, PROT_NONE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x56002dabe000 <0.000034> 13110 08:55:21.976098 mprotect(0x7fb46b15b000, 4096, PROT_READ) = 0 <0.000028> 13110 08:55:21.976341 mprotect(0x56002c201000, 16384, PROT_READ) = 0 <0.000025> 13110 08:55:21.976443 getuid() = 0 <0.000017> 13110 08:55:21.976546 stat("bb.txt", 0x7ffe89dab7d0) = -1 ENOENT (No such file or directory) <0.001175> 13110 08:55:21.977864 rename("aa.txt", "bb.txt") = -1 ENOENT (No such file or directory) <0.037236> 13110 08:55:22.015305 write(2, "mv: can't rename 'aa.txt': No such file or directory\n", 53) = 53 <0.000087> 13110 08:55:22.015606 exit_group(1) = ? 13110 08:55:22.016035 +++ exited with 1 +++

trapexit commented 2 years ago

Yes, and it clearly wasn't run during the time the trace was taken from mergerfs. 08:55:21.977864 vs 08:57:09.587786 I have no idea what the state of the system was at the time. All those errors are totally valid normally. I need full context and none has been provided.

marc0janssen commented 2 years ago

But the four “exit code == 0” gave errors in my shell On 13 Dec 2021, 15:54 +0100, trapexit @.***>, wrote:

Yes, and it clearly wasn't run during the time the trace was taken from mergerfs. 08:55:21.977864 vs 08:57:09.587786 I have no idea what the state of the system was at the time. All those errors are totally valid normally. I need full context and none has been provided. — You are receiving this because you are subscribed to this thread. Reply to this email directly, view it on GitHub, or unsubscribe.

trapexit commented 2 years ago

I don't know what to tell you if you can't provide me with the evidence of it happening and precise instructions to reproduce.

marc0janssen commented 2 years ago

I know it is difficult.. I don't how to hand it to you also... I gave all the info you asked and I have.

this is what I see on my end when the log says: exit code == 0

uruk:/mnt/video# mv bb.txt aa.txt mv: can't rename 'bb.txt': No such file or directory