Attachment 694988 Details for Bug 909090 – Strace output for "cups" while attempting to print this file

Strace output for "cups" while attempting to print this file

strace.out (text/plain), 140.74 KB, created by Wolfgang Denk on 2013-02-08 08:30:57 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Wolfgang Denk

Created: 2013-02-08 08:30:57 UTC

Size: 140.74 KB

patch

obsolete

>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, -1) = 1
>13090 accept(3, {sa_family=AF_FILE, NULL}, [2]) = 16
>13090 getsockname(16, {sa_family=AF_FILE, sun_path="/var/run/cups/cups.sock"}, [26]) = 0
>13090 setsockopt(16, SOL_TCP, TCP_NODELAY, [1], 4) = -1 EOPNOTSUPP (Operation not supported)
>13090 fcntl(16, F_GETFD)                = 0
>13090 fcntl(16, F_SETFD, FD_CLOEXEC)    = 0
>13090 epoll_ctl(5, EPOLL_CTL_ADD, 16, {...}) = 0
>13090 unlink("/var/run/cups/certs/0")   = 0
>13090 unlink("/var/run/cups/certs/0")   = -1 ENOENT (No such file or directory)
>13090 open("/var/run/cups/certs/0", O_WRONLY|O_CREAT|O_EXCL, 0400) = 18
>13090 fchmod(18, 0440)                  = 0
>13090 fchown(18, 0, 3)                  = 0
>13090 fsetxattr(18, "system.posix_acl_access", "\x02\x00\x00\x00\x01\x00\x04\x00\xff\xff\xff\xff\x04\x00\x04\x00\xff\xff\xff\xff\x08\x00\x04\x00\x00\x00\x00\x00\x10\x00\x04\x00\xff\xff\xff\xff \x00\x00\x00\xff\xff\xff\xff", 44, 0) = 0
>13090 write(18, "1E5F8BBD836EA107FB797C2EC5A6DD3E", 32) = 32
>13090 close(18)                         = 0
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "P", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "POST / HTTP/1.1\r\nContent-Length:"..., 2048, 0, NULL, NULL) = 818
>13090 sendto(16, "HTTP/1.1 100 Continue\r\n\r\n", 25, 0, NULL, 0) = 25
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 sendto(16, "HTTP/1.1 200 OK\r\nDate: Fri, 08 F"..., 200, 0, NULL, 0) = 200
>13090 epoll_ctl(5, EPOLL_CTL_MOD, 16, {...}) = 0
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 301000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 sendto(16, "\1\1\0\0\0\0\0\1\1G\0\22attributes-charset\0\5"..., 1484, 0, NULL, 0) = 1484
>13090 epoll_ctl(5, EPOLL_CTL_MOD, 16, {...}) = 0
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "POST /printers/lp HTTP/1.1\r\nCont"..., 2048, 0, NULL, NULL) = 583
>13090 sendto(16, "HTTP/1.1 100 Continue\r\n\r\n", 25, 0, NULL, 0) = 25
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 epoll_wait(5, {}, 4096, 0)        = 0
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\23\0\0\0c\2\0\0q\0\0\0\1\1o\0\32\0\0\0/com/red"..., 136}, {"\2\0\0\0lp\0\0.\10\0\0\2\0\0\0wd\0", 19}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 155
>13090 sendto(16, "HTTP/1.1 200 OK\r\nDate: Fri, 08 F"..., 199, 0, NULL, 0) = 199
>13090 epoll_ctl(5, EPOLL_CTL_MOD, 16, {...}) = 0
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 31000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 sendto(16, "\1\1\0\0\0\0\0\1\1G\0\22attributes-charset\0\5"..., 184, 0, NULL, 0) = 184
>13090 stat("/var/log/cups/access_log", {st_mode=S_IFREG|0600, st_size=3401, ...}) = 0
>13090 stat("/etc/localtime", {st_mode=S_IFREG|0644, st_size=2309, ...}) = 0
>13090 write(6, "localhost - - [08/Feb/2013:09:23"..., 105) = 105
>13090 epoll_ctl(5, EPOLL_CTL_MOD, 16, {...}) = 0
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "POST /printers/lp HTTP/1.1\r\nCont"..., 2048, 0, NULL, NULL) = 419
>13090 sendto(16, "HTTP/1.1 100 Continue\r\n\r\n", 25, 0, NULL, 0) = 25
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 0) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 0) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 0) = 1
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 0) = 1
>13090 open("/var/spool/cups/00000024", O_WRONLY|O_CREAT|O_TRUNC, 0640) = 18
>13090 fchmod(18, 0640)                  = 0
>13090 fchown(18, 0, 7)                  = 0
>13090 fcntl(18, F_GETFD)                = 0
>13090 fcntl(18, F_SETFD, FD_CLOEXEC)    = 0
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "2000\r\n%!PS-Adobe-3.0\n%XpdfVersio"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "%!PS-Adobe-3.0\n%XpdfVersion: 3.0"..., 2042) = 2042
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "t", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "troke { pdfStrokeOP setoverprint"..., 6150, 0, NULL, NULL) = 6150
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\np 3 index 2 index add 0."..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "troke { pdfStrokeOP setoverprint"..., 6150) = 6150
>13090 write(18, "p 3 index 2 index add 0.5 mul 3 "..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "c", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "ch dup dy mul y0 add exch dr mul"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n0050009700b300c700d90000"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "ch dup dy mul y0 add exch dr mul"..., 6152) = 6152
>13090 write(18, "0050009700b300c700d9000000000000"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "0", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "062b020616ab00e2344\n2310b00ef61b"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n5d5d5d5d5d5d\n5d5d7171717"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "062b020616ab00e2344\n2310b00ef61b"..., 6152) = 6152
>13090 write(18, "5d5d5d5d5d5d\n5d5d717171717171717"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "8", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "855e2f5b\n4e3a0d2d311f62425d652a4"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n401922401842401522462247"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "855e2f5b\n4e3a0d2d311f62425d652a4"..., 6152) = 6152
>13090 write(18, "40192240184240152246224722403342"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "0", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "01\n2ab8ffc04013080c482a0e5025161"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n095f0e010e0e0901003f332f"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "01\n2ab8ffc04013080c482a0e5025161"..., 6152) = 6152
>13090 write(18, "095f0e010e0e0901003f332f5d10ed3f"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "3", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "3016012416015416641694\n16a416040"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n732b2b012b5e735e73005e73"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "3016012416015416641694\n16a416040"..., 6152) = 6152
>13090 write(18, "732b2b012b5e735e73005e73\n5e73737"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "T", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "Tj\n2 TJm\n(\\006\\016)\n[3\n0\n5.316\n0"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n\n0\n3.996\n0] Tj\n-16 TJm\n("..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "Tj\n2 TJm\n(\\006\\016)\n[3\n0\n5.316\n0"..., 6152) = 6152
>13090 write(18, "\n0\n3.996\n0] Tj\n-16 TJm\n(\\006\\011"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "T", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "Tj\n1 TJm\n(\\005)\n[9.324\n0] Tj\n-5 "..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n4)\n[3\n0\n5.316\n0] Tj\n1 TJ"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "Tj\n1 TJm\n(\\005)\n[9.324\n0] Tj\n-5 "..., 6152) = 6152
>13090 write(18, "4)\n[3\n0\n5.316\n0] Tj\n1 TJm\n(\\002\\"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "Q", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "Q\nq\n/DeviceRGB {} cs\n[0 0 0] sc\n"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n11)\n[6\n0\n4.668\n0] Tj\n-2 "..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "Q\nq\n/DeviceRGB {} cs\n[0 0 0] sc\n"..., 6152) = 6152
>13090 write(18, "11)\n[6\n0\n4.668\n0] Tj\n-2 TJm\n(\\01"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "4", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "4\n0] Tj\n2 TJm\n(\\002\\003\\004)\n[6\n"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n0\n5.316\n0] Tj\n1 TJm\n(\\01"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "4\n0] Tj\n2 TJm\n(\\002\\003\\004)\n[6\n"..., 6152) = 6152
>13090 write(18, "0\n5.316\n0] Tj\n1 TJm\n(\\015)\n[3.32"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "\n", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\n0\n5.316\n0] Tj\n1 TJm\n(\\007)\n[3.3"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\nRT:C\\ILQU9e1<aj%&me?%&nK"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "\n0\n5.316\n0] Tj\n1 TJm\n(\\007)\n[3.3"..., 6152) = 6152
>13090 write(18, "RT:C\\ILQU9e1<aj%&me?%&nKK[1.)0S3"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "(", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "(!FX\np7eQ]D\"n*1-_Oq=4;kX+Zt`)3t!"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n7Dc.)MQSIKl6SPXU[I>->K[H"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "(!FX\np7eQ]D\"n*1-_Oq=4;kX+Zt`)3t!"..., 6152) = 6152
>13090 write(18, "7Dc.)MQSIKl6SPXU[I>->K[Hj2P!ai(2"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "Z", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "Zl*r#3DLXHuiM`Xb:9k(aN]jnud;@K_A"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\n<f?PsEoj`8M&UqLiVf#=.mid"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "Zl*r#3DLXHuiM`Xb:9k(aN]jnud;@K_A"..., 6152) = 6152
>13090 write(18, "<f?PsEoj`8M&UqLiVf#=.midfp^Jg!i."..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "$", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "$NO:Gc.h%'`u4QaaHIG`Xk\\%H6ZN\\oDs"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n2000\r\nIe=&8E4Nd#b\"\"j2sCje=k#O#"..., 2048, 0, NULL, NULL) = 2048
>13090 write(18, "$NO:Gc.h%'`u4QaaHIG`Xk\\%H6ZN\\oDs"..., 6152) = 6152
>13090 write(18, "Ie=&8E4Nd#b\"\"j2sCje=k#O#r`e*,;I%"..., 2040) = 2040
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 recvfrom(16, "E", 1, MSG_PEEK, NULL, NULL) = 1
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "EholsjE$-t;Ll95q8N8!^MGtc$YY^(OV"..., 6152, 0, NULL, NULL) = 6152
>13090 poll([{fd=16, events=POLLIN}], 1, 10000) = 1 ([{fd=16, revents=POLLIN}])
>13090 recvfrom(16, "\r\n374\r\n1$j@(0#GP(WJM%3P8d'aK6:(H"..., 2048, 0, NULL, NULL) = 898
>13090 write(18, "EholsjE$-t;Ll95q8N8!^MGtc$YY^(OV"..., 6152) = 6152
>13090 write(18, "1$j@(0#GP(WJM%3P8d'aK6:(H8d0ZM^H"..., 884) = 884
>13090 fstat(18, {st_mode=S_IFREG|0640, st_size=123764, ...}) = 0
>13090 close(18)                         = 0
>13090 open("/etc/passwd", O_RDONLY|O_CLOEXEC) = 18
>13090 fstat(18, {st_mode=S_IFREG|0644, st_size=3438, ...}) = 0
>13090 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f5a0fead000
>13090 read(18, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 3438
>13090 close(18)                         = 0
>13090 munmap(0x7f5a0fead000, 4096)      = 0
>13090 open("/var/spool/cups/00000024", O_RDONLY) = 18
>13090 fcntl(18, F_GETFD)                = 0
>13090 fcntl(18, F_SETFD, FD_CLOEXEC)    = 0
>13090 read(18, "%!PS-Adobe-3.0\n%XpdfVersion: 3.0"..., 4096) = 4096
>13090 close(18)                         = 0
>13090 stat("/var/spool/cups/00000024", {st_mode=S_IFREG|0640, st_size=123764, ...}) = 0
>13090 rename("/var/spool/cups/00000024", "/var/spool/cups/d02094-001") = 0
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0d\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 135
>13090 pipe([18, 19])                    = 0
>13090 fcntl(18, F_GETFD)                = 0
>13090 fcntl(18, F_SETFD, FD_CLOEXEC)    = 0
>13090 fcntl(19, F_GETFD)                = 0
>13090 fcntl(19, F_SETFD, FD_CLOEXEC)    = 0
>13090 pipe([20, 21])                    = 0
>13090 fcntl(20, F_GETFD)                = 0
>13090 fcntl(20, F_SETFD, FD_CLOEXEC)    = 0
>13090 fcntl(21, F_GETFD)                = 0
>13090 fcntl(21, F_SETFD, FD_CLOEXEC)    = 0
>13090 fcntl(20, F_GETFL)                = 0 (flags O_RDONLY)
>13090 fcntl(20, F_SETFL, O_RDONLY|O_NONBLOCK) = 0
>13090 fcntl(21, F_GETFL)                = 0x1 (flags O_WRONLY)
>13090 fcntl(21, F_SETFL, O_WRONLY|O_NONBLOCK) = 0
>13090 socketpair(PF_FILE, SOCK_STREAM, 0, [22, 23]) = 0
>13090 fcntl(22, F_GETFL)                = 0x2 (flags O_RDWR)
>13090 fcntl(22, F_SETFL, O_RDWR|O_NONBLOCK) = 0
>13090 fcntl(23, F_GETFL)                = 0x2 (flags O_RDWR)
>13090 fcntl(23, F_SETFL, O_RDWR|O_NONBLOCK) = 0
>13090 fcntl(22, F_GETFD)                = 0
>13090 fcntl(22, F_SETFD, FD_CLOEXEC)    = 0
>13090 fcntl(23, F_GETFD)                = 0
>13090 fcntl(23, F_SETFD, FD_CLOEXEC)    = 0
>13090 stat("/var/spool/cups/d02094-001", {st_mode=S_IFREG|0640, st_size=123764, ...}) = 0
>13090 access("/usr/lib/cups/filter/pstops", F_OK) = 0
>13090 pipe([24, 25])                    = 0
>13090 fcntl(24, F_GETFD)                = 0
>13090 fcntl(24, F_SETFD, FD_CLOEXEC)    = 0
>13090 fcntl(25, F_GETFD)                = 0
>13090 fcntl(25, F_SETFD, FD_CLOEXEC)    = 0
>13090 stat("/usr/lib/cups/filter/pstops", {st_mode=S_IFREG|0755, st_size=57328, ...}) = 0
>13090 stat("/usr/lib/cups/filter", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
>13090 rt_sigprocmask(SIG_BLOCK, [TERM CHLD], [], 8) = 0
>13090 clone( <unfinished ...>
>29394 set_robust_list(0x7f5a0fe54ae0, 24 <unfinished ...>
>13090 <... clone resumed> child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7f5a0fe54ad0) = 29394
>29394 <... set_robust_list resumed> )   = 0
>13090 rt_sigprocmask(SIG_SETMASK, [],  <unfinished ...>
>29394 dup2(19, 2 <unfinished ...>
>13090 <... rt_sigprocmask resumed> NULL, 8) = 0
>29394 <... dup2 resumed> )              = 2
>13090 stat("/usr/lib/cups/backend/socket",  <unfinished ...>
>29394 close(19 <unfinished ...>
>13090 <... stat resumed> {st_mode=S_IFREG|0755, st_size=36648, ...}) = 0
>29394 <... close resumed> )             = 0
>13090 stat("/usr/lib/cups/backend/socket", {st_mode=S_IFREG|0755, st_size=36648, ...}) = 0
>29394 setpgid(0, 0 <unfinished ...>
>13090 stat("/usr/lib/cups/backend",  <unfinished ...>
>29394 <... setpgid resumed> )           = 0
>13090 <... stat resumed> {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0
>29394 open("/dev/null", O_RDONLY <unfinished ...>
>13090 rt_sigprocmask(SIG_BLOCK, [TERM CHLD],  <unfinished ...>
>29394 <... open resumed> )              = 19
>13090 <... rt_sigprocmask resumed> [], 8) = 0
>29394 dup2(19, 0 <unfinished ...>
>13090 clone( <unfinished ...>
>29394 <... dup2 resumed> )              = 0
>29394 close(19 <unfinished ...>
>29395 set_robust_list(0x7f5a0fe54ae0, 24 <unfinished ...>
>13090 <... clone resumed> child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7f5a0fe54ad0) = 29395
>29395 <... set_robust_list resumed> )   = 0
>29394 <... close resumed> )             = 0
>13090 rt_sigprocmask(SIG_SETMASK, [],  <unfinished ...>
>29395 dup2(19, 2 <unfinished ...>
>29394 dup2(25, 1 <unfinished ...>
>29395 <... dup2 resumed> )              = 2
>29394 <... dup2 resumed> )              = 1
>29395 close(19 <unfinished ...>
>29394 close(25 <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... close resumed> )             = 0
>13090 <... rt_sigprocmask resumed> NULL, 8) = 0
>29395 setpgid(0, 0 <unfinished ...>
>29394 dup2(20, 3 <unfinished ...>
>29395 <... setpgid resumed> )           = 0
>29394 <... dup2 resumed> )              = 3
>29395 dup2(24, 0 <unfinished ...>
>29394 close(20 <unfinished ...>
>29395 <... dup2 resumed> )              = 0
>29394 <... close resumed> )             = 0
>29395 close(24 <unfinished ...>
>29394 fcntl(3, F_SETFL, O_RDONLY|O_NONBLOCK <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... fcntl resumed> )             = 0
>29395 open("/dev/null", O_WRONLY <unfinished ...>
>29394 dup2(22, 4 <unfinished ...>
>29395 <... open resumed> )              = 19
>29394 <... dup2 resumed> )              = 4
>29395 dup2(19, 1 <unfinished ...>
>29394 close(22 <unfinished ...>
>29395 <... dup2 resumed> )              = 1
>29394 <... close resumed> )             = 0
>29395 close(19 <unfinished ...>
>29394 fcntl(4, F_SETFL, O_RDONLY|O_NONBLOCK <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... fcntl resumed> )             = 0
>29395 dup2(21, 3)                       = 3
>29394 getpriority(PRIO_PROCESS, 0 <unfinished ...>
>29395 close(21 <unfinished ...>
>29394 <... getpriority resumed> )       = 20
>29395 <... close resumed> )             = 0
>29394 setpriority(PRIO_PROCESS, 0, 0 <unfinished ...>
>29395 fcntl(3, F_SETFL, O_RDONLY|O_NONBLOCK <unfinished ...>
>29394 <... setpriority resumed> )       = 0
>29395 <... fcntl resumed> )             = 0
>29394 getpriority(PRIO_PROCESS, 0 <unfinished ...>
>29395 dup2(23, 4 <unfinished ...>
>29394 <... getpriority resumed> )       = 20
>29395 <... dup2 resumed> )              = 4
>13090 close(24 <unfinished ...>
>29394 setgid(7 <unfinished ...>
>29395 close(23 <unfinished ...>
>29394 <... setgid resumed> )            = 0
>29395 <... close resumed> )             = 0
>13090 <... close resumed> )             = 0
>29395 fcntl(4, F_SETFL, O_RDONLY|O_NONBLOCK <unfinished ...>
>29394 setgroups(1, [7] <unfinished ...>
>29395 <... fcntl resumed> )             = 0
>29394 <... setgroups resumed> )         = 0
>29395 getpriority(PRIO_PROCESS, 0 <unfinished ...>
>29394 setuid(4 <unfinished ...>
>29395 <... getpriority resumed> )       = 20
>29394 <... setuid resumed> )            = 0
>29395 setpriority(PRIO_PROCESS, 0, 0 <unfinished ...>
>29394 umask(077 <unfinished ...>
>29395 <... setpriority resumed> )       = 0
>29394 <... umask resumed> )             = 022
>29395 getpriority(PRIO_PROCESS, 0 <unfinished ...>
>29394 rt_sigaction(SIGTERM, {SIG_DFL, [], SA_RESTORER, 0x7f5a0d4b1000},  <unfinished ...>
>29395 <... getpriority resumed> )       = 20
>29394 <... rt_sigaction resumed> NULL, 8) = 0
>13090 close(25 <unfinished ...>
>29395 setgid(7 <unfinished ...>
>29394 rt_sigaction(SIGCHLD, {SIG_DFL, [], SA_RESTORER, 0x7f5a0d4b1000},  <unfinished ...>
>29395 <... setgid resumed> )            = 0
>29394 <... rt_sigaction resumed> NULL, 8) = 0
>29395 setgroups(1, [7] <unfinished ...>
>29394 rt_sigaction(SIGPIPE, {SIG_DFL, [], SA_RESTORER, 0x7f5a0d4b1000},  <unfinished ...>
>29395 <... setgroups resumed> )         = 0
>29394 <... rt_sigaction resumed> NULL, 8) = 0
>29395 setuid(4 <unfinished ...>
>29394 rt_sigprocmask(SIG_SETMASK, [],  <unfinished ...>
>29395 <... setuid resumed> )            = 0
>29394 <... rt_sigprocmask resumed> NULL, 8) = 0
>29395 umask(077 <unfinished ...>
>29394 execve("/usr/lib/cups/filter/pstops", ["lp", "2094", "wd", "testfile.ps", "1", "finishings=3 media=iso_a4_210x29"..., "/var/spool/cups/d02094-001"], [/* 31 vars */] <unfinished ...>
>29395 <... umask resumed> )             = 022
>13090 <... close resumed> )             = 0
>29395 rt_sigaction(SIGTERM, {SIG_DFL, [], SA_RESTORER, 0x7f5a0d4b1000}, NULL, 8) = 0
>13090 close(20 <unfinished ...>
>29395 rt_sigaction(SIGCHLD, {SIG_DFL, [], SA_RESTORER, 0x7f5a0d4b1000},  <unfinished ...>
>13090 <... close resumed> )             = 0
>29395 <... rt_sigaction resumed> NULL, 8) = 0
>13090 close(21 <unfinished ...>
>29395 rt_sigaction(SIGPIPE, {SIG_DFL, [], SA_RESTORER, 0x7f5a0d4b1000},  <unfinished ...>
>13090 <... close resumed> )             = 0
>29395 <... rt_sigaction resumed> NULL, 8) = 0
>13090 close(22 <unfinished ...>
>29395 rt_sigprocmask(SIG_SETMASK, [],  <unfinished ...>
>13090 <... close resumed> )             = 0
>29395 <... rt_sigprocmask resumed> NULL, 8) = 0
>13090 close(23 <unfinished ...>
>29395 execve("/usr/lib/cups/backend/socket", ["socket://10.0.150.1:9100", "2094", "wd", "testfile.ps", "1", "finishings=3 media=iso_a4_210x29"...], [/* 31 vars */] <unfinished ...>
>13090 <... close resumed> )             = 0
>29394 <... execve resumed> )            = 0
>13090 access("/usr/lib/cups/backend/socket", F_OK <unfinished ...>
>29394 brk(0 <unfinished ...>
>13090 <... access resumed> )            = 0
>29394 <... brk resumed> )               = 0x7f254b05c000
>13090 close(19 <unfinished ...>
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>13090 <... close resumed> )             = 0
>29394 <... mmap resumed> )              = 0x7f2549238000
>29394 access("/etc/ld.so.preload", R_OK <unfinished ...>
>13090 epoll_ctl(5, EPOLL_CTL_ADD, 18, {...} <unfinished ...>
>29394 <... access resumed> )            = -1 ENOENT (No such file or directory)
>29394 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC <unfinished ...>
>13090 <... epoll_ctl resumed> )         = 0
>29394 <... open resumed> )              = 6
>29394 fstat(6, {st_mode=S_IFREG|0644, st_size=269762, ...}) = 0
>29394 mmap(NULL, 269762, PROT_READ, MAP_PRIVATE, 6, 0) = 0x7f25491f6000
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\23\0\0\0e\2\0\0q\0\0\0\1\1o\0\32\0\0\0/com/red"..., 136}, {"\2\0\0\0lp\0\0.\10\0\0\2\0\0\0wd\0", 19}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL <unfinished ...>
>29394 close(6)                          = 0
>13090 <... sendmsg resumed> )           = 155
>29394 open("/lib64/libcups.so.2", O_RDONLY|O_CLOEXEC) = 6
>13090 sendto(16, "HTTP/1.1 200 OK\r\nDate: Fri, 08 F"..., 199, 0, NULL, 0 <unfinished ...>
>29394 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\27\1\3011\0\0\0"..., 832) = 832
>29394 fstat(6, {st_mode=S_IFREG|0755, st_size=379328, ...}) = 0
>29394 mmap(NULL, 2469480, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>13090 <... sendto resumed> )            = 199
>29394 <... mmap resumed> )              = 0x7f2548dbe000
>13090 epoll_ctl(5, EPOLL_CTL_MOD, 16, {...} <unfinished ...>
>29394 mprotect(0x7f2548e15000, 2093056, PROT_NONE <unfinished ...>
>13090 <... epoll_ctl resumed> )         = 0
>29394 <... mprotect resumed> )          = 0
>13090 epoll_wait(5,  <unfinished ...>
>29394 mmap(0x7f2549014000, 20480, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x56000 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 <... mmap resumed> )              = 0x7f2549014000
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... execve resumed> )            = 0
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 brk(0 <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... brk resumed> )               = 0x7fabebea0000
>29394 <... close resumed> )             = 0
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 epoll_wait(5,  <unfinished ...>
>29394 open("/lib64/libgssapi_krb5.so.2", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... mmap resumed> )              = 0x7fabea42e000
>29394 read(6,  <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 access("/etc/ld.so.preload", R_OK <unfinished ...>
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\255\300\2511\0\0\0"..., 832) = 832
>29395 <... access resumed> )            = -1 ENOENT (No such file or directory)
>29394 fstat(6,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=281336, ...}) = 0
>29395 <... open resumed> )              = 6
>29394 mmap(NULL, 2369536, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 fstat(6,  <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2548b7b000
>29395 <... fstat resumed> {st_mode=S_IFREG|0644, st_size=269762, ...}) = 0
>29394 mprotect(0x7f2548bbc000, 2093056, PROT_NONE <unfinished ...>
>29395 mmap(NULL, 269762, PROT_READ, MAP_PRIVATE, 6, 0 <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... mmap resumed> )              = 0x7fabea3ec000
>29394 mmap(0x7f2548dbb000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x40000 <unfinished ...>
>29395 close(6 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2548dbb000
>29395 <... close resumed> )             = 0
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 close(6 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 open("/lib64/libcups.so.2", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... open resumed> )              = 6
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 open("/lib64/libkrb5.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 read(6,  <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\27\1\3011\0\0\0"..., 832) = 832
>29394 read(6,  <unfinished ...>
>29395 fstat(6,  <unfinished ...>
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\266A\2521\0\0\0"..., 832) = 832
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=379328, ...}) = 0
>29394 fstat(6,  <unfinished ...>
>29395 mmap(NULL, 2469480, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=952200, ...}) = 0
>29395 <... mmap resumed> )              = 0x7fabe9fb4000
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 mprotect(0x7fabea00b000, 2093056, PROT_NONE <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25491f5000
>29395 <... mprotect resumed> )          = 0
>29394 mmap(NULL, 3033824, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 mmap(0x7fabea20a000, 20480, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x56000 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2548896000
>29395 <... mmap resumed> )              = 0x7fabea20a000
>29394 mprotect(0x7f254896f000, 2097152, PROT_NONE <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 close(6 <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... close resumed> )             = 0
>29394 mmap(0x7f2548b6f000, 49152, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xd9000 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 open("/lib64/libgssapi_krb5.so.2", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2548b6f000
>29395 <... open resumed> )              = 6
>13090 sendto(16, "\1\1\0\0\0\0\0\1\1G\0\22attributes-charset\0\5"..., 176, 0, NULL, 0 <unfinished ...>
>29395 read(6,  <unfinished ...>
>29394 close(6 <unfinished ...>
>13090 <... sendto resumed> )            = 176
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\255\300\2511\0\0\0"..., 832) = 832
>29394 <... close resumed> )             = 0
>13090 stat("/var/log/cups/access_log",  <unfinished ...>
>29395 fstat(6,  <unfinished ...>
>29394 open("/lib64/libk5crypto.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>13090 <... stat resumed> {st_mode=S_IFREG|0600, st_size=3506, ...}) = 0
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=281336, ...}) = 0
>29394 <... open resumed> )              = 6
>13090 write(6, "localhost - - [08/Feb/2013:09:23"..., 111 <unfinished ...>
>29395 mmap(NULL, 2369536, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 read(6,  <unfinished ...>
>13090 <... write resumed> )             = 111
>29395 <... mmap resumed> )              = 0x7fabe9d71000
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320D\200\2511\0\0\0"..., 832) = 832
>13090 epoll_ctl(5, EPOLL_CTL_MOD, 16, {...} <unfinished ...>
>29395 mprotect(0x7fabe9db2000, 2093056, PROT_NONE <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>13090 <... epoll_ctl resumed> )         = 0
>29395 <... mprotect resumed> )          = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=175904, ...}) = 0
>13090 epoll_wait(5,  <unfinished ...>
>29395 mmap(0x7fabe9fb1000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x40000 <unfinished ...>
>29394 mmap(NULL, 2269616, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 <... mmap resumed> )              = 0x7fabe9fb1000
>29394 <... mmap resumed> )              = 0x7f254866b000
>13090 poll([{fd=16, events=POLLIN}], 1, 10000 <unfinished ...>
>29395 close(6 <unfinished ...>
>29394 mprotect(0x7f2548693000, 2097152, PROT_NONE <unfinished ...>
>13090 <... poll resumed> )              = 1 ([{fd=16, revents=POLLIN|POLLHUP}])
>29395 <... close resumed> )             = 0
>29394 <... mprotect resumed> )          = 0
>13090 recvfrom(16,  <unfinished ...>
>29395 open("/lib64/libkrb5.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mmap(0x7f2548893000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x28000 <unfinished ...>
>13090 <... recvfrom resumed> "", 2048, 0, NULL, NULL) = 0
>29395 <... open resumed> )              = 6
>29394 <... mmap resumed> )              = 0x7f2548893000
>13090 epoll_ctl(5, EPOLL_CTL_DEL, 16, {...} <unfinished ...>
>29395 read(6,  <unfinished ...>
>29394 mmap(0x7f2548895000, 432, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>13090 <... epoll_ctl resumed> )         = 0
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\266A\2521\0\0\0"..., 832) = 832
>29394 <... mmap resumed> )              = 0x7f2548895000
>13090 close(16 <unfinished ...>
>29395 fstat(6,  <unfinished ...>
>29394 close(6 <unfinished ...>
>13090 <... close resumed> )             = 0
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=952200, ...}) = 0
>29394 <... close resumed> )             = 0
>13090 epoll_wait(5,  <unfinished ...>
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 open("/lib64/libcom_err.so.2", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabea3eb000
>29394 <... open resumed> )              = 6
>29395 mmap(NULL, 3033824, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe9a8c000
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`\25\0\2511\0\0\0"..., 832) = 832
>29395 mprotect(0x7fabe9b65000, 2097152, PROT_NONE <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=18296, ...}) = 0
>29395 mmap(0x7fabe9d65000, 49152, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xd9000 <unfinished ...>
>29394 mmap(NULL, 2109928, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe9d65000
>29394 <... mmap resumed> )              = 0x7f2548467000
>29395 close(6 <unfinished ...>
>29394 mprotect(0x7f254846a000, 2093056, PROT_NONE <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... mprotect resumed> )          = 0
>29395 open("/lib64/libk5crypto.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mmap(0x7f2548669000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x2000 <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... mmap resumed> )              = 0x7f2548669000
>29395 read(6,  <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320D\200\2511\0\0\0"..., 832) = 832
>29394 <... close resumed> )             = 0
>29395 fstat(6,  <unfinished ...>
>29394 open("/lib64/libgnutls.so.26", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=175904, ...}) = 0
>29394 <... open resumed> )              = 6
>29395 mmap(NULL, 2269616, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe9861000
>29395 mprotect(0x7fabe9889000, 2097152, PROT_NONE) = 0
>29395 mmap(0x7fabe9a89000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x28000) = 0x7fabe9a89000
>29395 mmap(0x7fabe9a8b000, 432, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fabe9a8b000
>29395 close(6)                          = 0
>29395 open("/lib64/libcom_err.so.2", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`\25\0\2511\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=18296, ...}) = 0
>29395 mmap(NULL, 2109928, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe965d000
>29394 read(6,  <unfinished ...>
>29395 mprotect(0x7fabe9660000, 2093056, PROT_NONE <unfinished ...>
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0p\212\341\3101\0\0\0"..., 832) = 832
>29395 <... mprotect resumed> )          = 0
>29394 fstat(6,  <unfinished ...>
>29395 mmap(0x7fabe985f000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x2000 <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=770912, ...}) = 0
>29395 <... mmap resumed> )              = 0x7fabe985f000
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 close(6 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25491f4000
>29395 <... close resumed> )             = 0
>29394 mmap(NULL, 2854000, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 open("/lib64/libgnutls.so.26", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25481ae000
>29395 <... open resumed> )              = 6
>29394 mprotect(0x7f254825f000, 2097152, PROT_NONE <unfinished ...>
>29395 read(6,  <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0p\212\341\3101\0\0\0"..., 832) = 832
>29394 mmap(0x7f254845f000, 32768, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xb1000 <unfinished ...>
>29395 fstat(6,  <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f254845f000
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=770912, ...}) = 0
>29394 close(6 <unfinished ...>
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... mmap resumed> )              = 0x7fabea3ea000
>29395 mmap(NULL, 2854000, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 open("/lib64/libgcrypt.so.11", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe93a4000
>29394 <... open resumed> )              = 6
>29395 mprotect(0x7fabe9455000, 2097152, PROT_NONE <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0r\200\3021\0\0\0"..., 832) = 832
>29395 mmap(0x7fabe9655000, 32768, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xb1000 <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe9655000
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=502000, ...}) = 0
>29395 close(6 <unfinished ...>
>29394 mmap(NULL, 2587584, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... mmap resumed> )              = 0x7f2547f36000
>29395 open("/lib64/libgcrypt.so.11", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mprotect(0x7f2547fab000, 2093056, PROT_NONE <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... mprotect resumed> )          = 0
>29395 read(6,  <unfinished ...>
>29394 mmap(0x7f25481aa000, 16384, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x74000 <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0r\200\3021\0\0\0"..., 832) = 832
>29394 <... mmap resumed> )              = 0x7f25481aa000
>29395 fstat(6,  <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=502000, ...}) = 0
>29394 <... close resumed> )             = 0
>29395 mmap(NULL, 2587584, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 open("/lib64/libdl.so.2", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe912c000
>29394 <... open resumed> )              = 6
>29395 mprotect(0x7fabe91a1000, 2093056, PROT_NONE <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\16\0\2401\0\0\0"..., 832) = 832
>29395 mmap(0x7fabe93a0000, 16384, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x74000 <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe93a0000
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=22440, ...}) = 0
>29395 close(6 <unfinished ...>
>29394 mmap(NULL, 2109736, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... mmap resumed> )              = 0x7f2547d32000
>29395 open("/lib64/libdl.so.2", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mprotect(0x7f2547d35000, 2093056, PROT_NONE <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... mprotect resumed> )          = 0
>29395 read(6,  <unfinished ...>
>29394 mmap(0x7f2547f34000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x2000 <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\16\0\2401\0\0\0"..., 832) = 832
>29394 <... mmap resumed> )              = 0x7f2547f34000
>29395 fstat(6,  <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=22440, ...}) = 0
>29394 <... close resumed> )             = 0
>29395 mmap(NULL, 2109736, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 open("/lib64/libgpg-error.so.0", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe8f28000
>29394 <... open resumed> )              = 6
>29395 mprotect(0x7fabe8f2b000, 2093056, PROT_NONE <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\t\200\3001\0\0\0"..., 832) = 832
>29395 mmap(0x7fabe912a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x2000 <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe912a000
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=17592, ...}) = 0
>29395 close(6 <unfinished ...>
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... mmap resumed> )              = 0x7f25491f3000
>29395 open("/lib64/libgpg-error.so.0", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mmap(NULL, 2109528, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... mmap resumed> )              = 0x7f2547b2e000
>29395 read(6,  <unfinished ...>
>29394 mprotect(0x7f2547b31000, 2093056, PROT_NONE <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\t\200\3001\0\0\0"..., 832) = 832
>29394 <... mprotect resumed> )          = 0
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=17592, ...}) = 0
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fabea3e9000
>29395 mmap(NULL, 2109528, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe8d24000
>29395 mprotect(0x7fabe8d27000, 2093056, PROT_NONE) = 0
>29395 mmap(0x7fabe8f26000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x2000) = 0x7fabe8f26000
>29395 close(6)                          = 0
>29395 open("/lib64/libavahi-common.so.3", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\00005`\3071\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=56056, ...}) = 0
>29395 mmap(NULL, 2147640, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe8b17000
>29395 mprotect(0x7fabe8b22000, 2097152, PROT_NONE) = 0
>29395 mmap(0x7fabe8d22000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xb000) = 0x7fabe8d22000
>29395 close(6)                          = 0
>29395 open("/lib64/libavahi-client.so.3", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\3209\240\3101\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=72576, ...}) = 0
>29395 mmap(NULL, 2163768, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe8906000
>29395 mprotect(0x7fabe8916000, 2093056, PROT_NONE) = 0
>29395 mmap(0x7fabe8b15000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xf000) = 0x7fabe8b15000
>29395 close(6)                          = 0
>29395 open("/lib64/libz.so.1", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220!\300\2401\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=92560, ...}) = 0
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fabea3e8000
>29395 mmap(NULL, 2183688, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe86f0000
>29395 mprotect(0x7fabe8705000, 2093056, PROT_NONE) = 0
>29395 mmap(0x7fabe8904000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x14000) = 0x7fabe8904000
>29395 close(6)                          = 0
>29395 open("/lib64/libpthread.so.0", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\360j@\2401\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=144552, ...}) = 0
>29395 mmap(NULL, 2208808, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe84d4000
>29395 mprotect(0x7fabe84ea000, 2097152, PROT_NONE) = 0
>29395 mmap(0x7fabe86ea000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x16000) = 0x7fabe86ea000
>29395 mmap(0x7fabe86ec000, 13352, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fabe86ec000
>29395 close(6)                          = 0
>29395 open("/lib64/libcrypt.so.1", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\16 \2721\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=43808, ...}) = 0
>29395 mmap(NULL, 2318912, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe829d000
>29395 mprotect(0x7fabe82a5000, 2093056, PROT_NONE) = 0
>29395 mmap(0x7fabe84a4000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x7000) = 0x7fabe84a4000
>29395 mmap(0x7fabe84a6000, 184896, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fabe84a6000
>29395 close(6)                          = 0
>29395 open("/lib64/libm.so.6", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260U\300\2371\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=1139968, ...}) = 0
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fabea3e7000
>29395 mmap(NULL, 3146024, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe7f9c000
>29395 mprotect(0x7fabe809c000, 2093056, PROT_NONE) = 0
>29395 mmap(0x7fabe829b000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xff000) = 0x7fabe829b000
>29395 close(6)                          = 0
>29395 open("/lib64/libaudit.so.1", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\360(\0\2540\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=108680, ...}) = 0
>29395 mmap(NULL, 2216512, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe7d7e000
>29395 mprotect(0x7fabe7d97000, 2093056, PROT_NONE) = 0
>29395 mmap(0x7fabe7f96000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x18000) = 0x7fabe7f96000
>29395 mmap(0x7fabe7f98000, 12864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fabe7f98000
>29395 close(6)                          = 0
>29395 open("/lib64/libselinux.so.1", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0pa\0\2421\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=136440, ...}) = 0
>29395 mmap(NULL, 2234408, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe7b5c000
>29395 mprotect(0x7fabe7b7b000, 2093056, PROT_NONE) = 0
>29395 mmap(0x7fabe7d7a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x1e000) = 0x7fabe7d7a000
>29395 mmap(0x7fabe7d7c000, 6184, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fabe7d7c000
>29395 close(6)                          = 0
>29395 open("/lib64/libc.so.6", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\33\202\2371\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=2071376, ...}) = 0
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7fabea3e6000
>29395 mmap(NULL, 3896312, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe77a4000
>29395 mprotect(0x7fabe7951000, 2097152, PROT_NONE) = 0
>29395 mmap(0x7fabe7b51000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x1ad000) = 0x7fabe7b51000
>29395 mmap(0x7fabe7b57000, 17400, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7fabe7b57000
>29395 close(6)                          = 0
>29395 open("/lib64/libkrb5support.so.0", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0P+\0\2521\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=48000, ...}) = 0
>29395 mmap(NULL, 2139280, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7fabe7599000
>29395 mprotect(0x7fabe75a3000, 2093056, PROT_NONE) = 0
>29395 mmap(0x7fabe77a2000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x9000) = 0x7fabe77a2000
>29395 close(6)                          = 0
>29395 open("/lib64/libkeyutils.so.1", O_RDONLY|O_CLOEXEC) = 6
>29395 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\21\200\2521\0\0\0"..., 832) = 832
>29395 fstat(6, {st_mode=S_IFREG|0755, st_size=17880, ...}) = 0
>29395 mmap(NULL, 2109608, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 mmap(0x7f2547d30000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x2000 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe7395000
>29394 <... mmap resumed> )              = 0x7f2547d30000
>29395 mprotect(0x7fabe7398000, 2093056, PROT_NONE <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... close resumed> )             = 0
>29395 mmap(0x7fabe7597000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x2000 <unfinished ...>
>29394 open("/lib64/libavahi-common.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe7597000
>29394 <... open resumed> )              = 6
>29395 close(6 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\00005`\3071\0\0\0"..., 832) = 832
>29395 open("/lib64/libresolv.so.2", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=56056, ...}) = 0
>29395 read(6,  <unfinished ...>
>29394 mmap(NULL, 2147640, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0000:\300\2411\0\0\0"..., 832) = 832
>29394 <... mmap resumed> )              = 0x7f2547921000
>29395 fstat(6,  <unfinished ...>
>29394 mprotect(0x7f254792c000, 2097152, PROT_NONE <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=109704, ...}) = 0
>29394 <... mprotect resumed> )          = 0
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 mmap(0x7f2547b2c000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xb000 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabea3e5000
>29394 <... mmap resumed> )              = 0x7f2547b2c000
>29395 mmap(NULL, 2198168, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe717c000
>29394 <... close resumed> )             = 0
>29395 mprotect(0x7fabe7192000, 2093056, PROT_NONE <unfinished ...>
>29394 open("/lib64/libavahi-client.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... open resumed> )              = 6
>29395 mmap(0x7fabe7391000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x15000 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe7391000
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\3209\240\3101\0\0\0"..., 832) = 832
>29395 mmap(0x7fabe7393000, 6808, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe7393000
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=72576, ...}) = 0
>29395 close(6 <unfinished ...>
>29394 mmap(NULL, 2163768, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... mmap resumed> )              = 0x7f2547710000
>29395 open("/lib64/libgcc_s.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mprotect(0x7f2547720000, 2093056, PROT_NONE <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... mprotect resumed> )          = 0
>29395 read(6,  <unfinished ...>
>29394 mmap(0x7f254791f000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xf000 <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0@*\0\2411\0\0\0"..., 832) = 832
>29394 <... mmap resumed> )              = 0x7f254791f000
>29395 fstat(6,  <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=91352, ...}) = 0
>29394 <... close resumed> )             = 0
>29395 mmap(NULL, 2184216, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 open("/lib64/libz.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe6f66000
>29394 <... open resumed> )              = 6
>29395 mprotect(0x7fabe6f7b000, 2093056, PROT_NONE <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220!\300\2401\0\0\0"..., 832) = 832
>29395 mmap(0x7fabe717a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x14000 <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe717a000
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=92560, ...}) = 0
>29395 close(6 <unfinished ...>
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... mmap resumed> )              = 0x7f25491f2000
>29395 open("/lib64/libtasn1.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mmap(NULL, 2183688, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... mmap resumed> )              = 0x7f25474fa000
>29395 read(6,  <unfinished ...>
>29394 mprotect(0x7f254750f000, 2093056, PROT_NONE <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0\35 \3111\0\0\0"..., 832) = 832
>29394 <... mprotect resumed> )          = 0
>29395 fstat(6,  <unfinished ...>
>29394 mmap(0x7f254770e000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x14000 <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=71968, ...}) = 0
>29394 <... mmap resumed> )              = 0x7f254770e000
>29395 mmap(NULL, 2163656, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe6d55000
>29394 <... close resumed> )             = 0
>29395 mprotect(0x7fabe6d65000, 2093056, PROT_NONE <unfinished ...>
>29394 open("/lib64/libpthread.so.0", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... open resumed> )              = 6
>29395 mmap(0x7fabe6f64000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xf000 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe6f64000
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\360j@\2401\0\0\0"..., 832) = 832
>29395 close(6 <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=144552, ...}) = 0
>29395 open("/lib64/libp11-kit.so.0", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mmap(NULL, 2208808, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... mmap resumed> )              = 0x7f25472de000
>29395 read(6,  <unfinished ...>
>29394 mprotect(0x7f25472f4000, 2097152, PROT_NONE <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320.`\3061\0\0\0"..., 832) = 832
>29394 <... mprotect resumed> )          = 0
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 mmap(0x7f25474f4000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x16000 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe6d54000
>29394 <... mmap resumed> )              = 0x7f25474f4000
>29395 fstat(6,  <unfinished ...>
>29394 mmap(0x7f25474f6000, 13352, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=86256, ...}) = 0
>29394 <... mmap resumed> )              = 0x7f25474f6000
>29395 mmap(NULL, 2176368, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe6b40000
>29394 <... close resumed> )             = 0
>29395 mprotect(0x7fabe6b53000, 2093056, PROT_NONE <unfinished ...>
>29394 open("/lib64/libcrypt.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... open resumed> )              = 6
>29395 mmap(0x7fabe6d52000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x12000 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe6d52000
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\16 \2721\0\0\0"..., 832) = 832
>29395 close(6 <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=43808, ...}) = 0
>29395 open("/lib64/libdbus-1.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 mmap(NULL, 2318912, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... open resumed> )              = 6
>29394 <... mmap resumed> )              = 0x7f25470a7000
>29395 read(6,  <unfinished ...>
>29394 mprotect(0x7f25470af000, 2093056, PROT_NONE <unfinished ...>
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260z\0\2501\0\0\0"..., 832) = 832
>29394 <... mprotect resumed> )          = 0
>29395 fstat(6,  <unfinished ...>
>29394 mmap(0x7f25472ae000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x7000 <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=294560, ...}) = 0
>29394 <... mmap resumed> )              = 0x7f25472ae000
>29395 mmap(NULL, 2378208, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 mmap(0x7f25472b0000, 184896, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabe68fb000
>29394 <... mmap resumed> )              = 0x7f25472b0000
>29394 close(6 <unfinished ...>
>29395 mprotect(0x7fabe693f000, 2093056, PROT_NONE <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... mprotect resumed> )          = 0
>29394 open("/lib64/libm.so.6", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 mmap(0x7fabe6b3e000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x43000 <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... mmap resumed> )              = 0x7fabe6b3e000
>29394 read(6,  <unfinished ...>
>29395 close(6 <unfinished ...>
>29394 <... read resumed> "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260U\300\2371\0\0\0"..., 832) = 832
>29395 <... close resumed> )             = 0
>29394 fstat(6,  <unfinished ...>
>29395 open("/lib64/libfreebl3.so", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=1139968, ...}) = 0
>29395 <... open resumed> )              = 6
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 read(6,  <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25491f1000
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`6\340\2711\0\0\0"..., 832) = 832
>29394 mmap(NULL, 3146024, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 fstat(6,  <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2546da6000
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=421656, ...}) = 0
>29394 mprotect(0x7f2546ea6000, 2093056, PROT_NONE <unfinished ...>
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... mmap resumed> )              = 0x7fabea3e4000
>29394 mmap(0x7f25470a5000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xff000 <unfinished ...>
>29395 mmap(NULL, 2525024, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25470a5000
>29395 <... mmap resumed> )              = 0x7fabe6692000
>29394 close(6 <unfinished ...>
>29395 mprotect(0x7fabe66f5000, 2097152, PROT_NONE <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... mprotect resumed> )          = 0
>29394 open("/lib64/libaudit.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 mmap(0x7fabe68f5000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x63000 <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... mmap resumed> )              = 0x7fabe68f5000
>29394 read(6,  <unfinished ...>
>29395 mmap(0x7fabe68f7000, 14176, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\360(\0\2540\0\0\0"..., 832) = 832
>29395 <... mmap resumed> )              = 0x7fabe68f7000
>29394 fstat(6,  <unfinished ...>
>29395 close(6 <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=108680, ...}) = 0
>29395 <... close resumed> )             = 0
>29394 mmap(NULL, 2216512, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 open("/lib64/libpcre.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2546b88000
>29395 <... open resumed> )              = 6
>29394 mprotect(0x7f2546ba1000, 2093056, PROT_NONE <unfinished ...>
>29395 read(6,  <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260\35\200\2411\0\0\0"..., 832) = 832
>29394 mmap(0x7f2546da0000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x18000 <unfinished ...>
>29395 fstat(6,  <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2546da0000
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=388152, ...}) = 0
>29394 mmap(0x7f2546da2000, 12864, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 mmap(NULL, 2478664, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2546da2000
>29395 <... mmap resumed> )              = 0x7fabe6434000
>29394 close(6 <unfinished ...>
>29395 mprotect(0x7fabe6490000, 2097152, PROT_NONE <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... mprotect resumed> )          = 0
>29394 open("/lib64/libselinux.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 mmap(0x7fabe6690000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x5c000 <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... mmap resumed> )              = 0x7fabe6690000
>29394 read(6,  <unfinished ...>
>29395 close(6 <unfinished ...>
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0pa\0\2421\0\0\0"..., 832) = 832
>29395 <... close resumed> )             = 0
>29394 fstat(6,  <unfinished ...>
>29395 open("/lib64/librt.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=136440, ...}) = 0
>29395 <... open resumed> )              = 6
>29394 mmap(NULL, 2234408, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 read(6,  <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2546966000
>29395 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\"\200\2401\0\0\0"..., 832) = 832
>29394 mprotect(0x7f2546985000, 2093056, PROT_NONE <unfinished ...>
>29395 fstat(6,  <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=47624, ...}) = 0
>29394 mmap(0x7f2546b84000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x1e000 <unfinished ...>
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2546b84000
>29395 <... mmap resumed> )              = 0x7fabea3e3000
>29394 mmap(0x7f2546b86000, 6184, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 mmap(NULL, 2128984, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2546b86000
>29395 <... mmap resumed> )              = 0x7fabe622c000
>29394 close(6 <unfinished ...>
>29395 mprotect(0x7fabe6233000, 2093056, PROT_NONE <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... mprotect resumed> )          = 0
>29394 open("/lib64/libc.so.6", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 mmap(0x7fabe6432000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x6000 <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... mmap resumed> )              = 0x7fabe6432000
>29394 read(6,  <unfinished ...>
>29395 close(6 <unfinished ...>
>29394 <... read resumed> "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\33\202\2371\0\0\0"..., 832) = 832
>29395 <... close resumed> )             = 0
>29394 fstat(6,  <unfinished ...>
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=2071376, ...}) = 0
>29395 <... mmap resumed> )              = 0x7fabe622b000
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25491f0000
>29395 <... mmap resumed> )              = 0x7fabe622a000
>29394 mmap(NULL, 3896312, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25465ae000
>29395 <... mmap resumed> )              = 0x7fabe6228000
>29394 mprotect(0x7f254675b000, 2097152, PROT_NONE <unfinished ...>
>29395 arch_prctl(ARCH_SET_FS, 0x7fabe6228800 <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... arch_prctl resumed> )        = 0
>29394 mmap(0x7f254695b000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x1ad000 <unfinished ...>
>29395 mprotect(0x7fabe7b51000, 16384, PROT_READ <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f254695b000
>29395 <... mprotect resumed> )          = 0
>29394 mmap(0x7f2546961000, 17400, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 mprotect(0x7fabe86ea000, 4096, PROT_READ <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2546961000
>29395 <... mprotect resumed> )          = 0
>29394 close(6 <unfinished ...>
>29395 mprotect(0x7fabe6432000, 4096, PROT_READ <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... mprotect resumed> )          = 0
>29394 open("/lib64/libkrb5support.so.0", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 mprotect(0x7fabe6690000, 4096, PROT_READ <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... mprotect resumed> )          = 0
>29394 read(6,  <unfinished ...>
>29395 mprotect(0x7fabe912a000, 4096, PROT_READ <unfinished ...>
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0P+\0\2521\0\0\0"..., 832) = 832
>29395 <... mprotect resumed> )          = 0
>29394 fstat(6,  <unfinished ...>
>29395 mprotect(0x7fabe68f5000, 4096, PROT_READ <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=48000, ...}) = 0
>29395 <... mprotect resumed> )          = 0
>29394 mmap(NULL, 2139280, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 mprotect(0x7fabe6b3e000, 4096, PROT_READ <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25463a3000
>29395 <... mprotect resumed> )          = 0
>29395 mprotect(0x7fabe6d52000, 4096, PROT_READ <unfinished ...>
>29394 mprotect(0x7f25463ad000, 2093056, PROT_NONE <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mprotect resumed> )          = 0
>29395 mprotect(0x7fabe6f64000, 4096, PROT_READ <unfinished ...>
>29394 mmap(0x7f25465ac000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x9000 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mmap resumed> )              = 0x7f25465ac000
>29395 mprotect(0x7fabe717a000, 4096, PROT_READ <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... close resumed> )             = 0
>29395 mprotect(0x7fabe7391000, 4096, PROT_READ <unfinished ...>
>29394 open("/lib64/libkeyutils.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... open resumed> )              = 6
>29395 mprotect(0x7fabe7597000, 4096, PROT_READ <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\21\200\2521\0\0\0"..., 832) = 832
>29395 mprotect(0x7fabe7d7a000, 4096, PROT_READ <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=17880, ...}) = 0
>29395 mprotect(0x7fabe77a2000, 4096, PROT_READ <unfinished ...>
>29394 mmap(NULL, 2109608, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mmap resumed> )              = 0x7f254619f000
>29395 mprotect(0x7fabe7f96000, 4096, PROT_READ <unfinished ...>
>29394 mprotect(0x7f25461a2000, 2093056, PROT_NONE <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mprotect resumed> )          = 0
>29395 mprotect(0x7fabe829b000, 4096, PROT_READ <unfinished ...>
>29394 mmap(0x7f25463a1000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x2000 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mmap resumed> )              = 0x7f25463a1000
>29395 mprotect(0x7fabe84a4000, 4096, PROT_READ <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... close resumed> )             = 0
>29395 mprotect(0x7fabe8904000, 4096, PROT_READ <unfinished ...>
>29394 open("/lib64/libresolv.so.2", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... open resumed> )              = 6
>29395 mprotect(0x7fabe8d22000, 4096, PROT_READ <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0000:\300\2411\0\0\0"..., 832) = 832
>29395 mprotect(0x7fabe8b15000, 4096, PROT_READ <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=109704, ...}) = 0
>29395 mprotect(0x7fabe8f26000, 4096, PROT_READ <unfinished ...>
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mmap resumed> )              = 0x7f25491ef000
>29395 mprotect(0x7fabe93a0000, 4096, PROT_READ <unfinished ...>
>29394 mmap(NULL, 2198168, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mmap resumed> )              = 0x7f2545f86000
>29395 mprotect(0x7fabe9655000, 24576, PROT_READ <unfinished ...>
>29394 mprotect(0x7f2545f9c000, 2093056, PROT_NONE <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mprotect resumed> )          = 0
>29394 mmap(0x7f254619b000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x15000 <unfinished ...>
>29395 mprotect(0x7fabe985f000, 4096, PROT_READ <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f254619b000
>29395 <... mprotect resumed> )          = 0
>29394 mmap(0x7f254619d000, 6808, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f254619d000
>29395 mprotect(0x7fabe9a89000, 4096, PROT_READ <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... close resumed> )             = 0
>29394 open("/lib64/libgcc_s.so.1", O_RDONLY|O_CLOEXEC) = 6
>29394 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0@*\0\2411\0\0\0"..., 832) = 832
>29394 fstat(6, {st_mode=S_IFREG|0755, st_size=91352, ...}) = 0
>29394 mmap(NULL, 2184216, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7f2545d70000
>29394 mprotect(0x7f2545d85000, 2093056, PROT_NONE) = 0
>29394 mmap(0x7f2545f84000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x14000) = 0x7f2545f84000
>29394 close(6 <unfinished ...>
>29395 mprotect(0x7fabe9d65000, 40960, PROT_READ <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... mprotect resumed> )          = 0
>29394 open("/lib64/libtasn1.so.3", O_RDONLY|O_CLOEXEC) = 6
>29394 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0\35 \3111\0\0\0"..., 832) = 832
>29394 fstat(6, {st_mode=S_IFREG|0755, st_size=71968, ...}) = 0
>29394 mmap(NULL, 2163656, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 mprotect(0x7fabe9fb1000, 4096, PROT_READ <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2545b5f000
>29395 <... mprotect resumed> )          = 0
>29394 mprotect(0x7f2545b6f000, 2093056, PROT_NONE) = 0
>29394 mmap(0x7f2545d6e000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0xf000) = 0x7f2545d6e000
>29394 close(6)                          = 0
>29394 open("/lib64/libp11-kit.so.0", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 mprotect(0x7fabea20a000, 16384, PROT_READ <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... mprotect resumed> )          = 0
>29394 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320.`\3061\0\0\0"..., 832) = 832
>29395 mprotect(0x7fabea639000, 4096, PROT_READ <unfinished ...>
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 <... mprotect resumed> )          = 0
>29394 <... mmap resumed> )              = 0x7f2545b5e000
>29394 fstat(6,  <unfinished ...>
>29395 mprotect(0x7fabea42f000, 4096, PROT_READ <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=86256, ...}) = 0
>29395 <... mprotect resumed> )          = 0
>29394 mmap(NULL, 2176368, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 munmap(0x7fabea3ec000, 269762 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f254594a000
>29394 mprotect(0x7f254595d000, 2093056, PROT_NONE <unfinished ...>
>29395 <... munmap resumed> )            = 0
>29394 <... mprotect resumed> )          = 0
>29395 set_tid_address(0x7fabe6228ad0 <unfinished ...>
>29394 mmap(0x7f2545b5c000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x12000 <unfinished ...>
>29395 <... set_tid_address resumed> )   = 29395
>29394 <... mmap resumed> )              = 0x7f2545b5c000
>29395 set_robust_list(0x7fabe6228ae0, 24 <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... set_robust_list resumed> )   = 0
>29394 <... close resumed> )             = 0
>29395 rt_sigaction(SIGRTMIN, {0x7fabe84da650, [], SA_RESTORER|SA_SIGINFO, 0x7fabe84e3000},  <unfinished ...>
>29394 open("/lib64/libdbus-1.so.3", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 <... rt_sigaction resumed> NULL, 8) = 0
>29394 <... open resumed> )              = 6
>29395 rt_sigaction(SIGRT_1, {0x7fabe84da6d0, [], SA_RESTORER|SA_RESTART|SA_SIGINFO, 0x7fabe84e3000},  <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... rt_sigaction resumed> NULL, 8) = 0
>29394 <... read resumed> "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260z\0\2501\0\0\0"..., 832) = 832
>29395 rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1],  <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... rt_sigprocmask resumed> NULL, 8) = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=294560, ...}) = 0
>29395 getrlimit(RLIMIT_STACK,  <unfinished ...>
>29394 mmap(NULL, 2378208, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... getrlimit resumed> {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0
>29394 <... mmap resumed> )              = 0x7f2545705000
>29395 statfs("/sys/fs/selinux",  <unfinished ...>
>29394 mprotect(0x7f2545749000, 2093056, PROT_NONE) = 0
>29395 <... statfs resumed> 0x7fff83945a10) = -1 ENOENT (No such file or directory)
>29394 mmap(0x7f2545948000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x43000 <unfinished ...>
>29395 statfs("/selinux",  <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2545948000
>29395 <... statfs resumed> 0x7fff83945a10) = -1 ENOENT (No such file or directory)
>29394 close(6)                          = 0
>29394 open("/lib64/libfreebl3.so", O_RDONLY|O_CLOEXEC) = 6
>29394 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`6\340\2711\0\0\0"..., 832) = 832
>29394 fstat(6,  <unfinished ...>
>29395 brk(0 <unfinished ...>
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=421656, ...}) = 0
>29395 <... brk resumed> )               = 0x7fabebea0000
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 brk(0x7fabebec1000 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25491ee000
>29395 <... brk resumed> )               = 0x7fabebec1000
>29394 mmap(NULL, 2525024, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0) = 0x7f254549c000
>29395 open("/proc/filesystems", O_RDONLY <unfinished ...>
>29394 mprotect(0x7f25454ff000, 2097152, PROT_NONE) = 0
>29395 <... open resumed> )              = 6
>29394 mmap(0x7f25456ff000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x63000) = 0x7f25456ff000
>29395 fstat(6,  <unfinished ...>
>29394 mmap(0x7f2545701000, 14176, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 <... fstat resumed> {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
>29394 <... mmap resumed> )              = 0x7f2545701000
>29395 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29394 close(6 <unfinished ...>
>29395 <... mmap resumed> )              = 0x7fabea42d000
>29394 <... close resumed> )             = 0
>29395 read(6,  <unfinished ...>
>29394 open("/lib64/libpcre.so.1", O_RDONLY|O_CLOEXEC) = 6
>29395 <... read resumed> "nodev\tsysfs\nnodev\trootfs\nnodev\tb"..., 1024) = 410
>29394 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260\35\200\2411\0\0\0"..., 832) = 832
>29395 read(6,  <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... read resumed> "", 1024)      = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=388152, ...}) = 0
>29395 close(6 <unfinished ...>
>29394 mmap(NULL, 2478664, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 <... close resumed> )             = 0
>29394 <... mmap resumed> )              = 0x7f254523e000
>29395 munmap(0x7fabea42d000, 4096 <unfinished ...>
>29394 mprotect(0x7f254529a000, 2097152, PROT_NONE <unfinished ...>
>29395 <... munmap resumed> )            = 0
>29394 <... mprotect resumed> )          = 0
>29394 mmap(0x7f254549a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x5c000) = 0x7f254549a000
>29394 close(6)                          = 0
>29394 open("/lib64/librt.so.1", O_RDONLY|O_CLOEXEC <unfinished ...>
>29395 rt_sigaction(SIGPIPE, {SIG_IGN, [], SA_RESTORER, 0x7fabe84e3000},  <unfinished ...>
>29394 <... open resumed> )              = 6
>29395 <... rt_sigaction resumed> NULL, 8) = 0
>29394 read(6, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\"\200\2401\0\0\0"..., 832) = 832
>29395 futex(0x7fabea20ed28, FUTEX_WAKE_PRIVATE, 2147483647 <unfinished ...>
>29394 fstat(6,  <unfinished ...>
>29395 <... futex resumed> )             = 0
>29394 <... fstat resumed> {st_mode=S_IFREG|0755, st_size=47624, ...}) = 0
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 geteuid( <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f25491ed000
>29395 <... geteuid resumed> )           = 4
>29394 mmap(NULL, 2128984, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6, 0 <unfinished ...>
>29395 getuid( <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2545036000
>29395 <... getuid resumed> )            = 4
>29394 mprotect(0x7f254503d000, 2093056, PROT_NONE <unfinished ...>
>29395 getegid( <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... getegid resumed> )           = 7
>29394 mmap(0x7f254523c000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6, 0x6000 <unfinished ...>
>29395 getgid( <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f254523c000
>29395 <... getgid resumed> )            = 7
>29394 close(6 <unfinished ...>
>29395 write(2, "STATE: +connecting-to-device\n", 29 <unfinished ...>
>29394 <... close resumed> )             = 0
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "STATE: +connecting-to-device\n", 2047) = 29
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0f\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL <unfinished ...>
>29395 <... write resumed> )             = 29
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>13090 <... sendmsg resumed> )           = 135
>29395 write(2, "DEBUG: Looking up \"10.0.150.1\".."..., 34 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2545035000
>29395 <... write resumed> )             = 34
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>13090 read(18, "DEBUG: Looking up \"10.0.150.1\".."..., 2047) = 34
>29395 socket(PF_INET, SOCK_DGRAM, IPPROTO_IP <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2545034000
>29395 <... socket resumed> )            = 6
>13090 epoll_wait(5,  <unfinished ...>
>29394 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0 <unfinished ...>
>29395 setsockopt(6, SOL_SOCKET, SO_BROADCAST, [1], 4 <unfinished ...>
>29394 <... mmap resumed> )              = 0x7f2545032000
>29395 <... setsockopt resumed> )        = 0
>29394 arch_prctl(ARCH_SET_FS, 0x7f2545032800) = 0
>29395 open("/etc/cups/ppd/lp.ppd", O_RDONLY <unfinished ...>
>29394 mprotect(0x7f254695b000, 16384, PROT_READ <unfinished ...>
>29395 <... open resumed> )              = 7
>29394 <... mprotect resumed> )          = 0
>29395 fcntl(7, F_GETFD <unfinished ...>
>29394 mprotect(0x7f25474f4000, 4096, PROT_READ <unfinished ...>
>29395 <... fcntl resumed> )             = 0
>29394 <... mprotect resumed> )          = 0
>29395 fcntl(7, F_SETFD, FD_CLOEXEC <unfinished ...>
>29394 mprotect(0x7f254523c000, 4096, PROT_READ <unfinished ...>
>29395 <... fcntl resumed> )             = 0
>29394 <... mprotect resumed> )          = 0
>29395 read(7,  <unfinished ...>
>29394 mprotect(0x7f254549a000, 4096, PROT_READ <unfinished ...>
>29395 <... read resumed> "*PPD-Adobe: \"4.3\"\n*%============"..., 4096) = 4096
>29394 <... mprotect resumed> )          = 0
>29395 read(7,  <unfinished ...>
>29394 mprotect(0x7f2547f34000, 4096, PROT_READ <unfinished ...>
>29395 <... read resumed> "aultOption20: None\n*Option20 Non"..., 4096) = 4096
>29394 <... mprotect resumed> )          = 0
>29394 mprotect(0x7f25456ff000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2545948000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2545b5c000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2545d6e000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2545f84000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f254619b000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f25463a1000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2546b84000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f25465ac000, 4096, PROT_READ <unfinished ...>
>29395 read(7,  <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... read resumed> "0C *Option20 Two\n*UIConstraints:"..., 4096) = 4096
>29394 mprotect(0x7f2546da0000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f25470a5000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f25472ae000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f254770e000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2547b2c000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f254791f000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2547d30000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f25481aa000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f254845f000, 24576, PROT_READ) = 0
>29394 mprotect(0x7f2548669000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2548893000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2548b6f000, 40960, PROT_READ <unfinished ...>
>29395 read(7,  <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... read resumed> "straints: *KCCollate VMBAdmin *O"..., 4096) = 4096
>29394 mprotect(0x7f2548dbb000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2549014000, 16384, PROT_READ <unfinished ...>
>29395 read(7,  <unfinished ...>
>29394 <... mprotect resumed> )          = 0
>29395 <... read resumed> "ot EF1\n*UIConstraints: *InputSlo"..., 4096) = 4096
>29394 mprotect(0x7f2549448000, 4096, PROT_READ) = 0
>29394 mprotect(0x7f2549239000, 4096, PROT_READ) = 0
>29394 munmap(0x7f25491f6000, 269762)    = 0
>29394 set_tid_address(0x7f2545032ad0)   = 29394
>29394 set_robust_list(0x7f2545032ae0, 24) = 0
>29394 rt_sigaction(SIGRTMIN, {0x7f25472e4650, [], SA_RESTORER|SA_SIGINFO, 0x7f25472ed000}, NULL, 8) = 0
>29394 rt_sigaction(SIGRT_1, {0x7f25472e46d0, [], SA_RESTORER|SA_RESTART|SA_SIGINFO, 0x7f25472ed000}, NULL, 8) = 0
>29394 rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0
>29394 getrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0
>29394 statfs("/sys/fs/selinux", 0x7ffffbf73c90) = -1 ENOENT (No such file or directory)
>29394 statfs("/selinux", 0x7ffffbf73c90) = -1 ENOENT (No such file or directory)
>29394 brk(0)                            = 0x7f254b05c000
>29395 read(7,  <unfinished ...>
>29394 brk(0x7f254b07d000)               = 0x7f254b07d000
>29394 open("/proc/filesystems", O_RDONLY <unfinished ...>
>29395 <... read resumed> "putSlot PF60B\n*UIConstraints: *I"..., 4096) = 4096
>29394 <... open resumed> )              = 6
>29394 fstat(6, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f2549237000
>29394 read(6, "nodev\tsysfs\nnodev\trootfs\nnodev\tb"..., 1024) = 410
>29394 read(6, "", 1024)                 = 0
>29394 close(6)                          = 0
>29394 munmap(0x7f2549237000, 4096)      = 0
>29394 rt_sigaction(SIGPIPE, {SIG_IGN, [PIPE], SA_RESTORER|SA_RESTART, 0x7f25465e3c20}, {SIG_DFL, [], 0}, 8) = 0
>29395 read(7,  <unfinished ...>
>29394 rt_sigaction(SIGTERM, {0x7f2549240dd0, [], SA_RESTORER, 0x7f25472ed000},  <unfinished ...>
>29395 <... read resumed> "*Duplex DuplexNoTumble\n*UIConstr"..., 4096) = 4096
>29394 <... rt_sigaction resumed> NULL, 8) = 0
>29394 open("/var/spool/cups/d02094-001", O_RDONLY) = 6
>29394 fcntl(6, F_GETFD)                 = 0
>29394 fcntl(6, F_SETFD, FD_CLOEXEC)     = 0
>29394 read(6, "%!PS-Adobe-3.0\n%XpdfVersion: 3.0"..., 4096) = 4096
>29394 open("/usr/lib/locale/locale-archive", O_RDONLY|O_CLOEXEC) = 7
>29394 fstat(7, {st_mode=S_IFREG|0644, st_size=104789808, ...}) = 0
>29394 mmap(NULL, 104789808, PROT_READ, MAP_PRIVATE, 7, 0) = 0x7f253ec42000
>29394 close(7)                          = 0
>29394 futex(0x7f2549018d28, FUTEX_WAKE_PRIVATE, 2147483647) = 0
>29394 geteuid()                         = 4
>29394 getuid()                          = 4
>29394 getegid()                         = 7
>29394 getgid()                          = 7
>29394 open("/etc/cups/ppd/lp.ppd", O_RDONLY) = 7
>29394 fcntl(7, F_GETFD)                 = 0
>29394 fcntl(7, F_SETFD, FD_CLOEXEC)     = 0
>29394 read(7, "*PPD-Adobe: \"4.3\"\n*%============"..., 4096) = 4096
>29394 read(7,  <unfinished ...>
>29395 read(7,  <unfinished ...>
>29394 <... read resumed> "aultOption20: None\n*Option20 Non"..., 4096) = 4096
>29395 <... read resumed> "setpagedevice\"\n*PageSize EnvMona"..., 4096) = 4096
>29394 read(7, "0C *Option20 Two\n*UIConstraints:"..., 4096) = 4096
>29395 read(7,  <unfinished ...>
>29394 read(7,  <unfinished ...>
>29395 <... read resumed> "r/Letter: \"12 08 600 784\"\n*Image"..., 4096) = 4096
>29394 <... read resumed> "straints: *KCCollate VMBAdmin *O"..., 4096) = 4096
>29395 read(7,  <unfinished ...>
>29394 read(7,  <unfinished ...>
>29395 <... read resumed> "\n*MediaType Prepunched/Prepunche"..., 4096) = 4096
>29394 <... read resumed> "ot EF1\n*UIConstraints: *InputSlo"..., 4096) = 4096
>29395 brk(0 <unfinished ...>
>29394 read(7,  <unfinished ...>
>29395 <... brk resumed> )               = 0x7fabebec1000
>29394 <... read resumed> "putSlot PF60B\n*UIConstraints: *I"..., 4096) = 4096
>29395 brk(0x7fabebee2000 <unfinished ...>
>29394 read(7,  <unfinished ...>
>29395 <... brk resumed> )               = 0x7fabebee2000
>29394 <... read resumed> "*Duplex DuplexNoTumble\n*UIConstr"..., 4096) = 4096
>29395 read(7,  <unfinished ...>
>29394 read(7,  <unfinished ...>
>29395 <... read resumed> ": PickOne\n*OrderDependency: 20 A"..., 4096) = 4096
>29394 <... read resumed> "setpagedevice\"\n*PageSize EnvMona"..., 4096) = 4096
>29395 read(7,  <unfinished ...>
>29394 read(7,  <unfinished ...>
>29395 <... read resumed> "s get dup /Mode 0 put dup /Type "..., 4096) = 4096
>29394 <... read resumed> "r/Letter: \"12 08 600 784\"\n*Image"..., 4096) = 4096
>29395 read(7,  <unfinished ...>
>29394 brk(0)                            = 0x7f254b07d000
>29394 brk(0x7f254b09e000)               = 0x7f254b09e000
>29394 read(7, "\n*MediaType Prepunched/Prepunche"..., 4096) = 4096
>29394 read(7,  <unfinished ...>
>29395 <... read resumed> "ndard \"(001.000)\" Standard ROM\n*"..., 4096) = 4096
>29394 <... read resumed> ": PickOne\n*OrderDependency: 20 A"..., 4096) = 4096
>29395 read(7, "rd \"(001.000)\" Standard ROM\n*Fon"..., 4096) = 3349
>29394 read(7,  <unfinished ...>
>29395 read(7,  <unfinished ...>
>29394 <... read resumed> "s get dup /Mode 0 put dup /Type "..., 4096) = 4096
>29395 <... read resumed> "", 4096)      = 0
>29394 read(7,  <unfinished ...>
>29395 read(7,  <unfinished ...>
>29394 <... read resumed> "ndard \"(001.000)\" Standard ROM\n*"..., 4096) = 4096
>29395 <... read resumed> "", 4096)      = 0
>29394 read(7,  <unfinished ...>
>29395 close(7 <unfinished ...>
>29394 <... read resumed> "rd \"(001.000)\" Standard ROM\n*Fon"..., 4096) = 3349
>29395 <... close resumed> )             = 0
>29394 read(7,  <unfinished ...>
>29395 open("/etc/cups/snmp.conf", O_RDONLY <unfinished ...>
>29394 <... read resumed> "", 4096)      = 0
>29395 <... open resumed> )              = 7
>29394 read(7,  <unfinished ...>
>29395 fcntl(7, F_GETFD <unfinished ...>
>29394 <... read resumed> "", 4096)      = 0
>29395 <... fcntl resumed> )             = 0
>29394 close(7 <unfinished ...>
>29395 fcntl(7, F_SETFD, FD_CLOEXEC <unfinished ...>
>29394 <... close resumed> )             = 0
>29395 <... fcntl resumed> )             = 0
>29394 write(2, "DEBUG: Page = 595x842; 12,10 to "..., 40 <unfinished ...>
>29395 read(7, "#\n# \"$Id: snmp.conf.in 9045 2010"..., 4096) = 278
>29395 close(7)                          = 0
>29395 sendto(6, "0)\2\1\0\4\6public\240\34\2\1\1\2\1\0\2\1\0000\0210\17\6\v+\6"..., 43, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, 16 <unfinished ...>
>29394 <... write resumed> )             = 40
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18,  <unfinished ...>
>29395 <... sendto resumed> )            = 43
>13090 <... read resumed> "DEBUG: Page = 595x842; 12,10 to "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29395 poll([{fd=6, events=POLLIN}], 1, 2000 <unfinished ...>
>29394 write(2, "DEBUG: slow_collate=0, slow_dupl"..., 51 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 <... write resumed> )             = 51
>13090 read(18, "DEBUG: slow_collate=0, slow_dupl"..., 2047) = 51
>13090 epoll_wait(5,  <unfinished ...>
>29394 fstat(1, {st_mode=S_IFIFO|0600, st_size=0, ...}) = 0
>29394 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f2549237000
>29394 write(2, "DEBUG: Before copy_comments - %!"..., 45) = 45
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 write(2, "DEBUG: %!PS-Adobe-3.0\n", 22 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... write resumed> )             = 22
>13090 <... read resumed> "DEBUG: Before copy_comments - %!"..., 2047) = 67
>29394 write(2, "DEBUG: %XpdfVersion: 3.03\n", 26 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29394 <... write resumed> )             = 26
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 write(2, "DEBUG: %%Creator: Writer\n", 25 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... write resumed> )             = 25
>13090 <... read resumed> "DEBUG: %XpdfVersion: 3.03\nDEBUG:"..., 2047) = 51
>29394 write(2, "DEBUG: %%Title: Heiko Schocher\n", 31 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29394 <... write resumed> )             = 31
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 write(2, "DEBUG: %%LanguageLevel: 2\n", 26 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... write resumed> )             = 26
>13090 <... read resumed> "DEBUG: %%Title: Heiko Schocher\nD"..., 2047) = 57
>29394 write(2, "DEBUG: %%DocumentSuppliedResourc"..., 44 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29394 <... write resumed> )             = 44
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 write(2, "DEBUG: %%DocumentMedia: plain 59"..., 46 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... write resumed> )             = 46
>13090 <... read resumed> "DEBUG: %%DocumentSuppliedResourc"..., 2047) = 90
>29394 write(2, "DEBUG: %%BoundingBox: 0 0 595 84"..., 34 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29394 <... write resumed> )             = 34
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18,  <unfinished ...>
>29394 write(2, "DEBUG: %%Pages: 1\n", 18 <unfinished ...>
>13090 <... read resumed> "DEBUG: %%BoundingBox: 0 0 595 84"..., 2047) = 34
>29394 <... write resumed> )             = 18
>13090 epoll_wait(5,  <unfinished ...>
>29394 write(2, "DEBUG: %%EndComments\n", 21 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 <... write resumed> )             = 21
>13090 read(18, "DEBUG: %%Pages: 1\nDEBUG: %%EndCo"..., 2047) = 39
>29394 write(2, "DEBUG: Before copy_prolog - %%Be"..., 44 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29394 <... write resumed> )             = 44
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 <... poll resumed> )              = 1 ([{fd=6, revents=POLLIN}])
>13090 read(18, "DEBUG: Before copy_prolog - %%Be"..., 2047) = 44
>29395 recvfrom(6,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... recvfrom resumed> "01\2\1\0\4\6public\242$\2\1\1\2\1\0\2\1\0000\0310\27\6\v+\6"..., 1472, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, [16]) = 51
>29395 write(2, "DEBUG2: hrDeviceDesc=\"FS-3830N\"\n", 32 <unfinished ...>
>29394 write(1, "\33%-12345X@PJL\n@PJL JOB NAME = \"t"..., 4096 <unfinished ...>
>29395 <... write resumed> )             = 32
>29394 <... write resumed> )             = 4096
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 open("/var/cache/cups/10.0.150.1.snmp", O_RDONLY <unfinished ...>
>29394 read(6,  <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... open resumed> )              = 7
>29394 <... read resumed> "ioning operators\n/Td { pdfTextMa"..., 4096) = 4096
>29395 fcntl(7, F_GETFD <unfinished ...>
>13090 <... read resumed> "DEBUG2: hrDeviceDesc=\"FS-3830N\"\n", 2047) = 32
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... fcntl resumed> )             = 0
>29394 write(1, " { /pdfTextRise exch def } def\n/"..., 4096 <unfinished ...>
>29395 fcntl(7, F_SETFD, FD_CLOEXEC <unfinished ...>
>29394 <... write resumed> )             = 4096
>29395 <... fcntl resumed> )             = 0
>29394 read(6,  <unfinished ...>
>29395 read(7,  <unfinished ...>
>29394 <... read resumed> "p 3 index 2 index add 0.5 mul 3 "..., 4096) = 4096
>29395 <... read resumed> "2 2 2004\nFS-3830N\nToner Containe"..., 4096) = 1090
>29394 write(2, "DEBUG: Before copy_setup - %%Beg"..., 40 <unfinished ...>
>29395 close(7 <unfinished ...>
>29394 <... write resumed> )             = 40
>29395 <... close resumed> )             = 0
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18,  <unfinished ...>
>29395 open("/var/cache/cups/10.0.150.1.snmp", O_WRONLY <unfinished ...>
>13090 <... read resumed> "DEBUG: Before copy_setup - %%Beg"..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... open resumed> )              = 7
>29394 write(1, "ex 4 index funcSH\n    6 index 2 "..., 4096 <unfinished ...>
>29395 fstat(7,  <unfinished ...>
>29394 <... write resumed> )             = 4096
>29395 <... fstat resumed> {st_mode=S_IFREG|0600, st_size=1090, ...}) = 0
>29394 read(6,  <unfinished ...>
>29395 lstat("/var/cache/cups/10.0.150.1.snmp",  <unfinished ...>
>29394 <... read resumed> " put\ndup 95 /c5f put\ndup 96 /c60"..., 4096) = 4096
>29395 <... lstat resumed> {st_mode=S_IFREG|0600, st_size=1090, ...}) = 0
>29394 write(1, "leartomark\n[{\n%%BeginFeature: *P"..., 4096 <unfinished ...>
>29395 ftruncate(7, 0 <unfinished ...>
>29394 <... write resumed> )             = 4096
>29395 <... ftruncate resumed> )         = 0
>29394 read(6,  <unfinished ...>
>29395 fcntl(7, F_GETFD <unfinished ...>
>29394 <... read resumed> "0050009700b300c700d9000000000000"..., 4096) = 4096
>29395 <... fcntl resumed> )             = 0
>29394 write(1, "61 /ca1 put\ndup 162 /ca2 put\ndup"..., 4096 <unfinished ...>
>29395 fcntl(7, F_SETFD, FD_CLOEXEC <unfinished ...>
>29394 <... write resumed> )             = 4096
>29395 <... fcntl resumed> )             = 0
>29394 read(6,  <unfinished ...>
>29395 write(7, "2 2 2004\nFS-3830N\nToner Containe"..., 1090 <unfinished ...>
>29394 <... read resumed> "33e00b002233eb10102060cb00a23654"..., 4096) = 4096
>29395 <... write resumed> )             = 1090
>29394 write(1, "0a2d2c00b10a0b4323430b\n2d2c00b02"..., 4096 <unfinished ...>
>29395 close(7 <unfinished ...>
>29394 <... write resumed> )             = 4096
>29394 read(6, "5d5d5d5d5d5d\n5d5d717171717171717"..., 4096) = 4096
>29394 write(1, "fc0400e252e48164806115009101b500"..., 4096) = 4096
>29394 read(6, "364706388038015f3801403801803801"..., 4096) = 4096
>29394 write(1, "0320150\n3270329032d032f032057032"..., 4096) = 4096
>29394 read(6, "40192240184240152246224722403342"..., 4096) = 4096
>29394 write(1, "1983e372b256939416345231e4c81632"..., 4096) = 4096
>29394 read(6, "2a02bb2afb2a02842a010b2a016deb2a"..., 4096) = 4096
>29394 write(1, "0000000>\n<00010000ffec040003ac00"..., 4096) = 4096
>29394 read(6, "095f0e010e0e0901003f332f5d10ed3f"..., 4096) = 4096
>29394 write(1, "41e0615140e0223222e02278b41\n2313"..., 4096) = 4096
>29394 read(6, "b10100b041e5f0313003fed3f332f10\n"..., 4096) = 4096
>29394 write(1, "102f021010260218021b021c021e0\n21"..., 4096) = 4096
>29394 read(6, "732b2b012b5e735e73005e73\n5e73737"..., 4096) = 4096
>29394 write(1, "025a1f6a1f7a1f032b1f3b1f4b1f031c"..., 4096) = 4096
>29394 write(2, "DEBUG: Before page loop - %%Page"..., 38) = 38
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 write(2, "DEBUG: Copying page 1...\n", 25 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... write resumed> )             = 25
>13090 <... read resumed> "DEBUG: Before page loop - %%Page"..., 2047) = 63
>13090 epoll_wait(5,  <unfinished ...>
>29394 write(2, "PAGE: 1 1\n", 10)       = 10
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "PAGE: 1 1\n", 2047)     = 10
>13090 stat("/var/log/cups/page_log", {st_mode=S_IFREG|0600, st_size=3685, ...}) = 0
>13090 write(8, "lp wd 2094 [08/Feb/2013:09:23:13"..., 95) = 95
>13090 epoll_wait(5,  <unfinished ...>
>29394 write(2, "DEBUG: pagew = 571.0, pagel = 82"..., 36) = 36
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 write(2, "DEBUG: bboxx = 0, bboxy = 0, bbo"..., 54 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... write resumed> )             = 54
>13090 <... read resumed> "DEBUG: pagew = 571.0, pagel = 82"..., 2047) = 90
>29394 write(2, "DEBUG: PageLeft = 12.0, PageRigh"..., 42 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29394 <... write resumed> )             = 42
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 write(2, "DEBUG: PageTop = 832.0, PageBott"..., 42 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... write resumed> )             = 42
>13090 <... read resumed> "DEBUG: PageLeft = 12.0, PageRigh"..., 2047) = 84
>29394 write(2, "DEBUG: PageWidth = 595.0, PageLe"..., 45 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29394 <... write resumed> )             = 45
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 read(6,  <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... read resumed> "j\n-7 TJm\n(\\023)\n[6\n0] Tj\n17 TJm\n"..., 4096) = 4096
>13090 <... read resumed> "DEBUG: PageWidth = 595.0, PageLe"..., 2047) = 45
>13090 epoll_wait(5,  <unfinished ...>
>29394 write(1, "/cdc/cdd/cde/cdf\n  /ce0/ce1/ce2/"..., 4096) = 4096
>29394 read(6, "\n0\n3.996\n0] Tj\n-16 TJm\n(\\006\\011"..., 4096) = 4096
>29394 write(1, "5)\n[3.324\n0] Tj\n2 TJm\n(\\002\\006\\"..., 4096) = 4096
>29394 read(6, "\n(\\016)\n[5.316\n0] Tj\n-6 TJm\n(\\01"..., 4096) = 4096
>29394 write(1, "Jm\n(\\021\\024\\007)\n[6\n0\n6\n0\n3.324"..., 4096) = 4096
>29394 read(6, "4)\n[3\n0\n5.316\n0] Tj\n1 TJm\n(\\002\\"..., 4096) = 4096
>29394 write(1, "0] Tj\n-6 TJm\n(\\005)\n[9.324\n0] Tj"..., 4096 <unfinished ...>
>29395 <... close resumed> )             = 0
>29395 sendto(6, "0(\2\1\0\4\6public\241\33\2\1\1\2\1\0\2\1\0000\0200\16\6\n+\6"..., 42, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, 16) = 42
>29395 poll([{fd=6, events=POLLIN}], 1, 2000) = 1 ([{fd=6, revents=POLLIN}])
>29395 recvfrom(6, "0+\2\1\0\4\6public\242\36\2\1\1\2\1\0\2\1\0000\0230\21\6\f+\6"..., 1472, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, [16]) = 45
>29395 write(2, "ATTR: marker-colors=none,none\n", 30) = 30
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "ATTR: marker-names='\"Toner Conta"..., 59 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 59
>13090 <... read resumed> "ATTR: marker-colors=none,none\nAT"..., 2047) = 89
>29395 write(2, "ATTR: marker-types=toner,wasteTo"..., 36 <unfinished ...>
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0g\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL <unfinished ...>
>29395 <... write resumed> )             = 36
>13090 <... sendmsg resumed> )           = 135
>29395 write(2, "ATTR: marker-levels=25,-1\n", 26 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 26
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "DEBUG: new_supply_state=0, chang"..., 45 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 45
>13090 <... read resumed> "ATTR: marker-types=toner,wasteTo"..., 2047) = 107
>29395 write(2, "STATE: -developer-low-report\n", 29 <unfinished ...>
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0h\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL <unfinished ...>
>29395 <... write resumed> )             = 29
>13090 <... sendmsg resumed> )           = 135
>29395 write(2, "STATE: -developer-empty-warning\n", 32 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 32
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "STATE: -marker-supply-low-report"..., 33 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 33
>13090 <... read resumed> "STATE: -developer-low-report\nSTA"..., 2047) = 94
>29395 write(2, "STATE: -marker-supply-empty-warn"..., 36 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 36
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "STATE: -opc-near-eol-report\n", 28 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 28
>13090 <... read resumed> "STATE: -marker-supply-empty-warn"..., 2047) = 64
>29395 write(2, "STATE: -opc-life-over-warning\n", 30 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 30
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "STATE: -toner-low-report\n", 25 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 25
>13090 <... read resumed> "STATE: -opc-life-over-warning\nST"..., 2047) = 55
>29395 write(2, "STATE: -toner-empty-warning\n", 28 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 28
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18,  <unfinished ...>
>29395 sendto(6, "0)\2\1\0\4\6public\240\34\2\1\1\2\1\0\2\1\0000\0210\17\6\v+\6"..., 43, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, 16 <unfinished ...>
>13090 <... read resumed> "STATE: -toner-empty-warning\n", 2047) = 28
>29395 <... sendto resumed> )            = 43
>13090 epoll_wait(5,  <unfinished ...>
>29395 poll([{fd=6, events=POLLIN}], 1, 2000) = 1 ([{fd=6, revents=POLLIN}])
>29395 recvfrom(6, "0*\2\1\0\4\6public\242\35\2\1\1\2\1\0\2\1\0000\0220\20\6\v+\6"..., 1472, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, [16]) = 44
>29395 write(2, "DEBUG: new_state=0, change_state"..., 38) = 38
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "STATE: -media-low-report\n", 25 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 25
>13090 <... read resumed> "DEBUG: new_state=0, change_state"..., 2047) = 63
>29395 write(2, "STATE: -media-empty-warning\n", 28 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 28
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "STATE: -door-open-report\n", 25 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 25
>13090 <... read resumed> "STATE: -media-empty-warning\nSTAT"..., 2047) = 53
>29395 write(2, "STATE: -media-jam-warning\n", 26 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 26
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "STATE: -input-tray-missing-warni"..., 35 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 35
>13090 <... read resumed> "STATE: -media-jam-warning\nSTATE:"..., 2047) = 61
>29395 write(2, "STATE: -output-tray-missing-warn"..., 36 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 36
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "STATE: -marker-supply-missing-wa"..., 38 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 38
>13090 <... read resumed> "STATE: -output-tray-missing-warn"..., 2047) = 74
>29395 write(2, "STATE: -output-area-almost-full-"..., 39 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 39
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "STATE: -output-area-full-warning"..., 33 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 33
>13090 <... read resumed> "STATE: -output-area-almost-full-"..., 2047) = 72
>29395 sendto(6, "0*\2\1\0\4\6public\240\35\2\1\1\2\1\0\2\1\0000\0220\20\6\f+\6"..., 44, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, 16 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... sendto resumed> )            = 44
>29395 poll([{fd=6, events=POLLIN}], 1, 2000) = 1 ([{fd=6, revents=POLLIN}])
>29395 recvfrom(6, "0-\2\1\0\4\6public\242 \2\1\1\2\1\0\2\1\0000\0250\23\6\f+\6"..., 1472, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, [16]) = 47
>29395 write(2, "DEBUG: backendWaitLoop(snmp_fd=6"..., 79) = 79
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(5, [0 4], NULL, NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999997})
>13090 <... read resumed> "DEBUG: backendWaitLoop(snmp_fd=6"..., 2047) = 79
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "\33%-12345X@PJL\n@PJL JOB NAME = \"t"..., 1024) = 1024
>29395 write(2, "DEBUG: Connecting to 10.0.150.1:"..., 37) = 37
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Connecting to 10.0.150.1:"..., 2047) = 37
>29395 access("/usr/share/locale/en_US/cups_en_US.po", F_OK <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... access resumed> )            = -1 ENOENT (No such file or directory)
>29395 access("/usr/share/locale/en/cups_en.po", F_OK) = -1 ENOENT (No such file or directory)
>29395 open("/usr/share/locale/C/cups_C.po", O_RDONLY) = -1 ENOENT (No such file or directory)
>29395 write(2, "INFO: Connecting to printer.\n", 29) = 29
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 socket(PF_INET, SOCK_STREAM, IPPROTO_IP <unfinished ...>
>13090 read(18, "INFO: Connecting to printer.\n", 2047) = 29
>29395 <... socket resumed> )            = 7
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0i\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL <unfinished ...>
>29395 setsockopt(7, SOL_SOCKET, SO_REUSEADDR, [1], 4 <unfinished ...>
>13090 <... sendmsg resumed> )           = 135
>29395 <... setsockopt resumed> )        = 0
>13090 epoll_wait(5,  <unfinished ...>
>29395 setsockopt(7, SOL_TCP, TCP_NODELAY, [1], 4) = 0
>29395 fcntl(7, F_SETFD, FD_CLOEXEC)     = 0
>29395 connect(7, {sa_family=AF_INET, sin_port=htons(9100), sin_addr=inet_addr("10.0.150.1")}, 16) = 0
>29395 write(2, "STATE: -connecting-to-device\n", 29) = 29
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "INFO: Connected to printer.\n", 28 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 28
>13090 <... read resumed> "STATE: -connecting-to-device\nINF"..., 2047) = 57
>29395 write(2, "DEBUG: Connected to 10.0.150.1:9"..., 39 <unfinished ...>
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0j\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL <unfinished ...>
>29395 <... write resumed> )             = 39
>13090 <... sendmsg resumed> )           = 135
>29395 write(7, "\33%-12345X@PJL\n@PJL JOB NAME = \"t"..., 1024 <unfinished ...>
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 <... write resumed> )             = 1024
>13090 read(18, "DEBUG: Connected to 10.0.150.1:9"..., 2047) = 39
>29395 write(2, "DEBUG: backendRunLoop(print_fd=0"..., 113 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 113
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 rt_sigaction(SIGTERM, {SIG_IGN, [], SA_RESTORER, 0x7fabe84e3000},  <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... rt_sigaction resumed> NULL, 8) = 0
>13090 <... read resumed> "DEBUG: backendRunLoop(print_fd=0"..., 2047) = 113
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999997})
>29395 read(0, " {\n  pdfDictSize dict begin\n  /p"..., 8192) = 8192
>29394 <... write resumed> )             = 4096
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... write resumed> )             = 40
>29394 <... read resumed> "16\n0] Tj\n1 TJm\n(\\011)\n[4.668\n0] "..., 4096) = 4096
>29395 sendto(6, "0(\2\1\0\4\6public\241\33\2\1\1\2\1\0\2\1\0000\0200\16\6\n+\6"..., 42, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, 16 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>29395 <... sendto resumed> )            = 42
>13090 epoll_wait(5,  <unfinished ...>
>29395 poll([{fd=6, events=POLLIN}], 1, 2000 <unfinished ...>
>29394 write(1, ")\n[5.316\n0] Tj\n1 TJm\n(\\015)\n[3.3"..., 4096) = 4096
>29394 read(6, "11)\n[6\n0\n4.668\n0] Tj\n-2 TJm\n(\\01"..., 4096) = 4096
>29394 write(1, "6\n0\n5.316\n0] Tj\n1 TJm\n(\\020)\n[5."..., 4096 <unfinished ...>
>29395 <... poll resumed> )              = 1 ([{fd=6, revents=POLLIN}])
>29395 recvfrom(6, "0,\2\1\0\4\6public\242\37\2\1\1\2\1\0\2\1\0000\0240\22\6\f+\6"..., 1472, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, [16]) = 46
>29395 write(2, "DEBUG2: prtMarkerSuppliesLevel.1"..., 43) = 43
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 sendto(6, "0*\2\1\0\4\6public\241\35\2\1\2\2\1\0\2\1\0000\0220\20\6\f+\6"..., 44, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, 16 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... sendto resumed> )            = 44
>13090 <... read resumed> "DEBUG2: prtMarkerSuppliesLevel.1"..., 2047) = 43
>29395 poll([{fd=6, events=POLLIN}], 1, 2000 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... poll resumed> )              = 1 ([{fd=6, revents=POLLIN}])
>29395 recvfrom(6, "0+\2\1\0\4\6public\242\36\2\1\2\2\1\0\2\1\0000\0230\21\6\f+\6"..., 1472, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, [16]) = 45
>29395 write(2, "DEBUG2: prtMarkerSuppliesLevel.1"..., 40) = 40
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 sendto(6, "0*\2\1\0\4\6public\241\35\2\1\3\2\1\0\2\1\0000\0220\20\6\f+\6"..., 44, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, 16 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... sendto resumed> )            = 44
>13090 <... read resumed> "DEBUG2: prtMarkerSuppliesLevel.1"..., 2047) = 40
>29395 poll([{fd=6, events=POLLIN}], 1, 2000 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... poll resumed> )              = 1 ([{fd=6, revents=POLLIN}])
>29395 recvfrom(6, "0+\2\1\0\4\6public\242\36\2\1\3\2\1\0\2\1\0000\0230\21\6\f+\6"..., 1472, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, [16]) = 45
>29395 write(2, "ATTR: marker-levels=100,-1\n", 27) = 27
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 write(2, "DEBUG: new_supply_state=0, chang"..., 42 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... write resumed> )             = 42
>13090 <... read resumed> "ATTR: marker-levels=100,-1\nDEBUG"..., 2047) = 69
>29395 sendto(6, "0)\2\1\0\4\6public\240\34\2\1\1\2\1\0\2\1\0000\0210\17\6\v+\6"..., 43, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, 16 <unfinished ...>
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0k\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL <unfinished ...>
>29395 <... sendto resumed> )            = 43
>13090 <... sendmsg resumed> )           = 135
>29395 poll([{fd=6, events=POLLIN}], 1, 2000 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... poll resumed> )              = 1 ([{fd=6, revents=POLLIN}])
>29395 recvfrom(6, "0*\2\1\0\4\6public\242\35\2\1\1\2\1\0\2\1\0000\0220\20\6\v+\6"..., 1472, 0, {sa_family=AF_INET, sin_port=htons(161), sin_addr=inet_addr("10.0.150.1")}, [16]) = 44
>29395 write(2, "DEBUG: new_state=0, change_state"..., 35) = 35
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 999997})
>13090 <... read resumed> "DEBUG: new_state=0, change_state"..., 2047) = 35
>29395 write(7, " {\n  pdfDictSize dict begin\n  /p"..., 8192 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999997})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "yMax sub dy mul dx div add yMax "..., 8192) = 8192
>29394 <... write resumed> )             = 4096
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... write resumed> )             = 40
>29394 <... read resumed> "0\n6\n0] Tj\n-7 TJm\n(\\004)\n[5.316\n0"..., 4096) = 4096
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29394 write(1, " Tj\n2 TJm\n(\\015)\n[3.324\n0] Tj\n2 "..., 4096) = 4096
>29394 read(6, "0\n5.316\n0] Tj\n1 TJm\n(\\015)\n[3.32"..., 4096) = 4096
>29395 <... select resumed> )            = 1 (out [7], left {4, 999538})
>29394 write(1, "Tj\n-7 TJm\n(\\013\\002)\n[6\n0\n6\n0] T"..., 4096 <unfinished ...>
>29395 write(7, "yMax sub dy mul dx div add yMax "..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999997})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "cdd put\ndup 222 /cde put\ndup 223"..., 8192) = 8192
>29394 <... write resumed> )             = 4096
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... write resumed> )             = 40
>29394 <... read resumed> "`A\n6[7ZL1A\"cFPUhGOI'Rkn_l@M+ZlBd"..., 4096) = 4096
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>29394 write(1, "16\n0] Tj\n1 TJm\n(\\004)\n[5.316\n0] "..., 4096 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 <... write resumed> )             = 4096
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29394 read(6, "RT:C\\ILQU9e1<aj%&me?%&nKK[1.)0S3"..., 4096) = 4096
>29394 write(1, "s&B&!X8Z-\"9SW(!!!-*!WrW-!!a2L&J>"..., 4096 <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 999203})
>29395 write(7, "cdd put\ndup 222 /cde put\ndup 223"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999997})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "7414e582d75a1642ccebf4b8362\n39fe"..., 8192) = 8192
>29394 <... write resumed> )             = 4096
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... write resumed> )             = 40
>29394 <... read resumed> "i1e[#5uBa\"HE>!5RI_GXBb^ql.g4=pu3"..., 4096) = 4096
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>29394 write(1, "Qq1QR[%%a[=^Ej4O%-.6SR0LT=/3O[:W"..., 4096 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 <... write resumed> )             = 4096
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29394 read(6, "7Dc.)MQSIKl6SPXU[I>->K[Hj2P!ai(2"..., 4096) = 4096
>29394 write(1, "R7bRajjc/p)\\WW15^nYq<<SVH\"<)D,9&"..., 4096 <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 998766})
>29395 write(7, "7414e582d75a1642ccebf4b8362\n39fe"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999998})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "b01405b01\n345b01205b015bb8ffc040"..., 8192) = 8192
>29394 <... write resumed> )             = 4096
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... write resumed> )             = 40
>29394 <... read resumed> "qrg($R/+9NUn(kE3&S:Sl1,<V(;sMf'f"..., 4096) = 4096
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>29394 write(1, "/8PPiM/rNseJ0eJ;TRGr)\"k?#b8TGZ/\n"..., 4096 <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 999998})
>29394 <... write resumed> )             = 4096
>29395 write(7, "b01405b01\n345b01205b015bb8ffc040"..., 8192 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>29395 <... write resumed> )             = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... write resumed> )             = 41
>29394 <... read resumed> "<f?PsEoj`8M&UqLiVf#=.midfp^Jg!i."..., 4096) = 4096
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>29394 write(1, ")V\\DqEdOr-bG1b'WW+\"@*48A%u`\nble!"..., 4096 <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999997})
>13090 epoll_wait(5,  <unfinished ...>
>29395 read(0,  <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 <... read resumed> "58018162014c75fef4015866fe7f56fe"..., 8192) = 8192
>29394 <... write resumed> )             = 4096
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>13090 read(18, "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 <... write resumed> )             = 40
>29394 read(6,  <unfinished ...>
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>29394 <... read resumed> "Cisgc\"9^V>`A2d1X_o1Fo3jQimo9mTue"..., 4096) = 4096
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>29394 write(1, "PKX?@Qj1i4h,Z1:7#@E[s6&\nI,2h@U<Z"..., 4096 <unfinished ...>
>13090 read(18,  <unfinished ...>
>29394 <... write resumed> )             = 4096
>13090 <... read resumed> "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29394 read(6, "Ie=&8E4Nd#b\"\"j2sCje=k#O#r`e*,;I%"..., 4096) = 4096
>29394 write(1, "QOBTKm\\s-&nb&+GKo1\\\n1;ZUis@$F?s$"..., 4096 <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 998513})
>29395 write(7, "58018162014c75fef4015866fe7f56fe"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999998})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "010f5cfd048dc25f0f3cf5001f080000"..., 8192) = 8192
>29394 <... write resumed> )             = 4096
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... write resumed> )             = 40
>29394 <... read resumed> ":CAS\"#K:(!G;cmFE%)]7\"sAAG@1N?(Qh"..., 4096) = 4096
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>29394 write(1, "%`;tB5%(N$[<+2a\neYeT#aV?h0+d`BlY"..., 4096 <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 999998})
>29394 <... write resumed> )             = 4096
>29395 write(7, "010f5cfd048dc25f0f3cf5001f080000"..., 8192 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>29395 <... write resumed> )             = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41 <unfinished ...>
>29394 read(6,  <unfinished ...>
>29395 <... write resumed> )             = 41
>29394 <... read resumed> "1$j@(0#GP(WJM%3P8d'aK6:(H8d0ZM^H"..., 4096) = 884
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29394 write(1, "[;!-$lo8qaa\nf_3eI*hrm\"`@s$&5fEOi"..., 3818 <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999992})
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 read(0,  <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... read resumed> "996\n0\n5.316\n0] Tj\n1 TJm\n(\\021\\01"..., 8192) = 8192
>29394 <... write resumed> )             = 3818
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>29394 write(2, "DEBUG: Wrote 1 pages...\n", 24 <unfinished ...>
>29395 <... write resumed> )             = 40
>29394 <... write resumed> )             = 24
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 64
>13090 epoll_wait(5,  <unfinished ...>
>29394 close(6)                          = 0
>29394 write(1, "%%Trailer\nend\n%%DocumentSupplied"..., 176) = 176
>29394 exit_group(0)                     = ?
>29394 +++ exited with 0 +++
>13090 <... epoll_wait resumed> 7f5a112bb990, 4096, 1000) = -1 EINTR (Interrupted system call)
>13090 --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=29394, si_status=0, si_utime=1, si_stime=0} ---
>13090 rt_sigreturn()                    = -1 EINTR (Interrupted system call)
>13090 wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG, NULL) = 29394
>13090 wait4(-1, 0x7fff1d8348b8, WNOHANG, NULL) = 0
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 998459})
>29395 write(7, "996\n0\n5.316\n0] Tj\n1 TJm\n(\\021\\01"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 4 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 2 (in [0 4], left {4, 999997})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 poll([{fd=4, events=POLLIN}], 1, 1000 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... poll resumed> )              = 1 ([{fd=4, revents=POLLIN|POLLHUP}])
>29395 read(4, "", 16388)                = 0
>29395 select(8, [0 7], [], NULL, {5, 0}) = 1 (in [0], left {4, 999998})
>29395 read(0, "Jm\n(\\006\\011)\n[3\n0\n4.668\n0] Tj\n-"..., 8192) = 8192
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40) = 40
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 999998})
>13090 <... read resumed> "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>29395 write(7, "Jm\n(\\006\\011)\n[3\n0\n4.668\n0] Tj\n-"..., 8192 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999998})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "[4.668\n0] Tj\n-2 TJm\n(\\007)\n[3.32"..., 8192) = 8192
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40) = 40
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 998543})
>29395 write(7, "[4.668\n0] Tj\n-2 TJm\n(\\007)\n[3.32"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 41
>29395 select(8, [0 7], [], NULL, {5, 0}) = 1 (in [0], left {4, 999997})
>29395 read(0, "2 TJm\n(\\021\\006\\024\\012\\014)\n[6\n"..., 8192) = 8192
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 40
>29395 select(8, [7], [7], NULL, {5, 0}) = 1 (out [7], left {4, 999998})
>29395 write(7, "2 TJm\n(\\021\\006\\024\\012\\014)\n[6\n"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 41
>29395 select(8, [0 7], [], NULL, {5, 0}) = 1 (in [0], left {4, 999998})
>29395 read(0, "^/;39!)2S\nTpNksoC.d6@6'e=/)lMIoC"..., 8192) = 8192
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 40
>29395 select(8, [7], [7], NULL, {5, 0}) = 1 (out [7], left {4, 998585})
>29395 write(7, "^/;39!)2S\nTpNksoC.d6@6'e=/)lMIoC"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 <... write resumed> )             = 41
>13090 read(18,  <unfinished ...>
>29395 select(8, [0 7], [], NULL, {5, 0} <unfinished ...>
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 <... select resumed> )            = 1 (in [0], left {4, 999998})
>13090 epoll_wait(5,  <unfinished ...>
>29395 read(0, "E\nSl!hn%RrT5Q3\"K@T-i<;:2XFoi2*K/"..., 8192) = 8192
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40) = 40
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 999998})
>13090 <... read resumed> "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>29395 write(7, "E\nSl!hn%RrT5Q3\"K@T-i<;:2XFoi2*K/"..., 8192 <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... write resumed> )             = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999998})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "X?RWF?n2#puGe/abrmn,'\"#Sm^e.6E3F"..., 8192) = 8192
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40) = 40
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 read(18, "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 998229})
>29395 write(7, "X?RWF?n2#puGe/abrmn,'\"#Sm^e.6E3F"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999997})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "&:20:Ut8c59C_fm!!o\\ApTJKHhJ88c=F"..., 8192) = 8192
>29395 write(2, "DEBUG: Read 8192 bytes of print "..., 40 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 <... write resumed> )             = 40
>13090 read(18,  <unfinished ...>
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 <... read resumed> "DEBUG: Read 8192 bytes of print "..., 2047) = 40
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... select resumed> )            = 1 (out [7], left {4, 998168})
>29395 write(7, "&:20:Ut8c59C_fm!!o\\ApTJKHhJ88c=F"..., 8192) = 8192
>29395 write(2, "DEBUG: Wrote 8192 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999998})
>13090 <... read resumed> "DEBUG: Wrote 8192 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "N&Nt=L;jB.(#$D-6&0lXL2'7p;kUI,%c"..., 8192) = 2970
>29395 write(2, "DEBUG: Read 2970 bytes of print "..., 40 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 <... write resumed> )             = 40
>13090 read(18,  <unfinished ...>
>29395 select(8, [7], [7], NULL, {5, 0} <unfinished ...>
>13090 <... read resumed> "DEBUG: Read 2970 bytes of print "..., 2047) = 40
>29395 <... select resumed> )            = 1 (out [7], left {4, 999998})
>13090 epoll_wait(5,  <unfinished ...>
>29395 write(7, "N&Nt=L;jB.(#$D-6&0lXL2'7p;kUI,%c"..., 2970) = 2970
>29395 write(2, "DEBUG: Wrote 2970 bytes of print"..., 41) = 41
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 select(8, [0 7], [], NULL, {5, 0} <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [0], left {4, 999997})
>13090 <... read resumed> "DEBUG: Wrote 2970 bytes of print"..., 2047) = 41
>29395 read(0,  <unfinished ...>
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... read resumed> "", 8192)      = 0
>29395 write(2, "INFO: Waiting for printer to fin"..., 37) = 37
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 shutdown(7, SHUT_WR <unfinished ...>
>13090 read(18,  <unfinished ...>
>29395 <... shutdown resumed> )          = 0
>13090 <... read resumed> "INFO: Waiting for printer to fin"..., 2047) = 37
>29395 select(8, [7], NULL, NULL, {90, 0} <unfinished ...>
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0l\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 135
>13090 epoll_wait(5,  <unfinished ...>
>29395 <... select resumed> )            = 1 (in [7], left {89, 997177})
>29395 read(7, "", 1024)                 = 0
>29395 close(7)                          = 0
>29395 write(2, "INFO: Ready to print.\n", 22 <unfinished ...>
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 <... write resumed> )             = 22
>13090 read(18, "INFO: Ready to print.\n", 2047) = 22
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0m\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 135
>13090 epoll_wait(5,  <unfinished ...>
>29395 exit_group(0)                     = ?
>13090 <... epoll_wait resumed> {?} 0x7f5a112bb990, 4096, 1000) = 1
>29395 +++ exited with 0 +++
>13090 --- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=29395, si_status=0, si_utime=0, si_stime=0} ---
>13090 rt_sigreturn()                    = 1
>13090 read(18, "", 2047)                = 0
>13090 wait4(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}], WNOHANG, NULL) = 29395
>13090 wait4(-1, 0x7fff1d8348b8, WNOHANG, NULL) = -1 ECHILD (No child processes)
>13090 epoll_wait(5, {?} 0x7f5a112bb990, 4096, 1000) = 1
>13090 read(18, "", 2047)                = 0
>13090 epoll_ctl(5, EPOLL_CTL_DEL, 18, {...}) = 0
>13090 close(18)                         = 0
>13090 close(18)                         = -1 EBADF (Bad file descriptor)
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0n\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 135
>13090 open("/var/spool/cups/a02094", O_WRONLY|O_EXCL) = -1 ENOENT (No such file or directory)
>13090 unlink("/var/spool/cups/d02094-001") = 0
>13090 sendmsg(10, {msg_name(0)=NULL, msg_iov(2)=[{"l\4\1\1\7\0\0\0o\2\0\0o\0\0\0\1\1o\0\32\0\0\0/com/red"..., 128}, {"\2\0\0\0lp\0", 7}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 135
>13090 epoll_wait(5, {}, 4096, 1000)     = 0
>13090 open("/var/spool/cups/c02094.N", O_WRONLY) = -1 ENOENT (No such file or directory)
>13090 open("/var/spool/cups/c02094.N", O_WRONLY|O_CREAT|O_EXCL, 0666) = 16
>13090 fstat(16, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0
>13090 lstat("/var/spool/cups/c02094.N", {st_mode=S_IFREG|0644, st_size=0, ...}) = 0
>13090 ftruncate(16, 0)                  = 0
>13090 fcntl(16, F_GETFD)                = 0
>13090 fcntl(16, F_SETFD, FD_CLOEXEC)    = 0
>13090 fchmod(16, 0600)                  = 0
>13090 fchown(16, 0, 7)                  = 0
>13090 write(16, "\1\1\0\5\0\0\0\1\1G\0\22attributes-charset\0\5"..., 858) = 858
>13090 close(16)                         = 0
>13090 unlink("/var/spool/cups/c02094")  = -1 ENOENT (No such file or directory)
>13090 rename("/var/spool/cups/c02094.N", "/var/spool/cups/c02094") = 0
>13090 epoll_wait(5,  <detached ...>

Actions: View

Attachments on bug 909090: 694983 | 694988 | 694989 | 698853 | 909098