Zsh Mailing List Archive
Messages sorted by: Reverse Date, Date, Thread, Author

Re: bug with eval, proc-subst and pipes



2013-07-18 12:32:10 +0100, Peter Stephenson:
[...]
> Apparently working (except for the fact it doesn't fix Stephane's
> original problem, don't know if we're any further forward with that).
> However, I'll wait in case Bart can see something I missed.
> 
> diff --git a/Src/jobs.c b/Src/jobs.c
[...]

Not better with that one (on top of the other one).

~$ eval 'ls -l <(echo 1) <(echo 2) <(echo 3) <(echo 4)' | cat
ls: cannot access /proc/self/fd/11: No such file or directory
ls: cannot access /proc/self/fd/13: No such file or directory
lr-x------ 1 chazelas chazelas 64 Jul 19 20:52 /proc/self/fd/10 -> pipe:[509333]
lr-x------ 1 chazelas chazelas 64 Jul 19 20:52 /proc/self/fd/12 -> pipe:[509335]

Though I've also seen (with one zsh invocation consistently but no other one):

~$ eval 'ls -l <(echo 1) <(echo 2) <(echo 3) <(echo 4)' | cat
ls: cannot access /proc/self/fd/11: No such file or directory
ls: cannot access /proc/self/fd/12: No such file or directory
ls: cannot access /proc/self/fd/13: No such file or directory
lr-x------ 1 chazelas chazelas 64 Jul 19 20:51 /proc/self/fd/10 -> pipe:[504591]

Attached is the strace output (for the first case).

See how fd 13 is closed in the process that execs ls and fd 11
in its parent shortly before the fork.

I verified that I can reproduce it from a fresh debootstrap of
debian sid amd64, so it should be easily reproduced from a
Debian-based system like ubuntu or ubuntu live CD.

Procedure:

sudo debootstrap --arch amd64 sid debian http://ftp.uk.debian.org/debian
cd debian
sudo mount --bind /dev dev
sudo mount -t proc p proc
sudo mount -t sysfs s sys
sudo mount -t devpts d dev/pts
chroot . bash
apt-get install zsh
zsh
autoload compinit
compinit
eval 'ls -l <(echo 1) <(echo 2) <(echo 3) <(echo 4)' | cat

From the config.status of the debian package build:

ac_cs_config="'--build=x86_64-linux-gnu' '--includedir=\${prefix}/include' '--mandir=\${prefix}/share/man' '--infodir=\${prefix}/share/info' '--sysconfdir=/etc' '--localstatedir=/var' '--libdir=\${prefix}/lib/x86_64-linux-gnu' '--libexecdir=\${prefix}/lib/x86_64-linux-gnu' '--disable-maintainer-mode' '--disable-dependency-tracking' '--prefix=/usr' '--mandir=/usr/share/man' '--bindir=/bin' 'LDFLAGS=-Wl,--as-needed -g -Wl,-z,relro' '--infodir=/usr/share/info' '--enable-maildir-support' '--enable-max-jobtable-size=256' '--enable-etcdir=/etc/zsh' '--enable-function-subdirs' '--enable-site-fndir=/usr/local/share/zsh/site-functions' '--enable-fndir=/usr/share/zsh/functions' '--with-tcsetpgrp' '--with-term-lib=ncursesw tinfo' '--enable-cap' '--enable-pcre' '--enable-readnullcmd=pager' '--enable-custom-patchlevel=Debian' '--enable-additional-fpath=/usr/share/zsh/vendor-functions,/usr/share/zsh/vendor-completions' 'build_alias=x86_64-linux-gnu' 'CFLAGS=-g -O2 -fstack-protector --param=ssp-buffer-size=4 -Wformat -Werror=format-security -Wall -g' 'CPPFLAGS=-D_FORTIFY_SOURCE=2'"

-- 
Stephane
8713  20:20:27.164587 read(10, "\n", 1) = 1
8713  20:20:28.250709 fcntl(0, F_DUPFD, 10) = 11
8713  20:20:28.250958 close(0)          = 0
8713  20:20:28.251208 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:28.251431 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:28.251555 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:28.251665 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:28.251775 write(1, "\33[?1l\33>", 7) = 7
8713  20:20:28.251890 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:28.251940 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:28.252006 dup2(11, 0)       = 0
8713  20:20:28.252045 close(11)         = 0
8713  20:20:28.252090 write(10, "\33[K", 3) = 3
8713  20:20:28.252170 write(10, "\r\n", 2) = 2
8713  20:20:28.252217 alarm(0)          = 0
8713  20:20:28.252345 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig -icanon -echo ...}) = 0
8713  20:20:28.252401 ioctl(10, SNDCTL_TMR_STOP or TCSETSW, {B38400 opost isig icanon echo ...}) = 0
8713  20:20:28.252489 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig icanon echo ...}) = 0
8713  20:20:28.252545 munmap(0x7fccc6374000, 16384) = 0
8713  20:20:28.252595 ioctl(10, TIOCSPGRP, [8713]) = 0
8713  20:20:28.252643 fstat(0, {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 5), ...}) = 0
8713  20:20:28.252700 fcntl(0, F_GETFL) = 0x8002 (flags O_RDWR|O_LARGEFILE)
8713  20:20:28.252747 mmap(NULL, 16384, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fccc6374000
8713  20:20:28.252803 geteuid()         = 1000
8713  20:20:28.252847 capget(0x20080522, 0, NULL) = 0
8713  20:20:28.252894 capget(0x20080522, 0, {0, 0, 0}) = 0
8713  20:20:28.252948 write(10, "\33[1m\33[3m%\33[23m\33[1m\33[0m          "..., 215) = 215
8713  20:20:28.253043 rt_sigaction(SIGINT, {0x473a00, [], SA_RESTORER|SA_INTERRUPT, 0x34e1435260}, NULL, 8) = 0
8713  20:20:28.253105 rt_sigaction(SIGINT, {0x473a00, [], SA_RESTORER|SA_INTERRUPT, 0x34e1435260}, NULL, 8) = 0
8713  20:20:28.253235 geteuid()         = 1000
8713  20:20:28.253313 stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=3661, ...}) = 0
8713  20:20:28.253407 ioctl(10, FIONREAD, [0]) = 0
8713  20:20:28.253468 ioctl(10, TIOCSPGRP, [8713]) = 0
8713  20:20:28.253515 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig icanon echo ...}) = 0
8713  20:20:28.253563 ioctl(10, SNDCTL_TMR_STOP or TCSETSW, {B38400 opost isig -icanon -echo ...}) = 0
8713  20:20:28.253614 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig -icanon -echo ...}) = 0
8713  20:20:28.253662 write(10, "\r\33[0m\33[23m\33[24m\33[J\33[3m1\33[23m~$ ", 31) = 31
8713  20:20:28.253715 write(10, "\33[K\33[181C20:20\33[3m\33[23m\33[186D", 29) = 29
8713  20:20:28.253784 fcntl(0, F_DUPFD, 10) = 11
8713  20:20:28.253832 close(0)          = 0
8713  20:20:28.253893 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:28.253953 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:28.254004 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:28.254055 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:28.254117 write(1, "\33[?1h\33=", 7) = 7
8713  20:20:28.254172 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:28.254223 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:28.254295 dup2(11, 0)       = 0
8713  20:20:28.254343 close(11)         = 0
8713  20:20:28.254391 read(10, "e", 1)  = 1
8713  20:20:32.498719 write(10, "e", 1) = 1
8713  20:20:32.498984 read(10, "v", 1)  = 1
8713  20:20:32.690584 write(10, "\10ev", 3) = 3
8713  20:20:32.690850 read(10, "\33", 1) = 1
8713  20:20:33.226092 read(10, "p", 1)  = 1
8713  20:20:33.226235 write(10, "al 'ls -l <(echo 1) <(echo 2) <("..., 56) = 56
8713  20:20:33.226325 read(10, "\n", 1) = 1
8713  20:20:37.314618 fcntl(0, F_DUPFD, 10) = 11
8713  20:20:37.314875 close(0)          = 0
8713  20:20:37.315248 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:37.315591 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.315819 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.316015 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:37.316227 write(1, "\33[?1l\33>", 7) = 7
8713  20:20:37.316364 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.316457 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.316579 dup2(11, 0)       = 0
8713  20:20:37.316659 close(11)         = 0
8713  20:20:37.316756 write(10, "\33[K", 3) = 3
8713  20:20:37.316856 write(10, "\r\n", 2) = 2
8713  20:20:37.317066 alarm(0)          = 0
8713  20:20:37.317419 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig -icanon -echo ...}) = 0
8713  20:20:37.317651 ioctl(10, SNDCTL_TMR_STOP or TCSETSW, {B38400 opost isig icanon echo ...}) = 0
8713  20:20:37.317829 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig icanon echo ...}) = 0
8713  20:20:37.317937 symlink("/pid-8713/host-sc", "/home/chazelas/.zsh-history.5.0.2.LOCK") = 0
8713  20:20:37.318063 open("/home/chazelas/.zsh-history.5.0.2", O_WRONLY|O_CREAT|O_NOCTTY|O_APPEND, 0600) = 3
8713  20:20:37.318145 fcntl(3, F_GETFL) = 0x8401 (flags O_WRONLY|O_APPEND|O_LARGEFILE)
8713  20:20:37.318213 fstat(3, {st_mode=S_IFREG|0600, st_size=334450, ...}) = 0
8713  20:20:37.318327 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fccc72c4000
8713  20:20:37.318401 lseek(3, 0, SEEK_CUR) = 0
8713  20:20:37.318468 write(3, "eval 'ls -l <(echo 1) <(echo 2) "..., 59) = 59
8713  20:20:37.318556 fstat(3, {st_mode=S_IFREG|0600, st_size=334509, ...}) = 0
8713  20:20:37.318645 close(3)          = 0
8713  20:20:37.318711 munmap(0x7fccc72c4000, 4096) = 0
8713  20:20:37.318783 unlink("/home/chazelas/.zsh-history.5.0.2.LOCK") = 0
8713  20:20:37.318918 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:37.318987 pipe([3, 4])      = 0
8713  20:20:37.319057 fcntl(3, F_DUPFD, 10) = 11
8713  20:20:37.319109 close(3)          = 0
8713  20:20:37.319160 fcntl(4, F_DUPFD, 10) = 12
8713  20:20:37.319210 close(4)          = 0
8713  20:20:37.319272 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.319336 pipe([3, 4])      = 0
8713  20:20:37.319408 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fccc72bf9d0) = 18103
8713  20:20:37.319779 close(4 <unfinished ...>
18103 20:20:37.319833 close(3 <unfinished ...>
8713  20:20:37.319855 <... close resumed> ) = 0
18103 20:20:37.319874 <... close resumed> ) = 0
18103 20:20:37.319926 setpgid(0, 18103 <unfinished ...>
8713  20:20:37.319950 read(3,  <unfinished ...>
18103 20:20:37.319969 <... setpgid resumed> ) = 0
18103 20:20:37.320051 ioctl(10, TIOCSPGRP, [18103]) = 0
18103 20:20:37.320150 rt_sigaction(SIGTTOU, {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, {SIG_IGN, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.320264 rt_sigaction(SIGTTIN, {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260}, {SIG_IGN, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.320370 rt_sigaction(SIGTSTP, {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260}, {SIG_IGN, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.320487 rt_sigaction(SIGTERM, {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, {SIG_IGN, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.320603 rt_sigaction(SIGINT, {SIG_DFL, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260}, {0x473a00, [], SA_RESTORER|SA_INTERRUPT, 0x34e1435260}, 8) = 0
18103 20:20:37.320719 rt_sigaction(SIGQUIT, {SIG_DFL, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260}, {SIG_IGN, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.320871 getrusage(RUSAGE_CHILDREN, {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18103 20:20:37.320973 close(4)          = 0
8713  20:20:37.321054 <... read resumed> "", 1) = 0
18103 20:20:37.321166 dup2(12, 1 <unfinished ...>
8713  20:20:37.321190 close(3 <unfinished ...>
18103 20:20:37.321210 <... dup2 resumed> ) = 1
18103 20:20:37.321281 close(12 <unfinished ...>
8713  20:20:37.321303 <... close resumed> ) = 0
18103 20:20:37.321324 <... close resumed> ) = 0
18103 20:20:37.321374 close(10 <unfinished ...>
8713  20:20:37.321410 close(12 <unfinished ...>
18103 20:20:37.321429 <... close resumed> ) = 0
18103 20:20:37.321499 close(11 <unfinished ...>
8713  20:20:37.321519 <... close resumed> ) = 0
18103 20:20:37.321538 <... close resumed> ) = 0
18103 20:20:37.321592 close(13 <unfinished ...>
8713  20:20:37.321650 access("/bin/cat", X_OK) = 0
18103 20:20:37.321750 <... close resumed> ) = 0
8713  20:20:37.321775 stat("/bin/cat", {st_mode=S_IFREG|0755, st_size=58800, ...}) = 0
8713  20:20:37.321885 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18103 20:20:37.321932 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
8713  20:20:37.321958 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18103 20:20:37.321983 <... rt_sigprocmask resumed> [CHLD], 8) = 0
8713  20:20:37.322008 pipe( <unfinished ...>
18103 20:20:37.322047 pipe( <unfinished ...>
8713  20:20:37.322068 <... pipe resumed> [3, 4]) = 0
18103 20:20:37.322090 <... pipe resumed> [3, 4]) = 0
8713  20:20:37.322117 clone( <unfinished ...>
18103 20:20:37.322137 fcntl(3, F_DUPFD, 10) = 10
18103 20:20:37.322204 close(3)          = 0
18103 20:20:37.322280 fcntl(4, F_DUPFD, 10) = 11
8713  20:20:37.322350 <... clone resumed> child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fccc72bf9d0) = 18104
18103 20:20:37.322382 close(4 <unfinished ...>
8713  20:20:37.322404 close(4 <unfinished ...>
18104 20:20:37.322424 close(3 <unfinished ...>
18103 20:20:37.322442 <... close resumed> ) = 0
18104 20:20:37.322461 <... close resumed> ) = 0
18103 20:20:37.322484 clone( <unfinished ...>
18104 20:20:37.322504 setpgid(0, 18103 <unfinished ...>
8713  20:20:37.322523 <... close resumed> ) = 0
18104 20:20:37.322542 <... setpgid resumed> ) = 0
8713  20:20:37.322563 read(3,  <unfinished ...>
18104 20:20:37.322583 kill(4294949193, SIG_0) = 0
18104 20:20:37.322659 rt_sigaction(SIGTTOU, {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, {SIG_IGN, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.322776 <... clone resumed> child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fccc72bf9d0) = 18105
18104 20:20:37.322805 rt_sigaction(SIGTTIN, {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18105 20:20:37.322848 rt_sigaction(SIGINT, {SIG_IGN, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.322886 <... rt_sigaction resumed> {SIG_IGN, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18105 20:20:37.322924 <... rt_sigaction resumed> {SIG_DFL, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.322964 rt_sigaction(SIGTSTP, {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18105 20:20:37.323005 rt_sigaction(SIGQUIT, {SIG_IGN, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.323042 <... rt_sigaction resumed> {SIG_IGN, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18105 20:20:37.323079 <... rt_sigaction resumed> {SIG_DFL, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.323119 rt_sigaction(SIGTERM, {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18105 20:20:37.323158 ioctl(0, SNDCTL_TMR_TIMEBASE or TCGETS <unfinished ...>
18104 20:20:37.323178 <... rt_sigaction resumed> {SIG_IGN, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18105 20:20:37.323215 <... ioctl resumed> , {B38400 opost isig icanon echo ...}) = 0
18104 20:20:37.323246 rt_sigaction(SIGINT, {SIG_DFL, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18105 20:20:37.323285 close(0 <unfinished ...>
18104 20:20:37.323303 <... rt_sigaction resumed> {0x473a00, [], SA_RESTORER|SA_INTERRUPT, 0x34e1435260}, 8) = 0
18105 20:20:37.323340 <... close resumed> ) = 0
18104 20:20:37.323362 rt_sigaction(SIGQUIT, {SIG_DFL, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18105 20:20:37.323401 open("/dev/null", O_RDWR|O_NOCTTY <unfinished ...>
18104 20:20:37.323427 <... rt_sigaction resumed> {SIG_IGN, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18105 20:20:37.323476 <... open resumed> ) = 0
18103 20:20:37.323498 close(11 <unfinished ...>
18105 20:20:37.323519 rt_sigaction(SIGTTOU, {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.323558 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18105 20:20:37.323577 <... rt_sigaction resumed> {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.323614 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18105 20:20:37.323659 rt_sigaction(SIGTTIN, {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.323696 close(4 <unfinished ...>
18105 20:20:37.323714 <... rt_sigaction resumed> {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.323752 <... close resumed> ) = 0
18105 20:20:37.323773 rt_sigaction(SIGTSTP, {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.323811 dup2(11, 0 <unfinished ...>
18105 20:20:37.323829 <... rt_sigaction resumed> {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.323866 <... dup2 resumed> ) = 0
18105 20:20:37.323888 rt_sigaction(SIGTERM, {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.323925 close(11 <unfinished ...>
18105 20:20:37.323943 <... rt_sigaction resumed> {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.323980 <... close resumed> ) = 0
18103 20:20:37.323999 <... close resumed> ) = 0
18105 20:20:37.324019 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18104 20:20:37.324039 close(10 <unfinished ...>
18105 20:20:37.324057 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18104 20:20:37.324098 <... close resumed> ) = 0
18105 20:20:37.324119 dup2(11, 1 <unfinished ...>
18104 20:20:37.324138 close(13 <unfinished ...>
18105 20:20:37.324156 <... dup2 resumed> ) = 1
18104 20:20:37.324174 <... close resumed> ) = 0
18105 20:20:37.324194 close(11 <unfinished ...>
18103 20:20:37.324213 pipe( <unfinished ...>
18105 20:20:37.324231 <... close resumed> ) = 0
18104 20:20:37.324252 rt_sigprocmask(SIG_UNBLOCK, [CHLD],  <unfinished ...>
18105 20:20:37.324277 close(10 <unfinished ...>
18104 20:20:37.324295 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18105 20:20:37.324318 <... close resumed> ) = 0
18103 20:20:37.324337 <... pipe resumed> [3, 4]) = 0
8713  20:20:37.324359 <... read resumed> "", 1) = 0
18105 20:20:37.324383 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18104 20:20:37.324408 close(13 <unfinished ...>
18105 20:20:37.324426 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18104 20:20:37.324449 <... close resumed> ) = -1 EBADF (Bad file descriptor)
18103 20:20:37.324482 fcntl(3, F_DUPFD, 10 <unfinished ...>
18104 20:20:37.324505 execve("/bin/cat", ["cat"], [/* 39 vars */] <unfinished ...>
18105 20:20:37.324576 write(1, "1\n", 2 <unfinished ...>
18103 20:20:37.324599 <... fcntl resumed> ) = 11
18105 20:20:37.324618 <... write resumed> ) = 2
18103 20:20:37.324639 close(3 <unfinished ...>
18105 20:20:37.324661 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18103 20:20:37.324686 <... close resumed> ) = 0
18105 20:20:37.324705 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18103 20:20:37.324733 fcntl(4, F_DUPFD, 10 <unfinished ...>
18105 20:20:37.324756 rt_sigprocmask(SIG_UNBLOCK, [CHLD],  <unfinished ...>
18103 20:20:37.324780 <... fcntl resumed> ) = 12
18105 20:20:37.324799 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18103 20:20:37.324825 close(4 <unfinished ...>
18105 20:20:37.324845 close(1 <unfinished ...>
18104 20:20:37.324865 <... execve resumed> ) = 0
18105 20:20:37.324883 <... close resumed> ) = 0
18105 20:20:37.324912 exit_group(0)     = ?
18104 20:20:37.324954 brk(0 <unfinished ...>
18103 20:20:37.324976 <... close resumed> ) = 0
18104 20:20:37.324995 <... brk resumed> ) = 0x1547000
18103 20:20:37.325019 clone( <unfinished ...>
8713  20:20:37.325039 close(3 <unfinished ...>
18104 20:20:37.325060 access("/etc/ld.so.nohwcap", F_OK <unfinished ...>
8713  20:20:37.325088 <... close resumed> ) = 0
18104 20:20:37.325118 <... access resumed> ) = -1 ENOENT (No such file or directory)
8713  20:20:37.325143 close(11 <unfinished ...>
18104 20:20:37.325167 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
8713  20:20:37.325189 <... close resumed> ) = 0
18104 20:20:37.325208 <... mmap resumed> ) = 0x7ff9a72c4000
18103 20:20:37.325264 <... clone resumed> child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fccc72bf9d0) = 18106
18104 20:20:37.325292 access("/etc/ld.so.preload", R_OK <unfinished ...>
18106 20:20:37.325323 rt_sigaction(SIGINT, {SIG_IGN, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.325362 <... access resumed> ) = -1 ENOENT (No such file or directory)
18106 20:20:37.325383 <... rt_sigaction resumed> {SIG_DFL, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.325423 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC <unfinished ...>
18106 20:20:37.325451 rt_sigaction(SIGQUIT, {SIG_IGN, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.325488 <... open resumed> ) = 3
18106 20:20:37.325507 <... rt_sigaction resumed> {SIG_DFL, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.325546 fstat(3,  <unfinished ...>
18106 20:20:37.325566 ioctl(0, SNDCTL_TMR_TIMEBASE or TCGETS <unfinished ...>
18104 20:20:37.325586 <... fstat resumed> {st_mode=S_IFREG|0644, st_size=239015, ...}) = 0
18106 20:20:37.325630 <... ioctl resumed> , {B38400 opost isig icanon echo ...}) = 0
18104 20:20:37.325663 mmap(NULL, 239015, PROT_READ, MAP_PRIVATE, 3, 0 <unfinished ...>
18106 20:20:37.325685 close(0 <unfinished ...>
18104 20:20:37.325703 <... mmap resumed> ) = 0x7ff9a7289000
18106 20:20:37.325722 <... close resumed> ) = 0
18104 20:20:37.325741 close(3 <unfinished ...>
18106 20:20:37.325762 open("/dev/null", O_RDWR|O_NOCTTY <unfinished ...>
18104 20:20:37.325787 <... close resumed> ) = 0
18106 20:20:37.325806 <... open resumed> ) = 0
18104 20:20:37.325827 access("/etc/ld.so.nohwcap", F_OK <unfinished ...>
18106 20:20:37.325855 rt_sigaction(SIGTTOU, {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.325891 <... access resumed> ) = -1 ENOENT (No such file or directory)
18106 20:20:37.325912 <... rt_sigaction resumed> {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.325953 open("/lib/x86_64-linux-gnu/libc.so.6", O_RDONLY|O_CLOEXEC <unfinished ...>
18106 20:20:37.325984 rt_sigaction(SIGTTIN, {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.326021 <... open resumed> ) = 3
18106 20:20:37.326040 <... rt_sigaction resumed> {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.326080 read(3,  <unfinished ...>
18106 20:20:37.326102 rt_sigaction(SIGTSTP, {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.326138 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\32B\3414\0\0\0"..., 832) = 832
18106 20:20:37.326173 <... rt_sigaction resumed> {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.326213 fstat(3,  <unfinished ...>
18106 20:20:37.326247 rt_sigaction(SIGTERM, {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.326288 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=1740224, ...}) = 0
18106 20:20:37.326333 <... rt_sigaction resumed> {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.326375 mmap(0x34e1400000, 3849280, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0 <unfinished ...>
18106 20:20:37.326400 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18104 20:20:37.326418 <... mmap resumed> ) = 0x34e1400000
18106 20:20:37.326437 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18104 20:20:37.326482 mprotect(0x34e15a2000, 2097152, PROT_NONE <unfinished ...>
18106 20:20:37.326503 dup2(12, 1 <unfinished ...>
18104 20:20:37.326521 <... mprotect resumed> ) = 0
18106 20:20:37.326540 <... dup2 resumed> ) = 1
18104 20:20:37.326572 mmap(0x34e17a2000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1a2000 <unfinished ...>
18106 20:20:37.326596 close(12 <unfinished ...>
18104 20:20:37.326615 <... mmap resumed> ) = 0x34e17a2000
18106 20:20:37.326633 <... close resumed> ) = 0
18104 20:20:37.326656 mmap(0x34e17a8000, 15424, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
18106 20:20:37.326678 close(10 <unfinished ...>
18104 20:20:37.326696 <... mmap resumed> ) = 0x34e17a8000
18106 20:20:37.326715 <... close resumed> ) = 0
18104 20:20:37.326734 close(3 <unfinished ...>
18106 20:20:37.326754 close(11 <unfinished ...>
18104 20:20:37.326772 <... close resumed> ) = 0
18106 20:20:37.326790 <... close resumed> ) = 0
18103 20:20:37.326810 close(12 <unfinished ...>
18104 20:20:37.326834 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
18106 20:20:37.326858 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18104 20:20:37.326975 <... mmap resumed> ) = 0x7ff9a7288000
18106 20:20:37.326997 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18104 20:20:37.327025 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
18103 20:20:37.327047 <... close resumed> ) = 0
18104 20:20:37.327066 <... mmap resumed> ) = 0x7ff9a7287000
8713  20:20:37.327089 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18106 20:20:37.327115 write(1, "2\n", 2 <unfinished ...>
18104 20:20:37.327141 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
18106 20:20:37.327162 <... write resumed> ) = 2
18104 20:20:37.327180 <... mmap resumed> ) = 0x7ff9a7286000
18106 20:20:37.327202 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18104 20:20:37.327227 arch_prctl(ARCH_SET_FS, 0x7ff9a7287700 <unfinished ...>
18106 20:20:37.327250 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18104 20:20:37.327275 <... arch_prctl resumed> ) = 0
18106 20:20:37.327296 rt_sigprocmask(SIG_UNBLOCK, [CHLD],  <unfinished ...>
18103 20:20:37.327321 pipe( <unfinished ...>
18106 20:20:37.327339 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18104 20:20:37.327365 mprotect(0x60b000, 4096, PROT_READ <unfinished ...>
18106 20:20:37.327385 close(1 <unfinished ...>
18104 20:20:37.327403 <... mprotect resumed> ) = 0
18106 20:20:37.327422 <... close resumed> ) = 0
18104 20:20:37.327442 mprotect(0x34e17a2000, 16384, PROT_READ <unfinished ...>
18106 20:20:37.327462 exit_group(0)     = ?
18104 20:20:37.327503 <... mprotect resumed> ) = 0
18103 20:20:37.327524 <... pipe resumed> [3, 4]) = 0
8713  20:20:37.327548 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18103 20:20:37.327591 fcntl(3, F_DUPFD, 10 <unfinished ...>
18104 20:20:37.327631 mprotect(0x34e1221000, 4096, PROT_READ <unfinished ...>
18103 20:20:37.327654 <... fcntl resumed> ) = 12
18104 20:20:37.327674 <... mprotect resumed> ) = 0
18103 20:20:37.327694 close(3 <unfinished ...>
18104 20:20:37.327714 munmap(0x7ff9a7289000, 239015 <unfinished ...>
18103 20:20:37.327733 <... close resumed> ) = 0
18104 20:20:37.327752 <... munmap resumed> ) = 0
18103 20:20:37.327774 fcntl(4, F_DUPFD, 10 <unfinished ...>
8713  20:20:37.327795 rt_sigsuspend([INT] <unfinished ...>
18103 20:20:37.327821 <... fcntl resumed> ) = 13
18103 20:20:37.327854 close(4)          = 0
18103 20:20:37.327915 clone( <unfinished ...>
18104 20:20:37.327938 brk(0)            = 0x1547000
18104 20:20:37.327997 brk(0x1568000)    = 0x1568000
18104 20:20:37.328075 open("/usr/lib/locale/locale-archive", O_RDONLY|O_CLOEXEC <unfinished ...>
18103 20:20:37.328143 <... clone resumed> child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fccc72bf9d0) = 18107
18104 20:20:37.328175 <... open resumed> ) = 3
18104 20:20:37.328206 fstat(3,  <unfinished ...>
18103 20:20:37.328228 close(13 <unfinished ...>
18107 20:20:37.328250 rt_sigaction(SIGINT, {SIG_IGN, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.328291 <... fstat resumed> {st_mode=S_IFREG|0644, st_size=2117296, ...}) = 0
18107 20:20:37.328348 <... rt_sigaction resumed> {SIG_DFL, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.328392 mmap(NULL, 2117296, PROT_READ, MAP_PRIVATE, 3, 0 <unfinished ...>
18107 20:20:37.328417 rt_sigaction(SIGQUIT, {SIG_IGN, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.328454 <... mmap resumed> ) = 0x7ff9a7081000
18107 20:20:37.328473 <... rt_sigaction resumed> {SIG_DFL, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.328512 close(3 <unfinished ...>
18107 20:20:37.328533 ioctl(0, SNDCTL_TMR_TIMEBASE or TCGETS <unfinished ...>
18104 20:20:37.328554 <... close resumed> ) = 0
18107 20:20:37.328573 <... ioctl resumed> , {B38400 opost isig icanon echo ...}) = 0
18103 20:20:37.328601 <... close resumed> ) = 0
18107 20:20:37.328621 close(0 <unfinished ...>
18104 20:20:37.328641 fstat(1,  <unfinished ...>
18107 20:20:37.328659 <... close resumed> ) = 0
18104 20:20:37.328678 <... fstat resumed> {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 5), ...}) = 0
18107 20:20:37.328725 open("/dev/null", O_RDWR|O_NOCTTY <unfinished ...>
18104 20:20:37.328752 fstat(0,  <unfinished ...>
18107 20:20:37.328771 <... open resumed> ) = 0
18104 20:20:37.328790 <... fstat resumed> {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
18107 20:20:37.328835 rt_sigaction(SIGTTOU, {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.328876 fadvise64(0, 0, 0, POSIX_FADV_SEQUENTIAL <unfinished ...>
18107 20:20:37.328896 <... rt_sigaction resumed> {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18104 20:20:37.328934 <... fadvise64 resumed> ) = -1 ESPIPE (Illegal seek)
18107 20:20:37.328958 rt_sigaction(SIGTTIN, {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18104 20:20:37.328997 read(0,  <unfinished ...>
18107 20:20:37.329016 <... rt_sigaction resumed> {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.329054 pipe( <unfinished ...>
18107 20:20:37.329076 rt_sigaction(SIGTSTP, {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18103 20:20:37.329113 <... pipe resumed> [3, 4]) = 0
18107 20:20:37.329135 <... rt_sigaction resumed> {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.329175 fcntl(3, F_DUPFD, 10 <unfinished ...>
18107 20:20:37.329197 rt_sigaction(SIGTERM, {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18103 20:20:37.329235 <... fcntl resumed> ) = 13
18107 20:20:37.329254 <... rt_sigaction resumed> {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.329292 close(3 <unfinished ...>
18107 20:20:37.329329 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18103 20:20:37.329350 <... close resumed> ) = 0
18107 20:20:37.329369 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18103 20:20:37.329414 fcntl(4, F_DUPFD, 10 <unfinished ...>
18107 20:20:37.329435 dup2(13, 1 <unfinished ...>
18103 20:20:37.329453 <... fcntl resumed> ) = 14
18107 20:20:37.329472 <... dup2 resumed> ) = 1
18103 20:20:37.329492 close(4 <unfinished ...>
18107 20:20:37.329512 close(13 <unfinished ...>
18103 20:20:37.329530 <... close resumed> ) = 0
18107 20:20:37.329548 <... close resumed> ) = 0
18103 20:20:37.329571 clone( <unfinished ...>
18107 20:20:37.329590 close(10)         = 0
18107 20:20:37.329653 close(11)         = 0
18107 20:20:37.329719 close(12)         = 0
18103 20:20:37.329785 <... clone resumed> child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fccc72bf9d0) = 18108
18107 20:20:37.329820 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18103 20:20:37.329849 close(14 <unfinished ...>
18107 20:20:37.329868 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18108 20:20:37.329895 rt_sigaction(SIGINT, {SIG_IGN, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18103 20:20:37.329933 <... close resumed> ) = 0
18108 20:20:37.329952 <... rt_sigaction resumed> {SIG_DFL, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18107 20:20:37.330002 write(1, "3\n", 2 <unfinished ...>
18108 20:20:37.330029 rt_sigaction(SIGQUIT, {SIG_IGN, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18107 20:20:37.330066 <... write resumed> ) = 2
18108 20:20:37.330085 <... rt_sigaction resumed> {SIG_DFL, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18107 20:20:37.330126 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18108 20:20:37.330152 ioctl(0, SNDCTL_TMR_TIMEBASE or TCGETS <unfinished ...>
18107 20:20:37.330173 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18108 20:20:37.330197 <... ioctl resumed> , {B38400 opost isig icanon echo ...}) = 0
18107 20:20:37.330252 rt_sigprocmask(SIG_UNBLOCK, [CHLD],  <unfinished ...>
18108 20:20:37.330284 close(0 <unfinished ...>
18107 20:20:37.330303 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18108 20:20:37.330327 <... close resumed> ) = 0
18107 20:20:37.330347 close(1 <unfinished ...>
18108 20:20:37.330369 open("/dev/null", O_RDWR|O_NOCTTY <unfinished ...>
18107 20:20:37.330395 <... close resumed> ) = 0
18108 20:20:37.330414 <... open resumed> ) = 0
18107 20:20:37.330434 exit_group(0)     = ?
18108 20:20:37.330476 rt_sigaction(SIGTTOU, {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18103 20:20:37.330517 close(11)         = 0
18103 20:20:37.330658 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18108 20:20:37.330688 <... rt_sigaction resumed> {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.330727 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18108 20:20:37.330754 rt_sigaction(SIGTTIN, {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18103 20:20:37.330794 ioctl(1, SNDCTL_TMR_TIMEBASE or TCGETS <unfinished ...>
18108 20:20:37.330814 <... rt_sigaction resumed> {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.330851 <... ioctl resumed> , 0x7fffbe693020) = -1 ENOTTY (Inappropriate ioctl for device)
18108 20:20:37.330880 rt_sigaction(SIGTSTP, {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18103 20:20:37.330921 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18108 20:20:37.330944 <... rt_sigaction resumed> {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.330982 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18108 20:20:37.331011 rt_sigaction(SIGTERM, {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18103 20:20:37.331093 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18108 20:20:37.331120 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18103 20:20:37.331139 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18108 20:20:37.331163 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18103 20:20:37.331206 pipe( <unfinished ...>
18108 20:20:37.331226 dup2(14, 1 <unfinished ...>
18103 20:20:37.331245 <... pipe resumed> [3, 4]) = 0
18108 20:20:37.331267 <... dup2 resumed> ) = 1
18103 20:20:37.331291 clone( <unfinished ...>
18108 20:20:37.331310 close(14)         = 0
18108 20:20:37.331380 close(10)         = 0
18108 20:20:37.331449 close(11 <unfinished ...>
18103 20:20:37.331501 <... clone resumed> child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7fccc72bf9d0) = 18109
18108 20:20:37.331532 <... close resumed> ) = 0
18103 20:20:37.331553 close(4 <unfinished ...>
18109 20:20:37.331573 close(3 <unfinished ...>
18108 20:20:37.331592 close(12 <unfinished ...>
18109 20:20:37.331610 <... close resumed> ) = 0
18108 20:20:37.331629 <... close resumed> ) = 0
18109 20:20:37.331651 rt_sigaction(SIGTTOU, {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18108 20:20:37.331691 close(13 <unfinished ...>
18109 20:20:37.331710 <... rt_sigaction resumed> {SIG_DFL, [TTOU], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18108 20:20:37.331747 <... close resumed> ) = 0
18109 20:20:37.331769 rt_sigaction(SIGTTIN, {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18108 20:20:37.331808 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18109 20:20:37.331842 <... rt_sigaction resumed> {SIG_DFL, [TTIN], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18108 20:20:37.331881 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18109 20:20:37.331908 rt_sigaction(SIGTSTP, {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18103 20:20:37.331945 <... close resumed> ) = 0
18109 20:20:37.331964 <... rt_sigaction resumed> {SIG_DFL, [TSTP], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18108 20:20:37.332005 write(1, "4\n", 2 <unfinished ...>
18109 20:20:37.332030 rt_sigaction(SIGTERM, {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18108 20:20:37.332066 <... write resumed> ) = 2
18109 20:20:37.332085 <... rt_sigaction resumed> {SIG_DFL, [TERM], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18108 20:20:37.332125 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18109 20:20:37.332152 rt_sigaction(SIGINT, {SIG_DFL, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18108 20:20:37.332188 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18109 20:20:37.332212 <... rt_sigaction resumed> {SIG_DFL, [INT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18108 20:20:37.332252 rt_sigprocmask(SIG_UNBLOCK, [CHLD],  <unfinished ...>
18109 20:20:37.332278 rt_sigaction(SIGQUIT, {SIG_DFL, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260},  <unfinished ...>
18108 20:20:37.332315 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18109 20:20:37.332338 <... rt_sigaction resumed> {SIG_DFL, [QUIT], SA_RESTORER|SA_RESTART, 0x34e1435260}, 8) = 0
18108 20:20:37.332377 close(1 <unfinished ...>
18103 20:20:37.332398 read(3,  <unfinished ...>
18109 20:20:37.332418 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18108 20:20:37.332436 <... close resumed> ) = 0
18109 20:20:37.332455 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18108 20:20:37.332498 exit_group(0)     = ?
18109 20:20:37.332539 close(4)          = 0
18103 20:20:37.332599 <... read resumed> "", 1) = 0
18103 20:20:37.332646 close(3 <unfinished ...>
18109 20:20:37.332671 rt_sigprocmask(SIG_UNBLOCK, [CHLD],  <unfinished ...>
18103 20:20:37.332698 <... close resumed> ) = 0
18109 20:20:37.332717 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18103 20:20:37.332757 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
18109 20:20:37.332821 close(13 <unfinished ...>
18103 20:20:37.332843 rt_sigsuspend([INT] <unfinished ...>
18109 20:20:37.332866 <... close resumed> ) = 0
18103 20:20:37.332886 <... rt_sigsuspend resumed> ) = ? ERESTARTNOHAND (To be restarted)
18109 20:20:37.332907 execve("/bin/ls", ["ls", "-l", "/proc/self/fd/10", "/proc/self/fd/11", "/proc/self/fd/12", "/proc/self/fd/13"], [/* 39 vars */] <unfinished ...>
18103 20:20:37.332998 --- SIGCHLD (Child exited) @ 0 (0) ---
18103 20:20:37.333039 rt_sigprocmask(SIG_BLOCK, ~[RTMIN RT_1], [INT CHLD], 8) = 0
18103 20:20:37.333127 rt_sigprocmask(SIG_SETMASK, [INT CHLD], ~[KILL STOP RTMIN RT_1], 8) = 0
18103 20:20:37.333219 wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG|WSTOPPED|WCONTINUED, {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 18105
18109 20:20:37.333311 <... execve resumed> ) = 0
18103 20:20:37.333333 getrusage(RUSAGE_CHILDREN, {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18109 20:20:37.333408 brk(0 <unfinished ...>
18103 20:20:37.333431 wait4(-1,  <unfinished ...>
18109 20:20:37.333449 <... brk resumed> ) = 0x17fd000
18103 20:20:37.333469 <... wait4 resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG|WSTOPPED|WCONTINUED, {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 18106
18109 20:20:37.333517 access("/etc/ld.so.nohwcap", F_OK <unfinished ...>
18103 20:20:37.333545 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18109 20:20:37.333564 <... access resumed> ) = -1 ENOENT (No such file or directory)
18103 20:20:37.333585 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18109 20:20:37.333632 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
18103 20:20:37.333657 wait4(-1,  <unfinished ...>
18109 20:20:37.333675 <... mmap resumed> ) = 0x7f25818cc000
18103 20:20:37.333707 <... wait4 resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG|WSTOPPED|WCONTINUED, {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 18107
18109 20:20:37.333757 access("/etc/ld.so.preload", R_OK <unfinished ...>
18103 20:20:37.333786 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18109 20:20:37.333804 <... access resumed> ) = -1 ENOENT (No such file or directory)
18103 20:20:37.333825 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18109 20:20:37.333869 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC <unfinished ...>
18103 20:20:37.333897 wait4(-1,  <unfinished ...>
18109 20:20:37.333916 <... open resumed> ) = 3
18103 20:20:37.333935 <... wait4 resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG|WSTOPPED|WCONTINUED, {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 18108
18109 20:20:37.333984 fstat(3,  <unfinished ...>
18103 20:20:37.334004 getrusage(RUSAGE_CHILDREN,  <unfinished ...>
18109 20:20:37.334023 <... fstat resumed> {st_mode=S_IFREG|0644, st_size=239015, ...}) = 0
18103 20:20:37.334068 <... getrusage resumed> {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 0
18109 20:20:37.334114 mmap(NULL, 239015, PROT_READ, MAP_PRIVATE, 3, 0 <unfinished ...>
18103 20:20:37.334137 wait4(-1,  <unfinished ...>
18109 20:20:37.334156 <... mmap resumed> ) = 0x7f2581891000
18103 20:20:37.334175 <... wait4 resumed> 0x7fffbe69267c, WNOHANG|WSTOPPED|WCONTINUED, 0x7fffbe6926a0) = 0
18109 20:20:37.334197 close(3 <unfinished ...>
18103 20:20:37.334217 rt_sigreturn(0xffffffff <unfinished ...>
18109 20:20:37.334261 <... close resumed> ) = 0
18103 20:20:37.334284 <... rt_sigreturn resumed> ) = -1 EINTR (Interrupted system call)
18109 20:20:37.334307 access("/etc/ld.so.nohwcap", F_OK <unfinished ...>
18103 20:20:37.334334 kill(18109, SIGCONT <unfinished ...>
18109 20:20:37.334352 <... access resumed> ) = -1 ENOENT (No such file or directory)
18103 20:20:37.334367 <... kill resumed> ) = 0
18109 20:20:37.334376 --- SIGCONT (Continued) @ 0 (0) ---
18103 20:20:37.334383 rt_sigprocmask(SIG_BLOCK, [CHLD],  <unfinished ...>
18109 20:20:37.334411 open("/lib/x86_64-linux-gnu/libselinux.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
18103 20:20:37.334427 <... rt_sigprocmask resumed> [CHLD], 8) = 0
18109 20:20:37.334439 <... open resumed> ) = 3
18103 20:20:37.334449 rt_sigsuspend([INT] <unfinished ...>
18109 20:20:37.334461 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240a\300\3464\0\0\0"..., 832) = 832
18109 20:20:37.334518 fstat(3, {st_mode=S_IFREG|0644, st_size=137024, ...}) = 0
18109 20:20:37.334576 mmap(0x34e6c00000, 2234432, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x34e6c00000
18109 20:20:37.334628 mprotect(0x34e6c1f000, 2097152, PROT_NONE) = 0
18109 20:20:37.334679 mmap(0x34e6e1f000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1f000) = 0x34e6e1f000
18109 20:20:37.334734 mmap(0x34e6e21000, 2112, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x34e6e21000
18109 20:20:37.334785 close(3)          = 0
18109 20:20:37.334831 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18109 20:20:37.334894 open("/lib/x86_64-linux-gnu/librt.so.1", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.334954 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20#\200\3424\0\0\0"..., 832) = 832
18109 20:20:37.335012 fstat(3, {st_mode=S_IFREG|0644, st_size=34720, ...}) = 0
18109 20:20:37.335081 mmap(0x34e2800000, 2128888, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x34e2800000
18109 20:20:37.335139 mprotect(0x34e2807000, 2093056, PROT_NONE) = 0
18109 20:20:37.335196 mmap(0x34e2a06000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x6000) = 0x34e2a06000
18109 20:20:37.335259 close(3)          = 0
18109 20:20:37.335317 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18109 20:20:37.335382 open("/lib/x86_64-linux-gnu/libacl.so.1", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.335442 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\360!\300\3664\0\0\0"..., 832) = 832
18109 20:20:37.335504 fstat(3, {st_mode=S_IFREG|0644, st_size=37816, ...}) = 0
18109 20:20:37.335575 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f2581890000
18109 20:20:37.335634 mmap(0x34f6c00000, 2130600, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x34f6c00000
18109 20:20:37.335692 mprotect(0x34f6c08000, 2093056, PROT_NONE) = 0
18109 20:20:37.335748 mmap(0x34f6e07000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x7000) = 0x34f6e07000
18109 20:20:37.335811 close(3)          = 0
18109 20:20:37.335867 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18109 20:20:37.335928 open("/lib/x86_64-linux-gnu/libc.so.6", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.335987 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\32B\3414\0\0\0"..., 832) = 832
18109 20:20:37.336047 fstat(3, {st_mode=S_IFREG|0755, st_size=1740224, ...}) = 0
18109 20:20:37.336109 mmap(0x34e1400000, 3849280, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x34e1400000
18109 20:20:37.336167 mprotect(0x34e15a2000, 2097152, PROT_NONE) = 0
18109 20:20:37.336225 mmap(0x34e17a2000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1a2000) = 0x34e17a2000
18109 20:20:37.336291 mmap(0x34e17a8000, 15424, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x34e17a8000
18109 20:20:37.336344 close(3)          = 0
18109 20:20:37.336393 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18109 20:20:37.336451 open("/lib/x86_64-linux-gnu/libpcre.so.3", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.336506 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`\32\300\3424\0\0\0"..., 832) = 832
18109 20:20:37.336560 fstat(3, {st_mode=S_IFREG|0644, st_size=256584, ...}) = 0
18109 20:20:37.336617 mmap(0x34e2c00000, 2349248, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x34e2c00000
18109 20:20:37.336667 mprotect(0x34e2c3e000, 2093056, PROT_NONE) = 0
18109 20:20:37.336717 mmap(0x34e2e3d000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3d000) = 0x34e2e3d000
18109 20:20:37.336771 close(3)          = 0
18109 20:20:37.336817 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18109 20:20:37.336869 open("/lib/x86_64-linux-gnu/libpthread.so.0", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.336922 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0@l\0\3424\0\0\0"..., 832) = 832
18109 20:20:37.336976 fstat(3, {st_mode=S_IFREG|0755, st_size=134067, ...}) = 0
18109 20:20:37.337028 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f258188f000
18109 20:20:37.337079 mmap(0x34e2000000, 2208688, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x34e2000000
18109 20:20:37.337129 mprotect(0x34e2017000, 2093056, PROT_NONE) = 0
18109 20:20:37.337179 mmap(0x34e2216000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x16000) = 0x34e2216000
18109 20:20:37.337234 mmap(0x34e2218000, 13232, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x34e2218000
18109 20:20:37.337283 close(3)          = 0
18109 20:20:37.337329 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18109 20:20:37.337383 open("/lib/x86_64-linux-gnu/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.337437 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\16\200\3414\0\0\0"..., 832) = 832
18109 20:20:37.337492 fstat(3, {st_mode=S_IFREG|0644, st_size=17400, ...}) = 0
18109 20:20:37.337544 mmap(0x34e1800000, 2109720, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x34e1800000
18109 20:20:37.337593 mprotect(0x34e1803000, 2093056, PROT_NONE) = 0
18109 20:20:37.337643 mmap(0x34e1a02000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x34e1a02000
18109 20:20:37.337697 close(3)          = 0
18109 20:20:37.337744 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory)
18109 20:20:37.337796 open("/lib/x86_64-linux-gnu/libattr.so.1", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.337850 read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\24@\3604\0\0\0"..., 832) = 832
18109 20:20:37.337907 fstat(3, {st_mode=S_IFREG|0644, st_size=21112, ...}) = 0
18109 20:20:37.337964 mmap(0x34f0400000, 2113896, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x34f0400000
18109 20:20:37.338013 mprotect(0x34f0404000, 2093056, PROT_NONE) = 0
18109 20:20:37.338063 mmap(0x34f0603000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3000) = 0x34f0603000
18109 20:20:37.338116 close(3)          = 0
18109 20:20:37.338159 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f258188e000
18109 20:20:37.338218 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f258188d000
18109 20:20:37.338265 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f258188b000
18109 20:20:37.338304 arch_prctl(ARCH_SET_FS, 0x7f258188b800) = 0
18109 20:20:37.338371 mprotect(0x61a000, 4096, PROT_READ) = 0
18109 20:20:37.338406 mprotect(0x34e6e1f000, 4096, PROT_READ) = 0
18109 20:20:37.338439 mprotect(0x34e2a06000, 4096, PROT_READ) = 0
18109 20:20:37.338472 mprotect(0x34f6e07000, 4096, PROT_READ) = 0
18109 20:20:37.338505 mprotect(0x34e17a2000, 16384, PROT_READ) = 0
18109 20:20:37.338539 mprotect(0x34e2216000, 4096, PROT_READ) = 0
18109 20:20:37.338572 mprotect(0x34e1a02000, 4096, PROT_READ) = 0
18109 20:20:37.338605 mprotect(0x34e1221000, 4096, PROT_READ) = 0
18109 20:20:37.338637 mprotect(0x34f0603000, 4096, PROT_READ) = 0
18109 20:20:37.338670 munmap(0x7f2581891000, 239015) = 0
18109 20:20:37.338723 set_tid_address(0x7f258188bad0) = 18109
18109 20:20:37.338767 set_robust_list(0x7f258188bae0, 0x18) = 0
18109 20:20:37.338813 rt_sigaction(SIGRTMIN, {0x34e20067a0, [], SA_RESTORER|SA_SIGINFO, 0x34e200f210}, NULL, 8) = 0
18109 20:20:37.338867 rt_sigaction(SIGRT_1, {0x34e2006820, [], SA_RESTORER|SA_RESTART|SA_SIGINFO, 0x34e200f210}, NULL, 8) = 0
18109 20:20:37.338920 rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0
18109 20:20:37.338967 getrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM_INFINITY}) = 0
18109 20:20:37.339042 statfs("/sys/fs/selinux", 0x7fffff3d8890) = -1 ENOENT (No such file or directory)
18109 20:20:37.339101 statfs("/selinux", 0x7fffff3d8890) = -1 ENOENT (No such file or directory)
18109 20:20:37.339197 brk(0)            = 0x17fd000
18109 20:20:37.339245 brk(0x181e000)    = 0x181e000
18109 20:20:37.339297 open("/proc/filesystems", O_RDONLY) = 3
18109 20:20:37.339362 fstat(3, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
18109 20:20:37.339419 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f25818cb000
18109 20:20:37.339468 read(3, "nodev\tsysfs\nnodev\trootfs\nnodev\tb"..., 1024) = 378
18109 20:20:37.339537 read(3, "", 1024) = 0
18109 20:20:37.339581 close(3)          = 0
18109 20:20:37.339630 munmap(0x7f25818cb000, 4096) = 0
18109 20:20:37.339699 open("/usr/lib/locale/locale-archive", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.339755 fstat(3, {st_mode=S_IFREG|0644, st_size=2117296, ...}) = 0
18109 20:20:37.339808 mmap(NULL, 2117296, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7f2581686000
18109 20:20:37.339859 close(3)          = 0
18109 20:20:37.339918 ioctl(1, SNDCTL_TMR_TIMEBASE or TCGETS, 0x7fffff3d83f0) = -1 ENOTTY (Inappropriate ioctl for device)
18109 20:20:37.339967 ioctl(1, TIOCGWINSZ, 0x7fffff3d84d0) = -1 ENOTTY (Inappropriate ioctl for device)
18109 20:20:37.340029 open("/usr/share/locale/locale.alias", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.340086 fstat(3, {st_mode=S_IFREG|0644, st_size=2502, ...}) = 0
18109 20:20:37.340139 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f25818cb000
18109 20:20:37.340187 read(3, "# Locale name alias data base.\n#"..., 4096) = 2502
18109 20:20:37.340254 read(3, "", 4096) = 0
18109 20:20:37.340298 close(3)          = 0
18109 20:20:37.340346 munmap(0x7f25818cb000, 4096) = 0
18109 20:20:37.340413 open("/usr/share/locale/en_GB.UTF-8/LC_TIME/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.340469 open("/usr/share/locale/en_GB.utf8/LC_TIME/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.340525 open("/usr/share/locale/en_GB/LC_TIME/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.340579 open("/usr/share/locale/en.UTF-8/LC_TIME/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.340632 open("/usr/share/locale/en.utf8/LC_TIME/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.340685 open("/usr/share/locale/en/LC_TIME/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.340748 open("/usr/lib/x86_64-linux-gnu/gconv/gconv-modules.cache", O_RDONLY) = 3
18109 20:20:37.340805 fstat(3, {st_mode=S_IFREG|0644, st_size=26258, ...}) = 0
18109 20:20:37.340858 mmap(NULL, 26258, PROT_READ, MAP_SHARED, 3, 0) = 0x7f25818c5000
18109 20:20:37.340918 close(3)          = 0
18109 20:20:37.340992 futex(0x34e17a7918, FUTEX_WAKE_PRIVATE, 2147483647) = 0
18109 20:20:37.341123 lstat("/proc/self/fd/10", {st_mode=S_IFLNK|0500, st_size=64, ...}) = 0
18109 20:20:37.341227 lgetxattr("/proc/self/fd/10", "security.selinux", 0x1804100, 255) = -1 EOPNOTSUPP (Operation not supported)
18109 20:20:37.341292 readlink("/proc/self/fd/10", "pipe:[454132]", 65) = 13
18109 20:20:37.341360 socket(PF_FILE, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
18109 20:20:37.341415 connect(3, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = 0
18109 20:20:37.341519 sendto(3, "\2\0\0\0\v\0\0\0\7\0\0\0passwd\0", 19, MSG_NOSIGNAL, NULL, 0) = 19
18109 20:20:37.341603 poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 5000) = 1 ([{fd=3, revents=POLLIN|POLLHUP}])
18109 20:20:37.341653 recvmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"passwd\0", 7}, {"\310O\3\0\0\0\0\0", 8}], msg_controllen=24, {cmsg_len=20, cmsg_level=SOL_SOCKET, cmsg_type=SCM_RIGHTS, {4}}, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 15
18109 20:20:37.341720 mmap(NULL, 217032, PROT_READ, MAP_SHARED, 4, 0) = 0x7f2581651000
18109 20:20:37.341772 close(4)          = 0
18109 20:20:37.341816 close(3)          = 0
18109 20:20:37.341870 socket(PF_FILE, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
18109 20:20:37.341920 connect(3, {sa_family=AF_FILE, path="/var/run/nscd/socket"}, 110) = 0
18109 20:20:37.342019 sendto(3, "\2\0\0\0\f\0\0\0\6\0\0\0group\0", 18, MSG_NOSIGNAL, NULL, 0) = 18
18109 20:20:37.342075 poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 5000) = 1 ([{fd=3, revents=POLLIN|POLLHUP}])
18109 20:20:37.342127 recvmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"group\0", 6}, {"\310O\3\0\0\0\0\0", 8}], msg_controllen=24, {cmsg_len=20, cmsg_level=SOL_SOCKET, cmsg_type=SCM_RIGHTS, {4}}, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 14
18109 20:20:37.342184 mmap(NULL, 217032, PROT_READ, MAP_SHARED, 4, 0) = 0x7f258161c000
18109 20:20:37.342233 close(4)          = 0
18109 20:20:37.342273 close(3)          = 0
18109 20:20:37.342315 lstat("/proc/self/fd/11", 0x17ff6c0) = -1 ENOENT (No such file or directory)
18109 20:20:37.342383 open("/usr/share/locale/en_GB.UTF-8/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.342430 open("/usr/share/locale/en_GB.utf8/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.342475 open("/usr/share/locale/en_GB/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.342519 open("/usr/share/locale/en.UTF-8/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.342562 open("/usr/share/locale/en.utf8/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.342606 open("/usr/share/locale/en/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.342663 write(2, "ls: ", 4) = 4
18109 20:20:37.342752 write(2, "cannot access /proc/self/fd/11", 30) = 30
18109 20:20:37.342809 open("/usr/share/locale/en_GB.UTF-8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.342971 open("/usr/share/locale/en_GB.utf8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.343025 open("/usr/share/locale/en_GB/LC_MESSAGES/libc.mo", O_RDONLY) = 3
18109 20:20:37.343064 fstat(3, {st_mode=S_IFREG|0644, st_size=1474, ...}) = 0
18109 20:20:37.343106 mmap(NULL, 1474, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7f25818c4000
18109 20:20:37.343140 close(3)          = 0
18109 20:20:37.343175 open("/usr/share/locale/en.UTF-8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.343214 open("/usr/share/locale/en.utf8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.343248 open("/usr/share/locale/en/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
18109 20:20:37.343290 write(2, ": No such file or directory", 27) = 27
18109 20:20:37.343329 write(2, "\n", 1) = 1
18109 20:20:37.343377 lstat("/proc/self/fd/12", {st_mode=S_IFLNK|0500, st_size=64, ...}) = 0
18109 20:20:37.343428 lgetxattr("/proc/self/fd/12", "security.selinux", 0x18053f0, 255) = -1 EOPNOTSUPP (Operation not supported)
18109 20:20:37.343472 readlink("/proc/self/fd/12", "pipe:[459548]", 65) = 13
18109 20:20:37.343518 lstat("/proc/self/fd/13", 0x17ff780) = -1 ENOENT (No such file or directory)
18109 20:20:37.343559 write(2, "ls: ", 4) = 4
18109 20:20:37.343616 write(2, "cannot access /proc/self/fd/13", 30) = 30
18109 20:20:37.343734 write(2, ": No such file or directory", 27) = 27
18109 20:20:37.343863 write(2, "\n", 1) = 1
18109 20:20:37.343954 fstat(1, {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
18109 20:20:37.344020 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f25818c3000
18109 20:20:37.344070 open("/etc/localtime", O_RDONLY|O_CLOEXEC) = 3
18109 20:20:37.344116 fstat(3, {st_mode=S_IFREG|0644, st_size=3661, ...}) = 0
18109 20:20:37.344164 fstat(3, {st_mode=S_IFREG|0644, st_size=3661, ...}) = 0
18109 20:20:37.344212 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f25818c2000
18109 20:20:37.344252 read(3, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\7\0\0\0\7\0\0\0\0"..., 4096) = 3661
18109 20:20:37.344300 lseek(3, -2338, SEEK_CUR) = 1323
18109 20:20:37.344337 read(3, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\10\0\0\0\10\0\0\0\0"..., 4096) = 2338
18109 20:20:37.344383 close(3)          = 0
18109 20:20:37.344420 munmap(0x7f25818c2000, 4096) = 0
18109 20:20:37.344477 stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=3661, ...}) = 0
18109 20:20:37.344533 write(1, "lr-x------ 1 chazelas chazelas 6"..., 162) = 162
18104 20:20:37.344575 <... read resumed> "lr-x------ 1 chazelas chazelas 6"..., 32768) = 162
18109 20:20:37.344593 close(1 <unfinished ...>
18104 20:20:37.344604 write(1, "lr-x------ 1 chazelas chazelas 6"..., 162 <unfinished ...>
18109 20:20:37.344616 <... close resumed> ) = 0
18104 20:20:37.344626 <... write resumed> ) = 162
18109 20:20:37.344636 munmap(0x7f25818c3000, 4096 <unfinished ...>
18104 20:20:37.344646 read(0,  <unfinished ...>
18109 20:20:37.344655 <... munmap resumed> ) = 0
18109 20:20:37.344676 close(2)          = 0
18109 20:20:37.344731 exit_group(2)     = ?
18103 20:20:37.344873 <... rt_sigsuspend resumed> ) = ? ERESTARTNOHAND (To be restarted)
18103 20:20:37.344901 --- SIGCHLD (Child exited) @ 0 (0) ---
18103 20:20:37.344922 rt_sigprocmask(SIG_BLOCK, ~[RTMIN RT_1], [INT CHLD], 8) = 0
18103 20:20:37.344964 rt_sigprocmask(SIG_SETMASK, [INT CHLD], ~[KILL STOP RTMIN RT_1], 8) = 0
18103 20:20:37.345003 wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 2}], WNOHANG|WSTOPPED|WCONTINUED, {ru_utime={0, 0}, ru_stime={0, 4000}, ...}) = 18109
18103 20:20:37.345067 wait4(-1, 0x7fffbe69267c, WNOHANG|WSTOPPED|WCONTINUED, 0x7fffbe6926a0) = -1 ECHILD (No child processes)
18103 20:20:37.345104 rt_sigreturn(0xffffffff) = -1 EINTR (Interrupted system call)
18103 20:20:37.345143 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
18103 20:20:37.345183 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
18103 20:20:37.345223 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
18103 20:20:37.345258 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
18103 20:20:37.345305 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
18103 20:20:37.345340 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
18103 20:20:37.345401 close(10)         = 0
18103 20:20:37.345442 close(12)         = 0
18103 20:20:37.345479 close(13)         = 0
18103 20:20:37.345517 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
18103 20:20:37.345551 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
18103 20:20:37.345591 close(0)          = 0
18103 20:20:37.345620 close(1 <unfinished ...>
18104 20:20:37.345673 <... read resumed> "", 32768) = 0
18103 20:20:37.345696 <... close resumed> ) = 0
18104 20:20:37.345716 close(0 <unfinished ...>
18103 20:20:37.345732 close(2 <unfinished ...>
18104 20:20:37.345741 <... close resumed> ) = 0
18103 20:20:37.345750 <... close resumed> ) = 0
18104 20:20:37.345768 close(1 <unfinished ...>
18103 20:20:37.345779 exit_group(2)     = ?
18104 20:20:37.345800 <... close resumed> ) = 0
18104 20:20:37.345823 close(2)          = 0
18104 20:20:37.345874 exit_group(0)     = ?
8713  20:20:37.345923 <... rt_sigsuspend resumed> ) = ? ERESTARTNOHAND (To be restarted)
8713  20:20:37.345948 --- SIGCHLD (Child exited) @ 0 (0) ---
8713  20:20:37.345970 rt_sigprocmask(SIG_BLOCK, ~[RTMIN RT_1], [INT CHLD], 8) = 0
8713  20:20:37.346012 rt_sigprocmask(SIG_SETMASK, [INT CHLD], ~[KILL STOP RTMIN RT_1], 8) = 0
8713  20:20:37.346051 wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 2}], WNOHANG|WSTOPPED|WCONTINUED, {ru_utime={0, 0}, ru_stime={0, 4000}, ...}) = 18103
8713  20:20:37.346102 wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG|WSTOPPED|WCONTINUED, {ru_utime={0, 0}, ru_stime={0, 0}, ...}) = 18104
8713  20:20:37.346150 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig icanon echo ...}) = 0
8713  20:20:37.346189 ioctl(10, TIOCGPGRP, [18103]) = 0
8713  20:20:37.346223 ioctl(10, TIOCSPGRP, [8713]) = 0
8713  20:20:37.346291 ioctl(10, TIOCGWINSZ, {ws_row=52, ws_col=191, ws_xpixel=1920, ws_ypixel=1055}) = 0
8713  20:20:37.346345 wait4(-1, 0x7fffbe693e7c, WNOHANG|WSTOPPED|WCONTINUED, 0x7fffbe693ea0) = 0
8713  20:20:37.346392 rt_sigreturn(0xffffffff) = -1 EINTR (Interrupted system call)
8713  20:20:37.346438 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.346485 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.346535 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:37.346584 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.346635 munmap(0x7fccc6374000, 16384) = 0
8713  20:20:37.346692 ioctl(10, TIOCSPGRP, [8713]) = 0
8713  20:20:37.346738 fstat(0, {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 5), ...}) = 0
8713  20:20:37.346795 fcntl(0, F_GETFL) = 0x8002 (flags O_RDWR|O_LARGEFILE)
8713  20:20:37.346843 mmap(NULL, 16384, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fccc6374000
8713  20:20:37.346903 geteuid()         = 1000
8713  20:20:37.346952 capget(0x20080522, 0, NULL) = 0
8713  20:20:37.346998 capget(0x20080522, 0, {0, 0, 0}) = 0
8713  20:20:37.347052 write(10, "\33[1m\33[3m%\33[23m\33[1m\33[0m          "..., 215) = 215
8713  20:20:37.347132 rt_sigaction(SIGINT, {0x473a00, [], SA_RESTORER|SA_INTERRUPT, 0x34e1435260}, NULL, 8) = 0
8713  20:20:37.347191 rt_sigaction(SIGINT, {0x473a00, [], SA_RESTORER|SA_INTERRUPT, 0x34e1435260}, NULL, 8) = 0
8713  20:20:37.347269 geteuid()         = 1000
8713  20:20:37.347329 stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=3661, ...}) = 0
8713  20:20:37.347405 ioctl(10, FIONREAD, [0]) = 0
8713  20:20:37.347452 ioctl(10, TIOCSPGRP, [8713]) = 0
8713  20:20:37.347498 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig icanon echo ...}) = 0
8713  20:20:37.347546 ioctl(10, SNDCTL_TMR_STOP or TCSETSW, {B38400 opost isig -icanon -echo ...}) = 0
8713  20:20:37.347604 ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig -icanon -echo ...}) = 0
8713  20:20:37.347660 write(10, "\r\33[0m\33[23m\33[24m\33[J\33[3m1\33[23m~$ ", 31) = 31
8713  20:20:37.347727 write(10, "\33[K\33[181C20:20\33[3m\33[23m\33[186D", 29) = 29
8713  20:20:37.347786 fcntl(0, F_DUPFD, 10) = 11
8713  20:20:37.347837 close(0)          = 0
8713  20:20:37.347896 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:37.347955 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.348004 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.348053 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
8713  20:20:37.348113 write(1, "\33[?1h\33=", 7) = 7
8713  20:20:37.348168 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.348218 rt_sigprocmask(SIG_UNBLOCK, [CHLD], [CHLD], 8) = 0
8713  20:20:37.348278 dup2(11, 0)       = 0
8713  20:20:37.348321 close(11)         = 0


Messages sorted by: Reverse Date, Date, Thread, Author