lsds / sgx-lkl

SGX-LKL Library OS for running Linux applications inside of Intel SGX enclaves
MIT License
256 stars 89 forks source link

StringUtils.toLowerCase will cause problem when run as jvm app #389

Closed glorysdj closed 4 years ago

glorysdj commented 4 years ago

Hi guys, when I run some code as jvm app in sgx-lkl simulation mode , it will exit with no output or exception. e.g.

System.out.println("Hello World");   // will print
String lowered = StringUtils.toLowerCase("ADSAFFDSzcxcx");
System.out.println(lowered); // will not print

in jdk, it's

public static String toLowerCase(String str) {
        return str.toLowerCase(Locale.ENGLISH);
    }

Is this related to Locale class in Alphine? And I also wander that how can I debug jvm app in sgx-lkl simulation mode?

please help here. Thanks

davidchisnall commented 4 years ago

I don’t know how the JVM implements the locale functions, but musl just has stubs for most locale related functionality, so it’s possible that this is the issue. Is this with master or the oe_port branch?

glorysdj commented 4 years ago

With master branch. It seems that musl does not have locale, need to install it. BTW, is oe_branch ready for running java/openvino/tf/pytorch? And another question is where can I find any example for sgx-lkl-disk with dockerfile, maybe I can install locales in docker image and then build the disk image Thanks.

hukoyu commented 4 years ago

@glorysdj you can debug with this command:

sgx-lkl-java --sw-debug sgxlkl-java.img --debug Ref: PR https://github.com/lsds/sgx-lkl/pull/252

You can look at this sample java test about how to use Dockerfile. Check the Makefile https://github.com/lsds/sgx-lkl/tree/oe_port/tests/languages/java/hello_world

davidchisnall commented 4 years ago

@glorysdj, at present, the oe_port branch is more feature complete than master. I expect that we will switch over to making it the default branch soon.

glorysdj commented 4 years ago

ok, that's great. @davidchisnall and @hukoyu , thanks. I will try this and close the issue.

glorysdj commented 4 years ago

@davidchisnall and @hukoyu Hi, I have problem to install or build sgx-lkl-oe following the readme in Ubuntu 18.04. error occurs when "The FSGSBASE DKMS driver can be installed with:" sudo apt install enable-fsgsbase-dkms echo "enable_fsgsbase" | sudo tee -a /etc/modules sudo modprobe enable_fsgsbase

apt install enable-fsgsbase-dkms will install enable-fsgsbase-dkms to /lib/modules/4.15.0-106-generic/updates/dkms/enable_fsgsbase.ko so modprobe enable_fsgsbase always fail, since it will find from /lib/modules/4.15.0-72-generic.

Any idea to fix this? Thanks!

letmaik commented 4 years ago

@glorysdj Please open a new issue about this. It's not related to StringUtils.toLowerCase.

glorysdj commented 4 years ago

I have tried oe_branch and building disk-image from Dockerfile In Dockerfile, i've tried to install locale


FROM openjdk:8-alpine
COPY ./target/sgx-lkl-zoo-0.1.0-SNAPSHOT-jar-with-dependencies.jar /app/sgx-lkl-zoo-0.1.0-SNAPSHOT-jar-with-dependencies.jar
WORKDIR /app
RUN apk update && apk add tree cmake make musl-dev gcc gettext-dev libintl git && \
    git clone https://github.com/rilian-la-te/musl-locales.git && \
    cd musl-locales && cmake . && make && make install
RUN cp /usr/local/bin/locale /usr/bin/locale
RUN /usr/bin/locale
RUN mkdir -p /etc/apk/keys/ && \
    apk --no-cache add ca-certificates wget
RUN wget -q -O /etc/apk/keys/sgerrand.rsa.pub https://alpine-pkgs.sgerrand.com/sgerrand.rsa.pub
RUN wget https://github.com/sgerrand/alpine-pkg-glibc/releases/download/2.25-r0/glibc-2.25-r0.apk && \
    wget https://github.com/sgerrand/alpine-pkg-glibc/releases/download/2.25-r0/glibc-bin-2.25-r0.apk && \
    wget https://github.com/sgerrand/alpine-pkg-glibc/releases/download/2.25-r0/glibc-i18n-2.25-r0.apk && \
    apk add glibc-bin-2.25-r0.apk glibc-i18n-2.25-r0.apk glibc-2.25-r0.apk
# Iterate through all locale and install it
# Note that locale -a is not available in alpine linux, use `/usr/glibc-compat/bin/locale -a` instead
COPY ./locale.md locale.md
RUN cat locale.md | xargs -i /usr/glibc-compat/bin/localedef -i {} -f UTF-8 {}.UTF-8
# Set the lang, you can also specify it as as environment variable through docker-compose.yml
ENV LANG=en_US.UTF-8 \
    LANGUAGE=en_US.UTF-8

The java program is

System.out.println("Hello World");
String lowered = StringUtils.toLowerCase("ADSAFFDSzcxcx");
System.out.println(lowered);

And I built the Docker image (sgx-alpine-java:0.1) and disk image(sgxlkl-disk.img) from this Dockerfile. When I run my java program with Docker image

sudo docker run -it sgx-alpine-java:0.1 java -cp /app/sgx-lkl-zoo-0.1.0-SNAPSHOT-jar-with-dependencies.jar com.X.X.zoo.sgx.lkl.HelloWorld

it will print,

Hello World
adsaffdszcxcx

But when I run with sgx-lkl-java with the disk image

SGXLKL_TAP=sgxlkl_tap0 sgx-lkl-java --sw-debug ./sgxlkl-disk.img com.X.X.zoo.sgx.lkl.HelloWorld

it will print only

Hello World

The program will stuck, and no other output or errors. I can run locale with comman:

SGXLKL_TAP=sgxlkl_tap0 sgx-lkl-run-oe --sw-debug ./sgxlkl-disk.img /usr/bin/locale

The output is

LANG=en_US.UTF-8
LC_CTYPE=en_US.UTF-8
LC_NUMERIC=en_US.UTF-8
LC_TIME=en_US.UTF-8
LC_COLLATE=en_US.UTF-8
LC_MONETARY=en_US.UTF-8
LC_MESSAGES=en_US.UTF-8
LC_ALL=

Still have issue to run StringUtils.toLowerCase, please help here.

glorysdj commented 4 years ago

@letmaik could you please help to reopen this issue?

letmaik commented 4 years ago

Thanks for the details, I'll try to repro it.

letmaik commented 4 years ago

@glorysdj Could you provide a fully self-contained example? Your Dockerfile references a few files via COPY. It would be good if you could find a way to invoke an equivalent of StringUtils.toLowerCase outside Java, for easier reproducibility.

Also note that SGX-LKL doesn't support glibc currently, which you seem to be using from https://github.com/sgerrand/alpine-pkg-glibc.

glorysdj commented 4 years ago

@letmaik

FROM openjdk:8-alpine
COPY ./target/sgx-lkl-zoo-0.1.0-SNAPSHOT-jar-with-dependencies.jar /app/sgx-lkl-zoo-0.1.0-SNAPSHOT-jar-with-dependencies.jar
WORKDIR /app
RUN apk update && apk add tree cmake make musl-dev gcc gettext-dev libintl git && \
    git clone https://github.com/rilian-la-te/musl-locales.git && \
    cd musl-locales && cmake . && make && make install
RUN cp /usr/local/bin/locale /usr/bin/locale
RUN /usr/bin/locale

Please try this? Same results for this Dockerfile.

letmaik commented 4 years ago

@glorysdj I don't understand. You already tried running /usr/bin/locale with SGX-LKL and it seems to work. Why should I run this?

glorysdj commented 4 years ago

@letmaik /usr/bin/locale can get locales, but to run java program

String lowered = StringUtils.toLowerCase("ADSAFFDSzcxcx");
System.out.println(lowered);

It will stuck, and print nothing. I think maybe it has nothing to do with locale.

Please ignore the Dockerfiles, just run a java program to call StringUtils.toLowerCase to check if it can work. Thanks a lot!

letmaik commented 4 years ago

@glorysdj Could you try to adapt the existing hello world sample in samples/languages/java and see if you can reproduce your problem there?

glorysdj commented 4 years ago

Yes, still have the issue. I have tried:

  1. docker-deploy and javac on master branch
  2. adapting samples/languages/java on oe_port branch
  3. Dockerfile without locale related commands on oe_port branch
  4. Dockerfile with locale related commands on oe_port branch

Unfortunately, it stuck and print nothing each time.

letmaik commented 4 years ago

Good, can you post a minimal sample for us?

prp commented 4 years ago

@glorysdj Can you run with SGXLKL_TRACE_LKL_SYSCALL=1 to see what the last executed system call by the JVM is?

glorysdj commented 4 years ago

@letmaik minimal sample is

String lowered = StringUtils.toLowerCase("ADSAFFDSzcxcx");
System.out.println(lowered);

@prp Hi, run with SGXLKL_TRACE_LKL_SYSCALL=1, some (No such file or directory) errors happen, too long to paste all the output, only list the errors.

[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/server/libjli.so, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/libjli.so, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/../lib/amd64/libjli.so, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/lib/amd64/jli/libjli.so, 524288, 0) = 7
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/server/libz.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/libz.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/../lib/amd64/libz.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/lib/amd64/jli/libz.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/lib/amd64/jli/libz.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/lib/amd64/jli/../libz.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/bin/../lib/amd64/jli/libz.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/bin/../lib/amd64/libz.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /etc/ld-musl-x86_64.path, 524288, 438) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /lib/libz.so.1, 524288, 0) = 7
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/server/libstdc++.so.6, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/libstdc++.so.6, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/../lib/amd64/libstdc++.so.6, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/lib/amd64/jli/libstdc++.so.6, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/bin/../lib/amd64/jli/libstdc++.so.6, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/bin/../lib/amd64/libstdc++.so.6, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /lib/libstdc++.so.6, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/local/lib/libstdc++.so.6, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/libstdc++.so.6, 524288, 0) = 7
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/server/libgcc_s.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/libgcc_s.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/../lib/amd64/libgcc_s.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/lib/amd64/jli/libgcc_s.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/bin/../lib/amd64/jli/libgcc_s.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/bin/../lib/amd64/libgcc_s.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /lib/libgcc_s.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/local/lib/libgcc_s.so.1, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=1  ] openat 56      (-100, /usr/lib/libgcc_s.so.1, 524288, 0) = 7
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/server/libverify.so, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/libverify.so, 524288, 0) = 7
...
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/endorsed, 589824, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/xawt/libmawt.so, 0, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/libawt_xawt.so, 0, 0) = 0
...
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/server/libjava.so, 524288, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/amd64/libjava.so, 524288, 0) = 7
...
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/jfr.jar, 0, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/classes, 0, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/meta-index, 0, 438) = 7
...
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, .hotspot_compiler, 0, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /etc/localtime, 526336, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/java/packages/lib/ext/meta-index, 0, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /usr/java/packages/lib/ext, 589824, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /tmp/.java_pid1, 0, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/sunrsasign.jar, 0, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/jsse.jar, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/jce.jar, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/charsets.jar, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/jfr.jar, 0, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/classes, 0, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/meta-index, 0, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /etc/timezone, 0, 438) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /etc/localtime, 0, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/share/javazi/tzdb.dat, 0, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/currency.properties, 0, 0) = -2  (No such file or directory) <--- !
...
[[ LKL SYSC ]] [tid=57 ] execve 221     (/usr/local/sbin/setsid, setsid, bash, 139838732215488, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] execve 221     (/usr/local/bin/setsid, setsid, bash, 139838732215488, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] execve 221     (/usr/sbin/setsid, setsid, bash, 139838732215488, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] writev 66      (2, 139838718685248, 2, 0, 0, 0) = -32 (Broken pipe) <--- !
[[ LKL SYSC ]] [tid=57 ] execve 221     (/usr/bin/setsid, setsid, bash, 139838732215488, 0) = -14  (Bad address) <--- !
[[ LKL SYSC ]] [tid=57 ] write  64      (3, 139838718686828, 4, 0, 0, 0) = -32 (Broken pipe) <--- !
[[ LKL SYSC ]] [tid=57 ] close  57      (3, 0, 0, 0, 0, 0) = 0
prp commented 4 years ago

@glorysdj Can you instead share the last 50 syscall lines that are executed? We want to see what the JVM is doing before it gets stuck.

glorysdj commented 4 years ago

@prp last syscalls. Thanks!

[[ LKL SYSC ]] [tid=57 ] newfstatat     79      (-100, /usr/lib/jvm/java-1.8-openjdk/jre/lib/currency.properties, 0, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29293185, 0, 0, 0, 0) = 29293185
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672016, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29293270, 0, 0, 0, 0) = 29293270
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672272, 926, 0, 0, 0) = 926
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29292160, 0, 0, 0, 0) = 29292160
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671920, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29292233, 0, 0, 0, 0) = 29292233
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672176, 936, 0, 0, 0) = 936
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29283542, 0, 0, 0, 0) = 29283542
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668768, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29283610, 0, 0, 0, 0) = 29283610
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669024, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29287706, 0, 0, 0, 0) = 29287706
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669024, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29291802, 0, 0, 0, 0) = 29291802
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669024, 342, 0, 0, 0) = 342
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29283130, 0, 0, 0, 0) = 29283130
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668960, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29283207, 0, 0, 0, 0) = 29283207
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669216, 319, 0, 0, 0) = 319
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29261483, 0, 0, 0, 0) = 29261483
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673040, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29261542, 0, 0, 0, 0) = 29261542
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673296, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29265638, 0, 0, 0, 0) = 29265638
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673296, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29269734, 0, 0, 0, 0) = 29269734
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673296, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29273830, 0, 0, 0, 0) = 29273830
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673296, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29277926, 0, 0, 0, 0) = 29277926
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673296, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29282022, 0, 0, 0, 0) = 29282022
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673296, 1092, 0, 0, 0) = 1092
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29259986, 0, 0, 0, 0) = 29259986
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671952, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29260045, 0, 0, 0, 0) = 29260045
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672208, 1422, 0, 0, 0) = 1422
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29254423, 0, 0, 0, 0) = 29254423
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672912, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29254478, 0, 0, 0, 0) = 29254478
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673168, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 29258574, 0, 0, 0, 0) = 29258574
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673168, 1396, 0, 0, 0) = 1396
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31773109, 0, 0, 0, 0) = 31773109
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673424, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31773159, 0, 0, 0, 0) = 31773159
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673680, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31777255, 0, 0, 0, 0) = 31777255
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673680, 3582, 0, 0, 0) = 3582
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 369352715, 0, 0, 0, 0) = 369352715
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424156032, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81912492, 0, 0, 0, 0) = 81912492
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718668048, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81912555, 0, 0, 0, 0) = 81912555
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718668320, 461, 0, 0, 0) = 461
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 369334593, 0, 0, 0, 0) = 369334593
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424160736, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81669399, 0, 0, 0, 0) = 81669399
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718668672, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81669471, 0, 0, 0, 0) = 81669471
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718668944, 800, 0, 0, 0) = 800
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 13677773, 0, 0, 0, 0) = 13677773
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664928, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 13677829, 0, 0, 0, 0) = 13677829
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718665184, 524, 0, 0, 0) = 524
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 369329482, 0, 0, 0, 0) = 369329482
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424160992, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81592775, 0, 0, 0, 0) = 81592775
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718669024, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81592848, 0, 0, 0, 0) = 81592848
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718669296, 740, 0, 0, 0) = 740
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 28798058, 0, 0, 0, 0) = 28798058
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675408, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 28798132, 0, 0, 0, 0) = 28798132
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675664, 509, 0, 0, 0) = 509
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 28193299, 0, 0, 0, 0) = 28193299
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675872, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 28193353, 0, 0, 0, 0) = 28193353
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676128, 698, 0, 0, 0) = 698
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 369332135, 0, 0, 0, 0) = 369332135
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424161248, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81635899, 0, 0, 0, 0) = 81635899
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718669312, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81635982, 0, 0, 0, 0) = 81635982
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718669584, 1288, 0, 0, 0) = 1288
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 369326835, 0, 0, 0, 0) = 369326835
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424161760, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81530013, 0, 0, 0, 0) = 81530013
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718671504, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81530077, 0, 0, 0, 0) = 81530077
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718671776, 720, 0, 0, 0) = 720
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 369329147, 0, 0, 0, 0) = 369329147
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424162752, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81588325, 0, 0, 0, 0) = 81588325
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718671328, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 81588391, 0, 0, 0, 0) = 81588391
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718671600, 337, 0, 0, 0) = 337
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 368932643, 0, 0, 0, 0) = 368932643
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424163104, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76491607, 0, 0, 0, 0) = 76491607
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718671792, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76491678, 0, 0, 0, 0) = 76491678
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718672064, 707, 0, 0, 0) = 707
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31435572, 0, 0, 0, 0) = 31435572
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718678528, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31435636, 0, 0, 0, 0) = 31435636
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718678784, 2009, 0, 0, 0) = 2009
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31434703, 0, 0, 0, 0) = 31434703
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676864, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31434776, 0, 0, 0, 0) = 31434776
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677120, 780, 0, 0, 0) = 780
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31434019, 0, 0, 0, 0) = 31434019
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674704, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31434096, 0, 0, 0, 0) = 31434096
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674960, 591, 0, 0, 0) = 591
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31433151, 0, 0, 0, 0) = 31433151
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676864, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31433221, 0, 0, 0, 0) = 31433221
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677120, 782, 0, 0, 0) = 782
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31431230, 0, 0, 0, 0) = 31431230
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677424, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31431312, 0, 0, 0, 0) = 31431312
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677680, 1823, 0, 0, 0) = 1823
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31429096, 0, 0, 0, 0) = 31429096
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677344, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31429169, 0, 0, 0, 0) = 31429169
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677600, 2045, 0, 0, 0) = 2045
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 368932730, 0, 0, 0, 0) = 368932730
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424166368, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76492401, 0, 0, 0, 0) = 76492401
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718672048, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76492486, 0, 0, 0, 0) = 76492486
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718672320, 1832, 0, 0, 0) = 1832
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 368932449, 0, 0, 0, 0) = 368932449
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424171168, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76490600, 0, 0, 0, 0) = 76490600
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718663632, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76490680, 0, 0, 0, 0) = 76490680
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718663904, 256, 0, 0, 0) = 256
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 32080925, 0, 0, 0, 0) = 32080925
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675664, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 32081002, 0, 0, 0, 0) = 32081002
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675920, 1178, 0, 0, 0) = 1178
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 368934562, 0, 0, 0, 0) = 368934562
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424166528, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76543835, 0, 0, 0, 0) = 76543835
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718671280, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76543898, 0, 0, 0, 0) = 76543898
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718671552, 824, 0, 0, 0) = 824
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 368934481, 0, 0, 0, 0) = 368934481
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838424168928, 160, 0, 0, 0) = 160
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76543315, 0, 0, 0, 0) = 76543315
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718668176, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (8, 76543380, 0, 0, 0, 0) = 76543380
[[ LKL SYSC ]] [tid=57 ] read   63      (8, 139838718668448, 439, 0, 0, 0) = 439
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27327077, 0, 0, 0, 0) = 27327077
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676144, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27327137, 0, 0, 0, 0) = 27327137
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676400, 3421, 0, 0, 0) = 3421
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27324848, 0, 0, 0, 0) = 27324848
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677984, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27324905, 0, 0, 0, 0) = 27324905
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718678240, 2156, 0, 0, 0) = 2156
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27320001, 0, 0, 0, 0) = 27320001
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718678304, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27320058, 0, 0, 0, 0) = 27320058
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718678560, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27324154, 0, 0, 0, 0) = 27324154
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718678560, 678, 0, 0, 0) = 678
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27319048, 0, 0, 0, 0) = 27319048
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676144, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27319101, 0, 0, 0, 0) = 27319101
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676400, 884, 0, 0, 0) = 884
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27316471, 0, 0, 0, 0) = 27316471
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676672, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27316537, 0, 0, 0, 0) = 27316537
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676928, 2495, 0, 0, 0) = 2495
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27315791, 0, 0, 0, 0) = 27315791
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675552, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27315864, 0, 0, 0, 0) = 27315864
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675808, 591, 0, 0, 0) = 591
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27312669, 0, 0, 0, 0) = 27312669
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674912, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27312722, 0, 0, 0, 0) = 27312722
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675168, 3053, 0, 0, 0) = 3053
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31592886, 0, 0, 0, 0) = 31592886
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675264, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31592948, 0, 0, 0, 0) = 31592948
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675520, 1112, 0, 0, 0) = 1112
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31197771, 0, 0, 0, 0) = 31197771
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674864, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31197824, 0, 0, 0, 0) = 31197824
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675120, 547, 0, 0, 0) = 547
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27310332, 0, 0, 0, 0) = 27310332
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675152, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27310392, 0, 0, 0, 0) = 27310392
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675408, 2261, 0, 0, 0) = 2261
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31685698, 0, 0, 0, 0) = 31685698
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676512, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31685768, 0, 0, 0, 0) = 31685768
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718676768, 1693, 0, 0, 0) = 1693
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31674842, 0, 0, 0, 0) = 31674842
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677680, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31674915, 0, 0, 0, 0) = 31674915
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677936, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31679011, 0, 0, 0, 0) = 31679011
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677936, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31683107, 0, 0, 0, 0) = 31683107
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677936, 2575, 0, 0, 0) = 2575
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31673595, 0, 0, 0, 0) = 31673595
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673440, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31673682, 0, 0, 0, 0) = 31673682
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673696, 1144, 0, 0, 0) = 1144
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31668635, 0, 0, 0, 0) = 31668635
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674480, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31668702, 0, 0, 0, 0) = 31668702
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674736, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31672798, 0, 0, 0, 0) = 31672798
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674736, 781, 0, 0, 0) = 781
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31661529, 0, 0, 0, 0) = 31661529
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674480, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31661590, 0, 0, 0, 0) = 31661590
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674736, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31665686, 0, 0, 0, 0) = 31665686
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674736, 2933, 0, 0, 0) = 2933
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31660649, 0, 0, 0, 0) = 31660649
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674864, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31660746, 0, 0, 0, 0) = 31660746
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675120, 767, 0, 0, 0) = 767
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31649975, 0, 0, 0, 0) = 31649975
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673584, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31650041, 0, 0, 0, 0) = 31650041
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673840, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31654137, 0, 0, 0, 0) = 31654137
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673840, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31658233, 0, 0, 0, 0) = 31658233
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673840, 2400, 0, 0, 0) = 2400
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31642957, 0, 0, 0, 0) = 31642957
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671392, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31643016, 0, 0, 0, 0) = 31643016
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671648, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31647112, 0, 0, 0, 0) = 31647112
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671648, 2847, 0, 0, 0) = 2847
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31641910, 0, 0, 0, 0) = 31641910
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669632, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31641976, 0, 0, 0, 0) = 31641976
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669888, 965, 0, 0, 0) = 965
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31641450, 0, 0, 0, 0) = 31641450
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669808, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31641510, 0, 0, 0, 0) = 31641510
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670064, 384, 0, 0, 0) = 384
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31640988, 0, 0, 0, 0) = 31640988
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669808, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31641050, 0, 0, 0, 0) = 31641050
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670064, 384, 0, 0, 0) = 384
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31640511, 0, 0, 0, 0) = 31640511
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669824, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31640581, 0, 0, 0, 0) = 31640581
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670080, 391, 0, 0, 0) = 391
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31640050, 0, 0, 0, 0) = 31640050
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669808, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31640110, 0, 0, 0, 0) = 31640110
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670064, 385, 0, 0, 0) = 385
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31636681, 0, 0, 0, 0) = 31636681
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674432, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31636745, 0, 0, 0, 0) = 31636745
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674688, 3289, 0, 0, 0) = 3289
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31629760, 0, 0, 0, 0) = 31629760
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674464, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31629828, 0, 0, 0, 0) = 31629828
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674720, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31633924, 0, 0, 0, 0) = 31633924
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674720, 2741, 0, 0, 0) = 2741
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31626408, 0, 0, 0, 0) = 31626408
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672224, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31626481, 0, 0, 0, 0) = 31626481
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672480, 2844, 0, 0, 0) = 2844
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31621916, 0, 0, 0, 0) = 31621916
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672320, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31621984, 0, 0, 0, 0) = 31621984
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672576, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31626080, 0, 0, 0, 0) = 31626080
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672576, 312, 0, 0, 0) = 312
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31616714, 0, 0, 0, 0) = 31616714
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672512, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31616791, 0, 0, 0, 0) = 31616791
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672768, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31620887, 0, 0, 0, 0) = 31620887
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672768, 1013, 0, 0, 0) = 1013
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31615245, 0, 0, 0, 0) = 31615245
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671728, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31615316, 0, 0, 0, 0) = 31615316
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671984, 1382, 0, 0, 0) = 1382
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31611449, 0, 0, 0, 0) = 31611449
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669568, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31611519, 0, 0, 0, 0) = 31611519
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669824, 3710, 0, 0, 0) = 3710
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31608325, 0, 0, 0, 0) = 31608325
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670016, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31608407, 0, 0, 0, 0) = 31608407
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670272, 3026, 0, 0, 0) = 3026
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31602529, 0, 0, 0, 0) = 31602529
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667856, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31602607, 0, 0, 0, 0) = 31602607
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668112, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31606703, 0, 0, 0, 0) = 31606703
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668112, 1606, 0, 0, 0) = 1606
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31601176, 0, 0, 0, 0) = 31601176
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668224, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31601256, 0, 0, 0, 0) = 31601256
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668480, 1257, 0, 0, 0) = 1257
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31596778, 0, 0, 0, 0) = 31596778
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667488, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31596848, 0, 0, 0, 0) = 31596848
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667744, 2526, 0, 0, 0) = 2526
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31595322, 0, 0, 0, 0) = 31595322
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718666864, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31595398, 0, 0, 0, 0) = 31595398
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667120, 1364, 0, 0, 0) = 1364
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 13821081, 0, 0, 0, 0) = 13821081
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718665280, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 13821162, 0, 0, 0, 0) = 13821162
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718665536, 1208, 0, 0, 0) = 1208
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31575534, 0, 0, 0, 0) = 31575534
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663760, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31575611, 0, 0, 0, 0) = 31575611
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664016, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31579707, 0, 0, 0, 0) = 31579707
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664016, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31583803, 0, 0, 0, 0) = 31583803
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664016, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31587899, 0, 0, 0, 0) = 31587899
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664016, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31591995, 0, 0, 0, 0) = 31591995
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664016, 875, 0, 0, 0) = 875
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31565084, 0, 0, 0, 0) = 31565084
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663968, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31565162, 0, 0, 0, 0) = 31565162
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664224, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31569258, 0, 0, 0, 0) = 31569258
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664224, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31573354, 0, 0, 0, 0) = 31573354
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664224, 2164, 0, 0, 0) = 2164
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31563623, 0, 0, 0, 0) = 31563623
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718661808, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31563702, 0, 0, 0, 0) = 31563702
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718662064, 1366, 0, 0, 0) = 1366
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31561494, 0, 0, 0, 0) = 31561494
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663856, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31561571, 0, 0, 0, 0) = 31561571
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664112, 2036, 0, 0, 0) = 2036
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31559987, 0, 0, 0, 0) = 31559987
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663856, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31560058, 0, 0, 0, 0) = 31560058
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664112, 1420, 0, 0, 0) = 1420
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31540968, 0, 0, 0, 0) = 31540968
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663840, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31541047, 0, 0, 0, 0) = 31541047
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664096, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31545143, 0, 0, 0, 0) = 31545143
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664096, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31549239, 0, 0, 0, 0) = 31549239
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664096, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31553335, 0, 0, 0, 0) = 31553335
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664096, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31557431, 0, 0, 0, 0) = 31557431
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664096, 2540, 0, 0, 0) = 2540
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31538067, 0, 0, 0, 0) = 31538067
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718661680, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31538147, 0, 0, 0, 0) = 31538147
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718661936, 2805, 0, 0, 0) = 2805
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31532867, 0, 0, 0, 0) = 31532867
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663120, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31532938, 0, 0, 0, 0) = 31532938
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663376, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31537034, 0, 0, 0, 0) = 31537034
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663376, 1017, 0, 0, 0) = 1017
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31530157, 0, 0, 0, 0) = 31530157
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663664, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31530229, 0, 0, 0, 0) = 31530229
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663920, 2622, 0, 0, 0) = 2622
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31523236, 0, 0, 0, 0) = 31523236
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663568, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31523308, 0, 0, 0, 0) = 31523308
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663824, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31527404, 0, 0, 0, 0) = 31527404
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663824, 2737, 0, 0, 0) = 2737
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31520027, 0, 0, 0, 0) = 31520027
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663952, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31520110, 0, 0, 0, 0) = 31520110
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664208, 3110, 0, 0, 0) = 3110
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31519143, 0, 0, 0, 0) = 31519143
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718661792, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31519227, 0, 0, 0, 0) = 31519227
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718662048, 784, 0, 0, 0) = 784
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31518276, 0, 0, 0, 0) = 31518276
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663696, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31518355, 0, 0, 0, 0) = 31518355
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663952, 772, 0, 0, 0) = 772
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31517047, 0, 0, 0, 0) = 31517047
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663792, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31517126, 0, 0, 0, 0) = 31517126
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718664048, 1134, 0, 0, 0) = 1134
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31515238, 0, 0, 0, 0) = 31515238
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718662800, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31515300, 0, 0, 0, 0) = 31515300
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663056, 1731, 0, 0, 0) = 1731
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31514930, 0, 0, 0, 0) = 31514930
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663168, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31514988, 0, 0, 0, 0) = 31514988
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718663424, 234, 0, 0, 0) = 234
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31514517, 0, 0, 0, 0) = 31514517
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667904, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31514583, 0, 0, 0, 0) = 31514583
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668160, 331, 0, 0, 0) = 331
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31513838, 0, 0, 0, 0) = 31513838
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718666240, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31513923, 0, 0, 0, 0) = 31513923
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718666496, 578, 0, 0, 0) = 578
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31512957, 0, 0, 0, 0) = 31512957
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667536, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31513037, 0, 0, 0, 0) = 31513037
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667792, 785, 0, 0, 0) = 785
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31511014, 0, 0, 0, 0) = 31511014
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671936, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31511079, 0, 0, 0, 0) = 31511079
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672192, 440, 0, 0, 0) = 440
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31508858, 0, 0, 0, 0) = 31508858
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669776, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31508911, 0, 0, 0, 0) = 31508911
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670032, 2087, 0, 0, 0) = 2087
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31507690, 0, 0, 0, 0) = 31507690
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671552, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31507745, 0, 0, 0, 0) = 31507745
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671808, 1097, 0, 0, 0) = 1097
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31507336, 0, 0, 0, 0) = 31507336
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669232, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31507394, 0, 0, 0, 0) = 31507394
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669488, 280, 0, 0, 0) = 280
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31506051, 0, 0, 0, 0) = 31506051
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671344, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31506117, 0, 0, 0, 0) = 31506117
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671600, 1203, 0, 0, 0) = 1203
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31504037, 0, 0, 0, 0) = 31504037
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673104, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31504125, 0, 0, 0, 0) = 31504125
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673360, 1910, 0, 0, 0) = 1910
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31501186, 0, 0, 0, 0) = 31501186
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670944, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31501261, 0, 0, 0, 0) = 31501261
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671200, 2760, 0, 0, 0) = 2760
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31500671, 0, 0, 0, 0) = 31500671
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671552, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31500748, 0, 0, 0, 0) = 31500748
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671808, 422, 0, 0, 0) = 422
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31498974, 0, 0, 0, 0) = 31498974
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671936, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31499048, 0, 0, 0, 0) = 31499048
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672192, 1607, 0, 0, 0) = 1607
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31497846, 0, 0, 0, 0) = 31497846
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670576, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31497937, 0, 0, 0, 0) = 31497937
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670832, 1021, 0, 0, 0) = 1021
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31486980, 0, 0, 0, 0) = 31486980
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669120, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31487049, 0, 0, 0, 0) = 31487049
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669376, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31491145, 0, 0, 0, 0) = 31491145
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669376, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31495241, 0, 0, 0, 0) = 31495241
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669376, 1766, 0, 0, 0) = 1766
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31485939, 0, 0, 0, 0) = 31485939
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669312, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31486023, 0, 0, 0, 0) = 31486023
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669568, 941, 0, 0, 0) = 941
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31482753, 0, 0, 0, 0) = 31482753
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669024, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31482832, 0, 0, 0, 0) = 31482832
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669280, 3091, 0, 0, 0) = 3091
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31477479, 0, 0, 0, 0) = 31477479
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669504, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31477548, 0, 0, 0, 0) = 31477548
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669760, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31481644, 0, 0, 0, 0) = 31481644
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669760, 1093, 0, 0, 0) = 1093
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 13818202, 0, 0, 0, 0) = 13818202
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673392, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 13818286, 0, 0, 0, 0) = 13818286
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673648, 654, 0, 0, 0) = 654
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 13817599, 0, 0, 0, 0) = 13817599
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672864, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 13817679, 0, 0, 0, 0) = 13817679
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673120, 507, 0, 0, 0) = 507
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 15506512, 0, 0, 0, 0) = 15506512
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672656, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 15506602, 0, 0, 0, 0) = 15506602
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672912, 437, 0, 0, 0) = 437
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31475045, 0, 0, 0, 0) = 31475045
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672112, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31475123, 0, 0, 0, 0) = 31475123
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672368, 2340, 0, 0, 0) = 2340
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31474110, 0, 0, 0, 0) = 31474110
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718669952, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31474189, 0, 0, 0, 0) = 31474189
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670208, 840, 0, 0, 0) = 840
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31786722, 0, 0, 0, 0) = 31786722
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671872, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31786796, 0, 0, 0, 0) = 31786796
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672128, 1796, 0, 0, 0) = 1796
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 24690380, 0, 0, 0, 0) = 24690380
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672288, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 24690463, 0, 0, 0, 0) = 24690463
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672544, 1365, 0, 0, 0) = 1365
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31467367, 0, 0, 0, 0) = 31467367
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674592, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31467447, 0, 0, 0, 0) = 31467447
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674848, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31471543, 0, 0, 0, 0) = 31471543
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674848, 2551, 0, 0, 0) = 2551
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31463497, 0, 0, 0, 0) = 31463497
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672432, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31463585, 0, 0, 0, 0) = 31463585
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672688, 3766, 0, 0, 0) = 3766
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31461255, 0, 0, 0, 0) = 31461255
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673456, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31461319, 0, 0, 0, 0) = 31461319
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673712, 2162, 0, 0, 0) = 2162
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31460697, 0, 0, 0, 0) = 31460697
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673136, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31460765, 0, 0, 0, 0) = 31460765
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673392, 474, 0, 0, 0) = 474
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31459074, 0, 0, 0, 0) = 31459074
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670080, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31459145, 0, 0, 0, 0) = 31459145
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670336, 1536, 0, 0, 0) = 1536
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31458655, 0, 0, 0, 0) = 31458655
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668576, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31458713, 0, 0, 0, 0) = 31458713
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668832, 345, 0, 0, 0) = 345
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31458224, 0, 0, 0, 0) = 31458224
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668576, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31458292, 0, 0, 0, 0) = 31458292
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668832, 347, 0, 0, 0) = 347
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31449780, 0, 0, 0, 0) = 31449780
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668576, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31449841, 0, 0, 0, 0) = 31449841
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668832, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31453937, 0, 0, 0, 0) = 31453937
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668832, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31458033, 0, 0, 0, 0) = 31458033
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718668832, 175, 0, 0, 0) = 175
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31449244, 0, 0, 0, 0) = 31449244
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667488, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31449316, 0, 0, 0, 0) = 31449316
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718667744, 448, 0, 0, 0) = 448
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31448277, 0, 0, 0, 0) = 31448277
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670032, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31448350, 0, 0, 0, 0) = 31448350
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670288, 878, 0, 0, 0) = 878
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31445767, 0, 0, 0, 0) = 31445767
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674080, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31445838, 0, 0, 0, 0) = 31445838
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674336, 2423, 0, 0, 0) = 2423
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31444440, 0, 0, 0, 0) = 31444440
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671760, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31444509, 0, 0, 0, 0) = 31444509
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672016, 1242, 0, 0, 0) = 1242
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31442390, 0, 0, 0, 0) = 31442390
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674320, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31442496, 0, 0, 0, 0) = 31442496
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674576, 1928, 0, 0, 0) = 1928
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31438432, 0, 0, 0, 0) = 31438432
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672160, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31438512, 0, 0, 0, 0) = 31438512
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672416, 3862, 0, 0, 0) = 3862
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31437661, 0, 0, 0, 0) = 31437661
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674480, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 31437743, 0, 0, 0, 0) = 31437743
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674736, 673, 0, 0, 0) = 673
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 30840068, 0, 0, 0, 0) = 30840068
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674656, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 30840147, 0, 0, 0, 0) = 30840147
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674912, 601, 0, 0, 0) = 601
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27309053, 0, 0, 0, 0) = 27309053
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674096, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27309112, 0, 0, 0, 0) = 27309112
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674352, 490, 0, 0, 0) = 490
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27308837, 0, 0, 0, 0) = 27308837
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718677760, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27308902, 0, 0, 0, 0) = 27308902
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718678016, 135, 0, 0, 0) = 135
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27308605, 0, 0, 0, 0) = 27308605
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675296, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27308675, 0, 0, 0, 0) = 27308675
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718675552, 146, 0, 0, 0) = 146
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27306443, 0, 0, 0, 0) = 27306443
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674016, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27306509, 0, 0, 0, 0) = 27306509
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674272, 2080, 0, 0, 0) = 2080
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27296159, 0, 0, 0, 0) = 27296159
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674480, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27296234, 0, 0, 0, 0) = 27296234
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674736, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27300330, 0, 0, 0, 0) = 27300330
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674736, 4096, 0, 0, 0) = 4096
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27304426, 0, 0, 0, 0) = 27304426
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674736, 2001, 0, 0, 0) = 2001
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27292217, 0, 0, 0, 0) = 27292217
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672320, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27292297, 0, 0, 0, 0) = 27292297
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672576, 3846, 0, 0, 0) = 3846
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27291574, 0, 0, 0, 0) = 27291574
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670000, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27291646, 0, 0, 0, 0) = 27291646
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718670256, 555, 0, 0, 0) = 555
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27290953, 0, 0, 0, 0) = 27290953
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673392, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27291040, 0, 0, 0, 0) = 27291040
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718673648, 518, 0, 0, 0) = 518
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27290691, 0, 0, 0, 0) = 27290691
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671072, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27290772, 0, 0, 0, 0) = 27290772
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718671328, 165, 0, 0, 0) = 165
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27522704, 0, 0, 0, 0) = 27522704
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674144, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27522769, 0, 0, 0, 0) = 27522769
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674400, 1757, 0, 0, 0) = 1757
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27522030, 0, 0, 0, 0) = 27522030
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672640, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27522097, 0, 0, 0, 0) = 27522097
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672896, 591, 0, 0, 0) = 591
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27521304, 0, 0, 0, 0) = 27521304
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672640, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27521371, 0, 0, 0, 0) = 27521371
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672896, 643, 0, 0, 0) = 643
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27520584, 0, 0, 0, 0) = 27520584
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672640, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27520651, 0, 0, 0, 0) = 27520651
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672896, 637, 0, 0, 0) = 637
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27519849, 0, 0, 0, 0) = 27519849
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672640, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27519916, 0, 0, 0, 0) = 27519916
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672896, 652, 0, 0, 0) = 652
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27519110, 0, 0, 0, 0) = 27519110
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672640, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27519177, 0, 0, 0, 0) = 27519177
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672896, 656, 0, 0, 0) = 656
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27518359, 0, 0, 0, 0) = 27518359
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672640, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27518426, 0, 0, 0, 0) = 27518426
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672896, 668, 0, 0, 0) = 668
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27517609, 0, 0, 0, 0) = 27517609
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672640, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27517676, 0, 0, 0, 0) = 27517676
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672896, 667, 0, 0, 0) = 667
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27287339, 0, 0, 0, 0) = 27287339
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674416, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27287412, 0, 0, 0, 0) = 27287412
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674672, 3263, 0, 0, 0) = 3263
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27284609, 0, 0, 0, 0) = 27284609
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674224, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27284696, 0, 0, 0, 0) = 27284696
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674480, 2627, 0, 0, 0) = 2627
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27284162, 0, 0, 0, 0) = 27284162
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672064, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27284246, 0, 0, 0, 0) = 27284246
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718672320, 347, 0, 0, 0) = 347
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27282890, 0, 0, 0, 0) = 27282890
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674176, 30, 0, 0, 0) = 30
[[ LKL SYSC ]] [tid=57 ] lseek  62      (7, 27282983, 0, 0, 0, 0) = 27282983
[[ LKL SYSC ]] [tid=57 ] read   63      (7, 139838718674432, 1163, 0, 0, 0) = 1163
[[ LKL SYSC ]] [tid=57 ] rt_sigaction   134     (17, 139838718685984, 0, 8, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] pipe2  59      (139838718686968, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] pipe2  59      (139838718686976, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] pipe2  59      (139838718686984, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] pipe2  59      (139838718687000, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] pipe2  59      (139838718686992, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (10, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (11, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (13, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (15, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (16, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (17, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] dup3   24      (9, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (9, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] dup3   24      (12, 1, 0, 0, 0, 0) = 1
[[ LKL SYSC ]] [tid=57 ] close  57      (12, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] dup3   24      (14, 2, 0, 0, 0, 0) = 2
[[ LKL SYSC ]] [tid=57 ] close  57      (14, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] dup3   24      (18, 3, 0, 0, 0, 0) = 3
[[ LKL SYSC ]] [tid=57 ] close  57      (18, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (4, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (5, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] openat 56      (-100, /proc/self/fd, 589824, 0) = 4
[[ LKL SYSC ]] [tid=57 ] fcntl  25      (4, 2, 1, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] getdents64     61      (4, 139838425471480, 2048, 0, 0, 0) = 240
[[ LKL SYSC ]] [tid=57 ] close  57      (6, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (7, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (8, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] getdents64     61      (4, 139838425471480, 2048, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] close  57      (4, 0, 0, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] fcntl  25      (3, 2, 1, 0, 0, 0) = 0
[[ LKL SYSC ]] [tid=57 ] execve 221     (/usr/local/sbin/setsid, setsid, bash, 139838732215488, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] execve 221     (/usr/local/bin/setsid, setsid, bash, 139838732215488, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] execve 221     (/usr/sbin/setsid, setsid, bash, 139838732215488, 0) = -2  (No such file or directory) <--- !
[[ LKL SYSC ]] [tid=57 ] writev 66      (2, 139838718685248, 2, 0, 0, 0) = -32 (Broken pipe) <--- !
[[ LKL SYSC ]] [tid=57 ] execve 221     (/usr/bin/setsid, setsid, bash, 139838732215488, 0) = -14  (Bad address) <--- !
[[ LKL SYSC ]] [tid=57 ] write  64      (3, 139838718686828, 4, 0, 0, 0) = -32 (Broken pipe) <--- !
[[ LKL SYSC ]] [tid=57 ] close  57      (3, 0, 0, 0, 0, 0) = 0
prp commented 4 years ago

Ok, this cannot work, as the application is invoking an execve syscall, which is not supported (see https://github.com/lsds/sgx-lkl/issues/175).

Is this happening while the Java application is already running (i.e. it already printed "Hello World" in your sample code above)? If so, we would have to understand why the JVM tries to invoke a shell.

glorysdj commented 4 years ago

Yes, I have run System.out.println("Hello World"); before it. let me check #175. Thanks.

glorysdj commented 4 years ago

But even I put only the String lowered = StringUtils.toLowerCase("ADSAFFDSzcxcx"); in the java program, same error happens. It has nothing to do with the System.out.println("Hello World"). So why execve to invoke a shell? And how can we support such codes. I plan to run a bigdata/machine learning program in SGX-LKL, this is the first step to load a model from file system, and StringUtils is just a line of code in hadoop-clients lib.

SeanTAllen commented 4 years ago

Which StringUtils package are you using? There are several.

Can you provide a minimal complete java program including import and main that is runnable that demonstrates the problem?

Thanks.

glorysdj commented 4 years ago

@SeanTAllen Thanks for reminding me, I've checked it, it's org.apache.hadoop.util.StringUtils; @prp There is a line of static code in org.apache.hadoop.util.StringUtils

 public static final Pattern ENV_VAR_PATTERN = Shell.WINDOWS ?
    WIN_ENV_VAR_PATTERN : SHELL_ENV_VAR_PATTERN;

This may invoke a shell.

shexec = new ShellCommandExecutor(args);
shexec.execute();

and this will call java.lang.ProcessBuilder to start a process.

So, java's standard java.lang.ProcessBuilder is not supported by SGX-LKL because it is multi-process?

glorysdj commented 4 years ago

Also note that SGX-LKL doesn't support glibc currently, which you seem to be using from https://github.com/sgerrand/alpine-pkg-glibc.

@letmaik what does SGX-LKL doesn't support glibc mean? Can't I install it in the Dockerfile and then make a disk-image and run program in it?

I also plan to run OpenVINO in SGX-LKL, when I load model from OpenVINO, I may need libiomp5.so

Which will casue error.

Exception in thread "main" java.lang.UnsatisfiedLinkError: /tmp/openvino_native_libraries-1592272507980-0/libiomp5.so: Error relocating /tmp/openvino_native_libraries-1592272507980-0/libiomp5.so: __strncpy_chk: symbol not found
letmaik commented 4 years ago

Also note that SGX-LKL doesn't support glibc currently, which you seem to be using from https://github.com/sgerrand/alpine-pkg-glibc.

@letmaik what does SGX-LKL doesn't support glibc mean? Can't I install it in the Dockerfile and then make a disk-image and run program in it?

See the summary text at https://github.com/lsds/sgx-lkl/tree/oe_port#c-running-applications-with-sgx-lkl: "Currently, applications linked against glibc are not supported by SGX-LKL. The simplest way to run applications with SGX-LKL is to use prebuilt binaries for Alpine Linux, which uses musl libc as its default C standard library."

I also plan to run OpenVINO in SGX-LKL, when I load model from OpenVINO, I may need libiomp5.so

We have an example for OpenVINO: https://github.com/lsds/sgx-lkl/tree/oe_port/samples/ml/openvino Maybe you can adapt that?

glorysdj commented 4 years ago

Also note that SGX-LKL doesn't support glibc currently, which you seem to be using from https://github.com/sgerrand/alpine-pkg-glibc.

@letmaik what does SGX-LKL doesn't support glibc mean? Can't I install it in the Dockerfile and then make a disk-image and run program in it?

See the summary text at https://github.com/lsds/sgx-lkl/tree/oe_port#c-running-applications-with-sgx-lkl: "Currently, applications linked against glibc are not supported by SGX-LKL. The simplest way to run applications with SGX-LKL is to use prebuilt binaries for Alpine Linux, which uses musl libc as its default C standard library."

I also plan to run OpenVINO in SGX-LKL, when I load model from OpenVINO, I may need libiomp5.so

We have an example for OpenVINO: https://github.com/lsds/sgx-lkl/tree/oe_port/samples/ml/openvino Maybe you can adapt that?

yes, thanks a lot, we will try this.

SeanTAllen commented 4 years ago

We believe this has been fixed. If it hasn't, please reopen.