Skip to content

Instantly share code, notes, and snippets.

@notnoopci

notnoopci/hosed-lxc-start

Last active August 29, 2015 14:07
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save notnoopci/56cc26e3573745c65a73 to your computer and use it in GitHub Desktop.
Save notnoopci/56cc26e3573745c65a73 to your computer and use it in GitHub Desktop.
Download ZIP
Hosed lxc-start. The files are generated with the `aascript` commands
Raw
hosed-lxc-start
ubuntu@ip-10-63-130-120:~$ uname -a
Linux ip-10-63-130-120 3.14.19-031419-generic #201409171336 SMP Wed Sep 17 17:37:43 UTC 2014 x86_64 x86_64 x86_64 GNU/Linux
ubuntu@ip-10-63-130-120:~$ dpkg -l |grep lxc
ii liblxc1 1.0.5-0ubuntu0.1 amd64 Linux Containers userspace tools (library)
ii lxc 1.0.5-0ubuntu0.1 amd64 Linux Containers userspace tools
ii lxc-templates 1.0.5-0ubuntu0.1 amd64 Linux Containers userspace tools (templates)
ii python3-lxc 1.0.5-0ubuntu0.1 amd64 Linux Containers userspace tools (Python 3.x bindings)
ubuntu@ip-10-63-130-120:~$ dpkg -l |grep cgroup
ii cgmanager 0.24-0ubuntu7 amd64 Central cgroup manager daemon
ii cgmanager-utils 0.24-0ubuntu7 amd64 Central cgroup manager daemon (utilities)
ii cgroup-lite 1.9 all Light-weight package to set up cgroups at system boot
ii libcgmanager0:amd64 0.24-0ubuntu7 amd64 Central cgroup manager daemon (client library)
ubuntu@ip-10-63-130-120:~$ sudo lxc-create -t download -n p3 -- -d ubuntu -r trusty -a amd64
Using image from local cache
Unpacking the rootfs
---
You just created an Ubuntu container (release=trusty, arch=amd64, variant=default)
The default username/password is: ubuntu / ubuntu
To gain root privileges, please use sudo.
ubuntu@ip-10-63-130-120:~$ sudo strace -f -r -t -T -y -o p3.strace lxc-start -n p3 -o p3.log -l trace -- echo hi
[... hanging ...]
Raw
p3.log
lxc-start 1413476555.026 INFO lxc_start_ui - using rcfile /var/lib/lxc/p3/config
lxc-start 1413476555.029 WARN lxc_log - lxc_log_init called with log already initialized
lxc-start 1413476555.029 INFO lxc_lsm - LSM security driver nop
lxc-start 1413476555.030 INFO lxc_seccomp - processing: .[all].
lxc-start 1413476555.031 INFO lxc_seccomp - processing: .kexec_load errno 1.
lxc-start 1413476555.031 INFO lxc_seccomp - Adding non-compat rule for kexec_load action 327681
lxc-start 1413476555.031 INFO lxc_seccomp - Adding compat rule for kexec_load action 327681
lxc-start 1413476555.031 INFO lxc_seccomp - Really adding compat rule bc nr1 == nr2 (283, 246)
lxc-start 1413476555.031 INFO lxc_seccomp - processing: .open_by_handle_at errno 1.
lxc-start 1413476555.031 INFO lxc_seccomp - Adding non-compat rule for open_by_handle_at action 327681
lxc-start 1413476555.031 INFO lxc_seccomp - Adding compat rule for open_by_handle_at action 327681
lxc-start 1413476555.032 INFO lxc_seccomp - Really adding compat rule bc nr1 == nr2 (342, 304)
lxc-start 1413476555.032 INFO lxc_seccomp - processing: .init_module errno 1.
lxc-start 1413476555.032 INFO lxc_seccomp - Adding non-compat rule for init_module action 327681
lxc-start 1413476555.032 INFO lxc_seccomp - Adding compat rule for init_module action 327681
lxc-start 1413476555.032 INFO lxc_seccomp - Really adding compat rule bc nr1 == nr2 (128, 175)
lxc-start 1413476555.032 INFO lxc_seccomp - processing: .finit_module errno 1.
lxc-start 1413476555.032 INFO lxc_seccomp - Adding non-compat rule for finit_module action 327681
lxc-start 1413476555.033 WARN lxc_seccomp - Seccomp: got negative # for syscall: finit_module
lxc-start 1413476555.033 WARN lxc_seccomp - This syscall will NOT be blacklisted
lxc-start 1413476555.033 INFO lxc_seccomp - Adding compat rule for finit_module action 327681
lxc-start 1413476555.033 INFO lxc_seccomp - Adding non-compat rule bc nr1 == nr2 (-10085, -10085)
lxc-start 1413476555.033 WARN lxc_seccomp - Seccomp: got negative # for syscall: finit_module
lxc-start 1413476555.033 WARN lxc_seccomp - This syscall will NOT be blacklisted
lxc-start 1413476555.033 INFO lxc_seccomp - processing: .delete_module errno 1.
lxc-start 1413476555.033 INFO lxc_seccomp - Adding non-compat rule for delete_module action 327681
lxc-start 1413476555.034 INFO lxc_seccomp - Adding compat rule for delete_module action 327681
lxc-start 1413476555.034 INFO lxc_seccomp - Really adding compat rule bc nr1 == nr2 (129, 176)
lxc-start 1413476555.034 INFO lxc_seccomp - Merging in the compat seccomp ctx into the main one
lxc-start 1413476555.040 DEBUG lxc_conf - allocated pty '/dev/pts/86' (5/6)
lxc-start 1413476555.041 DEBUG lxc_conf - allocated pty '/dev/pts/87' (7/8)
lxc-start 1413476555.042 DEBUG lxc_conf - allocated pty '/dev/pts/88' (9/10)
lxc-start 1413476555.043 DEBUG lxc_conf - allocated pty '/dev/pts/89' (11/12)
lxc-start 1413476555.043 INFO lxc_conf - tty's configured
lxc-start 1413476555.043 DEBUG lxc_start - sigchild handler set
lxc-start 1413476555.044 DEBUG lxc_console - opening /dev/tty for console peer
lxc-start 1413476555.045 DEBUG lxc_console - using '/dev/tty' as console
lxc-start 1413476555.045 DEBUG lxc_console - 61332 got SIGWINCH fd 17
lxc-start 1413476555.045 DEBUG lxc_console - set winsz dstfd:14 cols:266 rows:66
lxc-start 1413476555.046 INFO lxc_start - 'p3' is initialized
lxc-start 1413476555.060 DEBUG lxc_start - Not dropping cap_sys_boot or watching utmp
lxc-start 1413476555.070 DEBUG lxc_conf - instanciated veth 'vethXTAQ6L/vethETFVG8', index is '154'
lxc-start 1413476555.070 INFO lxc_cgroup - cgroup driver cgmanager initing for p3
Raw
p3.strace
61332 0.000000 execve("/usr/bin/lxc-start", ["lxc-start", "-n", "p3", "-o", "p3.log", "-l", "trace", "--", "echo", "hi"], [/* 16 vars */]) = 0 <0.000214>
61332 0.000332 brk(0) = 0x7f54c7d92000 <0.000027>
61332 0.000083 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000030>
61332 0.000090 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c678a000 <0.000028>
61332 0.000074 access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000075 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3 <0.000033>
61332 0.000075 fstat(3</etc/ld.so.cache>, {st_mode=S_IFREG|0644, st_size=34793, ...}) = 0 <0.000029>
61332 0.000093 mmap(NULL, 34793, PROT_READ, MAP_PRIVATE, 3</etc/ld.so.cache>, 0) = 0x7f54c6781000 <0.000028>
61332 0.000069 close(3</etc/ld.so.cache>) = 0 <0.000026>
61332 0.000068 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000028>
61332 0.000070 open("/usr/lib/x86_64-linux-gnu/liblxc.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000032>
61332 0.000068 read(3</usr/lib/x86_64-linux-gnu/liblxc.so.1.0.5>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\312\0\0\0\0\0\0"..., 832) = 832 <0.000030>
61332 0.000080 fstat(3</usr/lib/x86_64-linux-gnu/liblxc.so.1.0.5>, {st_mode=S_IFREG|0644, st_size=443472, ...}) = 0 <0.000028>
61332 0.000073 mmap(NULL, 2538760, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</usr/lib/x86_64-linux-gnu/liblxc.so.1.0.5>, 0) = 0x7f54c62fe000 <0.000030>
61332 0.000070 mprotect(0x7f54c6367000, 2097152, PROT_NONE) = 0 <0.000031>
61332 0.000067 mmap(0x7f54c6567000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</usr/lib/x86_64-linux-gnu/liblxc.so.1.0.5>, 0x69000) = 0x7f54c6567000 <0.000032>
61332 0.000080 close(3</usr/lib/x86_64-linux-gnu/liblxc.so.1.0.5>) = 0 <0.000027>
61332 0.000070 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000028>
61332 0.000067 open("/lib/x86_64-linux-gnu/libpthread.so.0", O_RDONLY|O_CLOEXEC) = 3 <0.000031>
61332 0.000065 read(3</lib/x86_64-linux-gnu/libpthread-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0po\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000070 fstat(3</lib/x86_64-linux-gnu/libpthread-2.19.so>, {st_mode=S_IFREG|0755, st_size=141574, ...}) = 0 <0.000027>
61332 0.000069 mmap(NULL, 2217264, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libpthread-2.19.so>, 0) = 0x7f54c60e0000 <0.000032>
61332 0.000071 mprotect(0x7f54c60f9000, 2093056, PROT_NONE) = 0 <0.000030>
61332 0.000065 mmap(0x7f54c62f8000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libpthread-2.19.so>, 0x18000) = 0x7f54c62f8000 <0.000032>
61332 0.000075 mmap(0x7f54c62fa000, 13616, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f54c62fa000 <0.000028>
61332 0.000069 close(3</lib/x86_64-linux-gnu/libpthread-2.19.so>) = 0 <0.000027>
61332 0.000068 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000029>
61332 0.000070 open("/lib/x86_64-linux-gnu/libc.so.6", O_RDONLY|O_CLOEXEC) = 3 <0.000031>
61332 0.000067 read(3</lib/x86_64-linux-gnu/libc-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\37\2\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000070 fstat(3</lib/x86_64-linux-gnu/libc-2.19.so>, {st_mode=S_IFREG|0755, st_size=1845024, ...}) = 0 <0.000027>
61332 0.000069 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6780000 <0.000028>
61332 0.000075 mmap(NULL, 3953344, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libc-2.19.so>, 0) = 0x7f54c5d1a000 <0.000032>
61332 0.000076 mprotect(0x7f54c5ed5000, 2097152, PROT_NONE) = 0 <0.000031>
61332 0.000065 mmap(0x7f54c60d5000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libc-2.19.so>, 0x1bb000) = 0x7f54c60d5000 <0.000032>
61332 0.000087 mmap(0x7f54c60db000, 17088, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f54c60db000 <0.000028>
61332 0.000068 close(3</lib/x86_64-linux-gnu/libc-2.19.so>) = 0 <0.000027>
61332 0.000070 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000065 open("/lib/x86_64-linux-gnu/libcap.so.2", O_RDONLY|O_CLOEXEC) = 3 <0.000031>
61332 0.000066 read(3</lib/x86_64-linux-gnu/libcap.so.2.24>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 \26\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000069 fstat(3</lib/x86_64-linux-gnu/libcap.so.2.24>, {st_mode=S_IFREG|0644, st_size=18952, ...}) = 0 <0.000028>
61332 0.000070 mmap(NULL, 2114160, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libcap.so.2.24>, 0) = 0x7f54c5b15000 <0.000030>
61332 0.000070 mprotect(0x7f54c5b19000, 2093056, PROT_NONE) = 0 <0.000030>
61332 0.000064 mmap(0x7f54c5d18000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libcap.so.2.24>, 0x3000) = 0x7f54c5d18000 <0.000030>
61332 0.000077 close(3</lib/x86_64-linux-gnu/libcap.so.2.24>) = 0 <0.000027>
61332 0.000068 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000066 open("/usr/lib/x86_64-linux-gnu/libapparmor.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000031>
61332 0.000067 read(3</usr/lib/x86_64-linux-gnu/libapparmor.so.1.1.0>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\300\30\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000070 fstat(3</usr/lib/x86_64-linux-gnu/libapparmor.so.1.1.0>, {st_mode=S_IFREG|0644, st_size=47984, ...}) = 0 <0.000028>
61332 0.000069 mmap(NULL, 2143152, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</usr/lib/x86_64-linux-gnu/libapparmor.so.1.1.0>, 0) = 0x7f54c5909000 <0.000030>
61332 0.000069 mprotect(0x7f54c5914000, 2093056, PROT_NONE) = 0 <0.000028>
61332 0.000062 mmap(0x7f54c5b13000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</usr/lib/x86_64-linux-gnu/libapparmor.so.1.1.0>, 0xa000) = 0x7f54c5b13000 <0.000030>
61332 0.000078 close(3</usr/lib/x86_64-linux-gnu/libapparmor.so.1.1.0>) = 0 <0.000027>
61332 0.000068 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000064 open("/lib/x86_64-linux-gnu/libselinux.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000030>
61332 0.000065 read(3</lib/x86_64-linux-gnu/libselinux.so.1>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0[\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000068 fstat(3</lib/x86_64-linux-gnu/libselinux.so.1>, {st_mode=S_IFREG|0644, st_size=134296, ...}) = 0 <0.000028>
61332 0.000070 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c677f000 <0.000028>
61332 0.000065 mmap(NULL, 2238192, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libselinux.so.1>, 0) = 0x7f54c56e6000 <0.000030>
61332 0.000069 mprotect(0x7f54c5706000, 2093056, PROT_NONE) = 0 <0.000029>
61332 0.000063 mmap(0x7f54c5905000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libselinux.so.1>, 0x1f000) = 0x7f54c5905000 <0.000031>
61332 0.000075 mmap(0x7f54c5907000, 5872, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f54c5907000 <0.000032>
61332 0.000073 close(3</lib/x86_64-linux-gnu/libselinux.so.1>) = 0 <0.000026>
61332 0.000069 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000028>
61332 0.000064 open("/usr/lib/x86_64-linux-gnu/libseccomp.so.2", O_RDONLY|O_CLOEXEC) = 3 <0.000030>
61332 0.000066 read(3</usr/lib/x86_64-linux-gnu/libseccomp.so.2.1.0>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\207\0\0\0\0\0\0"..., 832) = 832 <0.000027>
61332 0.000068 fstat(3</usr/lib/x86_64-linux-gnu/libseccomp.so.2.1.0>, {st_mode=S_IFREG|0644, st_size=92336, ...}) = 0 <0.000027>
61332 0.000069 mmap(NULL, 2187464, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</usr/lib/x86_64-linux-gnu/libseccomp.so.2.1.0>, 0) = 0x7f54c54cf000 <0.000030>
61332 0.000078 mprotect(0x7f54c54e0000, 2097152, PROT_NONE) = 0 <0.000030>
61332 0.000063 mmap(0x7f54c56e0000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</usr/lib/x86_64-linux-gnu/libseccomp.so.2.1.0>, 0x11000) = 0x7f54c56e0000 <0.000030>
61332 0.000077 close(3</usr/lib/x86_64-linux-gnu/libseccomp.so.2.1.0>) = 0 <0.000027>
61332 0.000069 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000065 open("/lib/x86_64-linux-gnu/libcgmanager.so.0", O_RDONLY|O_CLOEXEC) = 3 <0.000030>
61332 0.000067 read(3</lib/x86_64-linux-gnu/libcgmanager.so.0.0.0>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0206\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000069 fstat(3</lib/x86_64-linux-gnu/libcgmanager.so.0.0.0>, {st_mode=S_IFREG|0644, st_size=108480, ...}) = 0 <0.000027>
61332 0.000069 mmap(NULL, 2203688, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libcgmanager.so.0.0.0>, 0) = 0x7f54c52b4000 <0.000031>
61332 0.000070 mprotect(0x7f54c52cd000, 2093056, PROT_NONE) = 0 <0.000030>
61332 0.000064 mmap(0x7f54c54cc000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libcgmanager.so.0.0.0>, 0x18000) = 0x7f54c54cc000 <0.000031>
61332 0.000079 close(3</lib/x86_64-linux-gnu/libcgmanager.so.0.0.0>) = 0 <0.000027>
61332 0.000070 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000028>
61332 0.000065 open("/lib/x86_64-linux-gnu/libnih.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000031>
61332 0.000066 read(3</lib/x86_64-linux-gnu/libnih.so.1.0.0>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`G\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000070 fstat(3</lib/x86_64-linux-gnu/libnih.so.1.0.0>, {st_mode=S_IFREG|0644, st_size=96280, ...}) = 0 <0.000028>
61332 0.000069 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c677e000 <0.000027>
61332 0.000065 mmap(NULL, 2191776, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libnih.so.1.0.0>, 0) = 0x7f54c509c000 <0.000031>
61332 0.000070 mprotect(0x7f54c50b3000, 2093056, PROT_NONE) = 0 <0.000029>
61332 0.000063 mmap(0x7f54c52b2000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libnih.so.1.0.0>, 0x16000) = 0x7f54c52b2000 <0.000031>
61332 0.000079 close(3</lib/x86_64-linux-gnu/libnih.so.1.0.0>) = 0 <0.000027>
61332 0.000071 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000028>
61332 0.000066 open("/lib/x86_64-linux-gnu/libnih-dbus.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000032>
61332 0.000069 read(3</lib/x86_64-linux-gnu/libnih-dbus.so.1.0.0>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\340,\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000073 fstat(3</lib/x86_64-linux-gnu/libnih-dbus.so.1.0.0>, {st_mode=S_IFREG|0644, st_size=38920, ...}) = 0 <0.000027>
61332 0.000070 mmap(NULL, 2134040, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libnih-dbus.so.1.0.0>, 0) = 0x7f54c4e92000 <0.000030>
61332 0.000069 mprotect(0x7f54c4e9a000, 2097152, PROT_NONE) = 0 <0.000030>
61332 0.000063 mmap(0x7f54c509a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libnih-dbus.so.1.0.0>, 0x8000) = 0x7f54c509a000 <0.000031>
61332 0.000077 close(3</lib/x86_64-linux-gnu/libnih-dbus.so.1.0.0>) = 0 <0.000026>
61332 0.000069 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000067 open("/lib/x86_64-linux-gnu/libdbus-1.so.3", O_RDONLY|O_CLOEXEC) = 3 <0.000030>
61332 0.000065 read(3</lib/x86_64-linux-gnu/libdbus-1.so.3.7.6>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0@h\0\0\0\0\0\0"..., 832) = 832 <0.000027>
61332 0.000068 fstat(3</lib/x86_64-linux-gnu/libdbus-1.so.3.7.6>, {st_mode=S_IFREG|0644, st_size=281552, ...}) = 0 <0.000028>
61332 0.000075 mmap(NULL, 2377408, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libdbus-1.so.3.7.6>, 0) = 0x7f54c4c4d000 <0.000031>
61332 0.000070 mprotect(0x7f54c4c91000, 2093056, PROT_NONE) = 0 <0.000029>
61332 0.000063 mmap(0x7f54c4e90000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libdbus-1.so.3.7.6>, 0x43000) = 0x7f54c4e90000 <0.000031>
61332 0.000078 close(3</lib/x86_64-linux-gnu/libdbus-1.so.3.7.6>) = 0 <0.000026>
61332 0.000070 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000065 open("/lib/x86_64-linux-gnu/libutil.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000030>
61332 0.000066 read(3</lib/x86_64-linux-gnu/libutil-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\17\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000068 fstat(3</lib/x86_64-linux-gnu/libutil-2.19.so>, {st_mode=S_IFREG|0644, st_size=10680, ...}) = 0 <0.000029>
61332 0.000070 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c677d000 <0.000026>
61332 0.000065 mmap(NULL, 2105624, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libutil-2.19.so>, 0) = 0x7f54c4a4a000 <0.000031>
61332 0.000070 mprotect(0x7f54c4a4c000, 2093056, PROT_NONE) = 0 <0.000029>
61332 0.000063 mmap(0x7f54c4c4b000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libutil-2.19.so>, 0x1000) = 0x7f54c4c4b000 <0.000031>
61332 0.000077 close(3</lib/x86_64-linux-gnu/libutil-2.19.so>) = 0 <0.000026>
61332 0.000072 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000064 open("/lib/x86_64-linux-gnu/libpcre.so.3", O_RDONLY|O_CLOEXEC) = 3 <0.000030>
61332 0.000065 read(3</lib/x86_64-linux-gnu/libpcre.so.3.13.1>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260\27\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000069 fstat(3</lib/x86_64-linux-gnu/libpcre.so.3.13.1>, {st_mode=S_IFREG|0644, st_size=252032, ...}) = 0 <0.000028>
61332 0.000068 mmap(NULL, 2347200, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libpcre.so.3.13.1>, 0) = 0x7f54c480c000 <0.000031>
61332 0.000070 mprotect(0x7f54c4849000, 2093056, PROT_NONE) = 0 <0.000029>
61332 0.000062 mmap(0x7f54c4a48000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libpcre.so.3.13.1>, 0x3c000) = 0x7f54c4a48000 <0.000032>
61332 0.000079 close(3</lib/x86_64-linux-gnu/libpcre.so.3.13.1>) = 0 <0.000026>
61332 0.000069 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000064 open("/lib/x86_64-linux-gnu/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3 <0.000033>
61332 0.000069 read(3</lib/x86_64-linux-gnu/libdl-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\16\0\0\0\0\0\0"..., 832) = 832 <0.000027>
61332 0.000069 fstat(3</lib/x86_64-linux-gnu/libdl-2.19.so>, {st_mode=S_IFREG|0644, st_size=14664, ...}) = 0 <0.000028>
61332 0.000068 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c677c000 <0.000028>
61332 0.000068 mmap(NULL, 2109744, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libdl-2.19.so>, 0) = 0x7f54c4608000 <0.000031>
61332 0.000069 mprotect(0x7f54c460b000, 2093056, PROT_NONE) = 0 <0.000029>
61332 0.000062 mmap(0x7f54c480a000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/libdl-2.19.so>, 0x2000) = 0x7f54c480a000 <0.000031>
61332 0.000079 close(3</lib/x86_64-linux-gnu/libdl-2.19.so>) = 0 <0.000027>
61332 0.000072 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000064 open("/lib/x86_64-linux-gnu/librt.so.1", O_RDONLY|O_CLOEXEC) = 3 <0.000031>
61332 0.000066 read(3</lib/x86_64-linux-gnu/librt-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0P#\0\0\0\0\0\0"..., 832) = 832 <0.000030>
61332 0.000077 fstat(3</lib/x86_64-linux-gnu/librt-2.19.so>, {st_mode=S_IFREG|0644, st_size=31792, ...}) = 0 <0.000028>
61332 0.000072 mmap(NULL, 2129016, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/librt-2.19.so>, 0) = 0x7f54c4400000 <0.000031>
61332 0.000071 mprotect(0x7f54c4407000, 2093056, PROT_NONE) = 0 <0.000030>
61332 0.000064 mmap(0x7f54c4606000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3</lib/x86_64-linux-gnu/librt-2.19.so>, 0x6000) = 0x7f54c4606000 <0.000030>
61332 0.000078 close(3</lib/x86_64-linux-gnu/librt-2.19.so>) = 0 <0.000029>
61332 0.000085 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c677b000 <0.000028>
61332 0.000079 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c677a000 <0.000027>
61332 0.000067 mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6778000 <0.000027>
61332 0.000069 arch_prctl(ARCH_SET_FS, 0x7f54c67788c0) = 0 <0.000026>
61332 0.000145 mprotect(0x7f54c60d5000, 16384, PROT_READ) = 0 <0.000030>
61332 0.000076 mprotect(0x7f54c62f8000, 4096, PROT_READ) = 0 <0.000029>
61332 0.000068 mprotect(0x7f54c4606000, 4096, PROT_READ) = 0 <0.000029>
61332 0.000068 mprotect(0x7f54c480a000, 4096, PROT_READ) = 0 <0.000029>
61332 0.000070 mprotect(0x7f54c4a48000, 4096, PROT_READ) = 0 <0.000028>
61332 0.000069 mprotect(0x7f54c4c4b000, 4096, PROT_READ) = 0 <0.000030>
61332 0.000074 mprotect(0x7f54c4e90000, 4096, PROT_READ) = 0 <0.000028>
61332 0.000100 mprotect(0x7f54c52b2000, 4096, PROT_READ) = 0 <0.000030>
61332 0.000106 mprotect(0x7f54c509a000, 4096, PROT_READ) = 0 <0.000028>
61332 0.000083 mprotect(0x7f54c54cc000, 8192, PROT_READ) = 0 <0.000028>
61332 0.000088 mprotect(0x7f54c56e0000, 20480, PROT_READ) = 0 <0.000029>
61332 0.000072 mprotect(0x7f54c5905000, 4096, PROT_READ) = 0 <0.000028>
61332 0.000066 mprotect(0x7f54c5b13000, 4096, PROT_READ) = 0 <0.000027>
61332 0.000065 mprotect(0x7f54c5d18000, 4096, PROT_READ) = 0 <0.000027>
61332 0.000156 mprotect(0x7f54c6567000, 8192, PROT_READ) = 0 <0.000028>
61332 0.000074 mprotect(0x7f54c6992000, 4096, PROT_READ) = 0 <0.000030>
61332 0.000066 mprotect(0x7f54c678c000, 4096, PROT_READ) = 0 <0.000028>
61332 0.000062 munmap(0x7f54c6781000, 34793) = 0 <0.000032>
61332 0.000069 set_tid_address(0x7f54c6778b90) = 61332 <0.000026>
61332 0.000061 set_robust_list(0x7f54c6778ba0, 24) = 0 <0.000025>
61332 0.000058 futex(0x7ffff56ec5f0, FUTEX_WAIT_BITSET_PRIVATE|FUTEX_CLOCK_REALTIME, 1, NULL, 7f54c67788c0) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000073 rt_sigaction(SIGRTMIN, {0x7f54c60e69f0, [], SA_RESTORER|SA_SIGINFO, 0x7f54c60f0340}, NULL, 8) = 0 <0.000028>
61332 0.000074 rt_sigaction(SIGRT_1, {0x7f54c60e6a80, [], SA_RESTORER|SA_RESTART|SA_SIGINFO, 0x7f54c60f0340}, NULL, 8) = 0 <0.000026>
61332 0.000064 rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0 <0.000026>
61332 0.000068 getrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0 <0.000026>
61332 0.000106 statfs("/sys/fs/selinux", 0x7ffff56ec5c0) = -1 ENOENT (No such file or directory) <0.000033>
61332 0.000074 statfs("/selinux", 0x7ffff56ec5c0) = -1 ENOENT (No such file or directory) <0.000026>
61332 0.000103 brk(0) = 0x7f54c7d92000 <0.000026>
61332 0.000060 brk(0x7f54c7db3000) = 0x7f54c7db3000 <0.000027>
61332 0.000070 open("/proc/filesystems", O_RDONLY) = 3 <0.000034>
61332 0.000076 fstat(3</proc/filesystems>, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0 <0.000028>
61332 0.000072 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000027>
61332 0.000062 read(3</proc/filesystems>, "nodev\tsysfs\nnodev\trootfs\nnodev\tr"..., 1024) = 313 <0.000040>
61332 0.000092 read(3</proc/filesystems>, "", 1024) = 0 <0.000028>
61332 0.000070 close(3</proc/filesystems>) = 0 <0.000031>
61332 0.000069 munmap(0x7f54c6789000, 4096) = 0 <0.000032>
61332 0.000079 open("/proc/self/cgroup", O_RDONLY|O_CLOEXEC) = 3 <0.000036>
61332 0.000074 fcntl(3</proc/61332/cgroup>, F_GETFL) = 0x8000 (flags O_RDONLY|O_LARGEFILE) <0.000027>
61332 0.000067 fstat(3</proc/61332/cgroup>, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0 <0.000028>
61332 0.000069 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000027>
61332 0.000062 lseek(3</proc/61332/cgroup>, 0, SEEK_CUR) = 0 <0.000027>
61332 0.000066 read(3</proc/61332/cgroup>, "13:name=systemd:/user/1000.user/"..., 1024) = 461 <0.000046>
61332 0.000094 read(3</proc/61332/cgroup>, "", 1024) = 0 <0.000026>
61332 0.000066 close(3</proc/61332/cgroup>) = 0 <0.000028>
61332 0.000065 munmap(0x7f54c6789000, 4096) = 0 <0.000029>
61332 0.000072 clock_getres(CLOCK_MONOTONIC, {0, 1}) = 0 <0.000026>
61332 0.000065 getresuid([0], [0], [0]) = 0 <0.000026>
61332 0.000062 getresgid([0], [0], [0]) = 0 <0.000026>
61332 0.000100 socket(PF_LOCAL, SOCK_STREAM|SOCK_CLOEXEC, 0) = 3 <0.000032>
61332 0.000072 connect(3, {sa_family=AF_LOCAL, sun_path="/sys/fs/cgroup/cgmanager/sock"}, 31) = 0 <0.000041>
61332 0.000080 fcntl(3<socket:[10299398]>, F_GETFL) = 0x2 (flags O_RDWR) <0.000027>
61332 0.000069 fcntl(3<socket:[10299398]>, F_SETFL, O_RDWR|O_NONBLOCK) = 0 <0.000027>
61332 0.000076 geteuid() = 0 <0.000026>
61332 0.000075 getsockname(3, {sa_family=AF_LOCAL, NULL}, [2]) = 0 <0.000027>
61332 0.000131 poll([{fd=3<socket:[10299398]>, events=POLLOUT}], 1, 0) = 1 ([{fd=3, revents=POLLOUT}]) <0.000029>
61332 0.000076 sendto(3, "\0", 1, MSG_NOSIGNAL, NULL, 0) = 1 <0.000033>
61332 0.000074 sendto(3, "AUTH EXTERNAL 30\r\n", 18, MSG_NOSIGNAL, NULL, 0) = 18 <0.000031>
61332 0.000090 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 4294967295) = 1 ([{fd=3, revents=POLLIN}]) <0.000038>
61332 0.000092 read(3<socket:[10299398]>, "OK 813caec187cf23c482e954cd543fc"..., 2048) = 37 <0.000030>
61332 0.000076 poll([{fd=3<socket:[10299398]>, events=POLLOUT}], 1, 4294967295) = 1 ([{fd=3, revents=POLLOUT}]) <0.000028>
61332 0.000071 sendto(3, "NEGOTIATE_UNIX_FD\r\n", 19, MSG_NOSIGNAL, NULL, 0) = 19 <0.000032>
61332 0.000071 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 4294967295) = 1 ([{fd=3, revents=POLLIN}]) <0.000027>
61332 0.000071 read(3<socket:[10299398]>, "AGREE_UNIX_FD\r\n", 2048) = 15 <0.000028>
61332 0.000072 poll([{fd=3<socket:[10299398]>, events=POLLOUT}], 1, 4294967295) = 1 ([{fd=3, revents=POLLOUT}]) <0.000027>
61332 0.000070 sendto(3, "BEGIN\r\n", 7, MSG_NOSIGNAL, NULL, 0) = 7 <0.000031>
61332 0.000069 poll([{fd=3<socket:[10299398]>, events=POLLIN|POLLOUT}], 1, 4294967295) = 1 ([{fd=3, revents=POLLOUT}]) <0.000027>
61332 0.000072 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\0018\0\0\0\1\0\0\0h\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 120}, {" \0\0\0org.linuxcontainers.cgmanage"..., 56}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 176 <0.000032>
61332 0.000077 clock_gettime(CLOCK_MONOTONIC, {11045, 312856437}) = 0 <0.000026>
61332 0.000063 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000027>
61332 0.000072 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\10\0\0\0\1\0\0\0\17\0\0\0\5\1u\0\1\0\0\0\10\1g\0\1v\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 40 <0.000027>
61332 0.000072 recvmsg(3, 0x7ffff56ec1c0, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000067 geteuid() = 0 <0.000025>
61332 0.000082 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1 \0\0\0\2\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\f\0\0\0name=systemd\0\0\0\0\1\0\0\0/\0\0\0\224\357\0\0", 32}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 176 <0.000032>
61332 0.000079 clock_gettime(CLOCK_MONOTONIC, {11045, 313292960}) = 0 <0.000029>
61332 0.000066 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000063>
61332 0.000107 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\2\0\0\0\10\0\0\0\5\1u\0\2\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000027>
61332 0.000069 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000082 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\30\0\0\0\3\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\7\0\0\0hugetlb\0\1\0\0\0/\0\0\0\224\357\0\0", 24}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 168 <0.000033>
61332 0.000074 clock_gettime(CLOCK_MONOTONIC, {11045, 313688901}) = 0 <0.000025>
61332 0.000062 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000071 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\3\0\0\0\10\0\0\0\5\1u\0\3\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000027>
61332 0.000069 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000080 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\34\0\0\0\4\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\10\0\0\0net_prio\0\0\0\0\1\0\0\0/\0\0\0\224\357\0\0", 28}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 172 <0.000031>
61332 0.000072 clock_gettime(CLOCK_MONOTONIC, {11045, 314042608}) = 0 <0.000025>
61332 0.000061 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000072 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\4\0\0\0\10\0\0\0\5\1u\0\4\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000026>
61332 0.000069 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000080 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\34\0\0\0\5\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\n\0\0\0perf_event\0\0\1\0\0\0/\0\0\0\224\357\0\0", 28}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 172 <0.000032>
61332 0.000073 clock_gettime(CLOCK_MONOTONIC, {11045, 314397253}) = 0 <0.000026>
61332 0.000062 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000027>
61332 0.000072 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\5\0\0\0\10\0\0\0\5\1u\0\5\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000027>
61332 0.000068 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000080 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\30\0\0\0\6\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\5\0\0\0blkio\0\0\0\1\0\0\0/\0\0\0\224\357\0\0", 24}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 168 <0.000032>
61332 0.000073 clock_gettime(CLOCK_MONOTONIC, {11045, 314752863}) = 0 <0.000026>
61332 0.000062 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000071 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\6\0\0\0\10\0\0\0\5\1u\0\6\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000027>
61332 0.000069 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000079 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\30\0\0\0\7\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\7\0\0\0net_cls\0\1\0\0\0/\0\0\0\224\357\0\0", 24}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 168 <0.000031>
61332 0.000072 clock_gettime(CLOCK_MONOTONIC, {11045, 315105265}) = 0 <0.000026>
61332 0.000061 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000076 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\7\0\0\0\10\0\0\0\5\1u\0\7\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000026>
61332 0.000069 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000080 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\30\0\0\0\10\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\7\0\0\0freezer\0\1\0\0\0/\0\0\0\224\357\0\0", 24}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 168 <0.000031>
61332 0.000071 clock_gettime(CLOCK_MONOTONIC, {11045, 315463257}) = 0 <0.000027>
61332 0.000065 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000072 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\10\0\0\0\10\0\0\0\5\1u\0\10\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000027>
61332 0.000070 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000082 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\30\0\0\0\t\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\7\0\0\0devices\0\1\0\0\0/\0\0\0\224\357\0\0", 24}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 168 <0.000032>
61332 0.000075 clock_gettime(CLOCK_MONOTONIC, {11045, 315826660}) = 0 <0.000027>
61332 0.000063 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000029>
61332 0.000073 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\t\0\0\0\10\0\0\0\5\1u\0\t\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000027>
61332 0.000072 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000027>
61332 0.000084 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\30\0\0\0\n\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\6\0\0\0memory\0\0\1\0\0\0/\0\0\0\224\357\0\0", 24}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 168 <0.000032>
61332 0.000073 clock_gettime(CLOCK_MONOTONIC, {11045, 316191105}) = 0 <0.000026>
61332 0.000061 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000072 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\n\0\0\0\10\0\0\0\5\1u\0\n\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000026>
61332 0.000068 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000025>
61332 0.000080 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\30\0\0\0\v\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\7\0\0\0cpuacct\0\1\0\0\0/\0\0\0\224\357\0\0", 24}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 168 <0.000031>
61332 0.000074 clock_gettime(CLOCK_MONOTONIC, {11045, 316546206}) = 0 <0.000027>
61332 0.000063 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000073 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\v\0\0\0\10\0\0\0\5\1u\0\v\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000028>
61332 0.000070 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000027>
61332 0.000081 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\24\0\0\0\f\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\3\0\0\0cpu\0\1\0\0\0/\0\0\0\224\357\0\0", 20}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 164 <0.000033>
61332 0.000075 clock_gettime(CLOCK_MONOTONIC, {11045, 316908960}) = 0 <0.000027>
61332 0.000063 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000072 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\f\0\0\0\10\0\0\0\5\1u\0\f\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000030>
61332 0.000077 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000025>
61332 0.000080 sendmsg(3, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\30\0\0\0\r\0\0\0y\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 144}, {"\6\0\0\0cpuset\0\0\1\0\0\0/\0\0\0\224\357\0\0", 24}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 168 <0.000031>
61332 0.000072 clock_gettime(CLOCK_MONOTONIC, {11045, 317271906}) = 0 <0.000025>
61332 0.000060 poll([{fd=3<socket:[10299398]>, events=POLLIN}], 1, 25000) = 1 ([{fd=3, revents=POLLIN}]) <0.000028>
61332 0.000071 recvmsg(3, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\0\0\0\0\r\0\0\0\10\0\0\0\5\1u\0\r\0\0\0", 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 24 <0.000027>
61332 0.000068 recvmsg(3, 0x7ffff56ec280, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000025>
61332 0.000064 close(3<socket:[10299398]>) = 0 <0.000034>
61332 0.000085 stat("/sys/kernel/security/apparmor/features/mount/mask", 0x7ffff56ec5d0) = -1 ENOENT (No such file or directory) <0.000031>
61332 0.000077 getuid() = 0 <0.000024>
61332 0.000057 getgid() = 0 <0.000024>
61332 0.000057 geteuid() = 0 <0.000024>
61332 0.000065 geteuid() = 0 <0.000024>
61332 0.000058 open("/etc/lxc/lxc.conf", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000028>
61332 0.000073 getuid() = 0 <0.000025>
61332 0.000058 open("p3.log", O_WRONLY|O_CREAT|O_APPEND|O_CLOEXEC, 0666) = 3 <0.000050>
61332 0.000086 getuid() = 0 <0.000024>
61332 0.000064 gettimeofday({1413476555, 26000}, NULL) = 0 <0.000025>
61332 0.000066 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.026 I"..., 91) = 91 <0.000038>
61332 0.000079 access("/var/lib/lxc/p3/config", F_OK) = 0 <0.000030>
61332 0.000069 geteuid() = 0 <0.000025>
61332 0.000060 mkdir("/", 0755) = -1 EEXIST (File exists) <0.000027>
61332 0.000063 mkdir("/run/", 0755) = -1 EEXIST (File exists) <0.000026>
61332 0.000061 mkdir("/run/lock/", 0755) = -1 EEXIST (File exists) <0.000028>
61332 0.000064 mkdir("/run/lock/lxc//", 0755) = -1 EEXIST (File exists) <0.000028>
61332 0.000063 mkdir("/run/lock/lxc//var/", 0755) = -1 EEXIST (File exists) <0.000027>
61332 0.000062 mkdir("/run/lock/lxc//var/lib/", 0755) = -1 EEXIST (File exists) <0.000027>
61332 0.000063 mkdir("/run/lock/lxc//var/lib/lxc", 0755) = -1 EEXIST (File exists) <0.000028>
61332 0.000068 stat("/var/lib/lxc/p3/config", {st_mode=S_IFREG|0644, st_size=545, ...}) = 0 <0.000028>
61332 0.000069 open("/run/lock/lxc//var/lib/lxc/p3", O_RDWR|O_CREAT, 0600) = 4 <0.000030>
61332 0.000066 fcntl(4</run/lock/lxc/var/lib/lxc/p3>, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0}) = 0 <0.000029>
61332 0.000086 access("/var/lib/lxc/p3/config", R_OK) = 0 <0.000027>
61332 0.000065 open("/var/lib/lxc/p3/config", O_RDONLY) = 5 <0.000028>
61332 0.000064 fstat(5</var/lib/lxc/p3/config>, {st_mode=S_IFREG|0644, st_size=545, ...}) = 0 <0.000028>
61332 0.000071 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000027>
61332 0.000062 read(5</var/lib/lxc/p3/config>, "# Template used to create this c"..., 4096) = 545 <0.000033>
61332 0.000084 access("/usr/share/lxc/config/ubuntu.common.conf", R_OK) = 0 <0.000028>
61332 0.000064 open("/usr/share/lxc/config/ubuntu.common.conf", O_RDONLY) = 6 <0.000029>
61332 0.000064 fstat(6</usr/share/lxc/config/ubuntu.common.conf>, {st_mode=S_IFREG|0644, st_size=2705, ...}) = 0 <0.000028>
61332 0.000072 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6788000 <0.000028>
61332 0.000063 read(6</usr/share/lxc/config/ubuntu.common.conf>, "# Default pivot location\nlxc.piv"..., 4096) = 2705 <0.000030>
61332 0.000105 read(6</usr/share/lxc/config/ubuntu.common.conf>, "", 4096) = 0 <0.000027>
61332 0.000071 close(6</usr/share/lxc/config/ubuntu.common.conf>) = 0 <0.000028>
61332 0.000067 munmap(0x7f54c6788000, 4096) = 0 <0.000032>
61332 0.000082 open("/dev/urandom", O_RDONLY) = 6 <0.000035>
61332 0.000071 fstat(6</dev/urandom>, {st_mode=S_IFCHR|0666, st_rdev=makedev(1, 9), ...}) = 0 <0.000027>
61332 0.000070 ioctl(6</dev/urandom>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, 0x7ffff56ec190) = -1 EINVAL (Invalid argument) <0.000027>
61332 0.000075 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6788000 <0.000026>
61332 0.000061 read(6</dev/urandom>, "b\206{j\316\n\274\220j\235\374\370=\253,\352\203c\357\365!\335\256:\355\233\200\1P\310\262\365"..., 4096) = 4096 <0.000347>
61332 0.000389 close(6</dev/urandom>) = 0 <0.000028>
61332 0.000065 munmap(0x7f54c6788000, 4096) = 0 <0.000029>
61332 0.000062 read(5</var/lib/lxc/p3/config>, "", 4096) = 0 <0.000027>
61332 0.000066 close(5</var/lib/lxc/p3/config>) = 0 <0.000027>
61332 0.000064 munmap(0x7f54c6789000, 4096) = 0 <0.000028>
61332 0.000061 fcntl(4</run/lock/lxc/var/lib/lxc/p3>, F_SETLK, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0 <0.000028>
61332 0.000068 close(4</run/lock/lxc/var/lib/lxc/p3>) = 0 <0.000027>
61332 0.000066 stat("/var/lib/lxc/p3/partial", 0x7ffff56ec440) = -1 ENOENT (No such file or directory) <0.000026>
61332 0.000064 gettimeofday({1413476555, 29055}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.029 W"..., 99) = 99 <0.000033>
61332 0.000079 stat("/var/lib/lxc/p3/partial", 0x7ffff56ec340) = -1 ENOENT (No such file or directory) <0.000026>
61332 0.000065 openat(AT_FDCWD, "/proc/self/task", O_RDONLY|O_NONBLOCK|O_DIRECTORY|O_CLOEXEC) = 4 <0.000033>
61332 0.000072 getdents(4</proc/61332/task>, /* 3 entries */, 32768) = 80 <0.000031>
61332 0.000075 getdents(4</proc/61332/task>, /* 0 entries */, 32768) = 0 <0.000027>
61332 0.000065 close(4</proc/61332/task>) = 0 <0.000026>
61332 0.000068 openat(AT_FDCWD, "/proc/self/fd", O_RDONLY|O_NONBLOCK|O_DIRECTORY|O_CLOEXEC) = 4 <0.000029>
61332 0.000067 getdents(4</proc/61332/fd>, /* 7 entries */, 32768) = 168 <0.000032>
61332 0.000074 getdents(4</proc/61332/fd>, /* 0 entries */, 32768) = 0 <0.000026>
61332 0.000065 close(4</proc/61332/fd>) = 0 <0.000027>
61332 0.000064 gettimeofday({1413476555, 29812}, NULL) = 0 <0.000026>
61332 0.000066 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.029 I"..., 74) = 74 <0.000032>
61332 0.000077 socket(PF_LOCAL, SOCK_STREAM, 0) = 4 <0.000027>
61332 0.000061 bind(4, {sa_family=AF_LOCAL, sun_path=@"/var/lib/lxc/p3/command"}, 26) = 0 <0.000027>
61332 0.000063 listen(4, 100) = 0 <0.000027>
61332 0.000060 fcntl(4<socket:[10299404]>, F_SETFD, FD_CLOEXEC) = 0 <0.000026>
61332 0.000068 open("/proc/self/status", O_RDONLY) = 5 <0.000032>
61332 0.000068 fstat(5</proc/61332/status>, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0 <0.000027>
61332 0.000068 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000027>
61332 0.000060 read(5</proc/61332/status>, "Name:\tlxc-start\nState:\tR (runnin"..., 1024) = 827 <0.000046>
61332 0.000100 close(5</proc/61332/status>) = 0 <0.000028>
61332 0.000065 munmap(0x7f54c6789000, 4096) = 0 <0.000029>
61332 0.000071 open("/usr/share/lxc/config/common.seccomp", O_RDONLY) = 5 <0.000031>
61332 0.000070 fstat(5</usr/share/lxc/config/common.seccomp>, {st_mode=S_IFREG|0644, st_size=126, ...}) = 0 <0.000027>
61332 0.000068 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000027>
61332 0.000060 read(5</usr/share/lxc/config/common.seccomp>, "2\nblacklist\n[all]\nkexec_load err"..., 4096) = 126 <0.000029>
61332 0.000073 uname({sys="Linux", node="ip-10-63-130-120", ...}) = 0 <0.000026>
61332 0.000069 gettimeofday({1413476555, 30984}, NULL) = 0 <0.000026>
61332 0.000073 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.030 I"..., 74) = 74 <0.000031>
61332 0.000073 gettimeofday({1413476555, 31124}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.031 I"..., 87) = 87 <0.000031>
61332 0.000072 gettimeofday({1413476555, 31258}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.031 I"..., 106) = 106 <0.000030>
61332 0.000077 gettimeofday({1413476555, 31397}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.031 I"..., 102) = 102 <0.000031>
61332 0.000072 gettimeofday({1413476555, 31531}, NULL) = 0 <0.000025>
61332 0.000063 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.031 I"..., 105) = 105 <0.000030>
61332 0.000075 gettimeofday({1413476555, 31669}, NULL) = 0 <0.000025>
61332 0.000063 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.031 I"..., 94) = 94 <0.000030>
61332 0.000071 gettimeofday({1413476555, 31805}, NULL) = 0 <0.000026>
61332 0.000066 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.031 I"..., 113) = 113 <0.000031>
61332 0.000075 gettimeofday({1413476555, 31944}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.031 I"..., 109) = 109 <0.000030>
61332 0.000072 gettimeofday({1413476555, 32078}, NULL) = 0 <0.000024>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.032 I"..., 105) = 105 <0.000030>
61332 0.000073 gettimeofday({1413476555, 32213}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.032 I"..., 88) = 88 <0.000030>
61332 0.000070 gettimeofday({1413476555, 32345}, NULL) = 0 <0.000024>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.032 I"..., 107) = 107 <0.000030>
61332 0.000071 gettimeofday({1413476555, 32477}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.032 I"..., 103) = 103 <0.000029>
61332 0.000071 gettimeofday({1413476555, 32610}, NULL) = 0 <0.000026>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.032 I"..., 105) = 105 <0.000030>
61332 0.000073 gettimeofday({1413476555, 32746}, NULL) = 0 <0.000026>
61332 0.000064 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.032 I"..., 89) = 89 <0.000030>
61332 0.000071 gettimeofday({1413476555, 32880}, NULL) = 0 <0.000025>
61332 0.000063 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.032 I"..., 108) = 108 <0.000030>
61332 0.000071 gettimeofday({1413476555, 33015}, NULL) = 0 <0.000026>
61332 0.000063 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.033 W"..., 104) = 104 <0.000031>
61332 0.000072 gettimeofday({1413476555, 33149}, NULL) = 0 <0.000025>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.033 W"..., 91) = 91 <0.000029>
61332 0.000070 gettimeofday({1413476555, 33280}, NULL) = 0 <0.000026>
61332 0.000063 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.033 I"..., 104) = 104 <0.000029>
61332 0.000070 gettimeofday({1413476555, 33413}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.033 I"..., 108) = 108 <0.000031>
61332 0.000071 gettimeofday({1413476555, 33546}, NULL) = 0 <0.000024>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.033 W"..., 104) = 104 <0.000030>
61332 0.000070 gettimeofday({1413476555, 33676}, NULL) = 0 <0.000025>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.033 W"..., 91) = 91 <0.000029>
61332 0.000071 gettimeofday({1413476555, 33809}, NULL) = 0 <0.000025>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.033 I"..., 90) = 90 <0.000029>
61332 0.000070 gettimeofday({1413476555, 33945}, NULL) = 0 <0.000026>
61332 0.000068 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.033 I"..., 109) = 109 <0.000030>
61332 0.000072 gettimeofday({1413476555, 34080}, NULL) = 0 <0.000024>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.034 I"..., 105) = 105 <0.000030>
61332 0.000069 gettimeofday({1413476555, 34211}, NULL) = 0 <0.000024>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.034 I"..., 105) = 105 <0.000029>
61332 0.000071 read(5</usr/share/lxc/config/common.seccomp>, "", 4096) = 0 <0.000027>
61332 0.000066 gettimeofday({1413476555, 34408}, NULL) = 0 <0.000025>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.034 I"..., 106) = 106 <0.000029>
61332 0.000070 close(5</usr/share/lxc/config/common.seccomp>) = 0 <0.000027>
61332 0.000064 munmap(0x7f54c6789000, 4096) = 0 <0.000028>
61332 0.000065 geteuid() = 0 <0.000025>
61332 0.000059 open("/run/lxc//var/lib/lxc/monitor-fifo", O_WRONLY|O_NONBLOCK) = -1 ENOENT (No such file or directory) <0.000030>
61332 0.000085 open("/dev/ptmx", O_RDWR) = 5 <0.000072>
61332 0.000109 statfs("/dev/pts", {f_type="DEVPTS_SUPER_MAGIC", f_bsize=4096, f_blocks=0, f_bfree=0, f_bavail=0, f_files=0, f_ffree=0, f_fsid={0, 0}, f_namelen=255, f_frsize=4096}) = 0 <0.000028>
61332 0.000075 ioctl(5</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000070 ioctl(5</dev/ptmx>, TIOCGPTN, [86]) = 0 <0.000028>
61332 0.000068 stat("/dev/pts/86", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 86), ...}) = 0 <0.000029>
61332 0.000067 getuid() = 0 <0.000025>
61332 0.000064 socket(PF_LOCAL, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 6 <0.000030>
61332 0.000064 connect(6, {sa_family=AF_LOCAL, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory) <0.000032>
61332 0.000070 close(6<socket:[10299406]>) = 0 <0.000030>
61332 0.000069 socket(PF_LOCAL, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 6 <0.000027>
61332 0.000062 connect(6, {sa_family=AF_LOCAL, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory) <0.000030>
61332 0.000067 close(6<socket:[10299407]>) = 0 <0.000029>
61332 0.000072 open("/etc/nsswitch.conf", O_RDONLY|O_CLOEXEC) = 6 <0.000030>
61332 0.000069 fstat(6</etc/nsswitch.conf>, {st_mode=S_IFREG|0644, st_size=475, ...}) = 0 <0.000027>
61332 0.000070 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000027>
61332 0.000065 read(6</etc/nsswitch.conf>, "# /etc/nsswitch.conf\n#\n# Example"..., 4096) = 475 <0.000048>
61332 0.000094 read(6</etc/nsswitch.conf>, "", 4096) = 0 <0.000026>
61332 0.000065 close(6</etc/nsswitch.conf>) = 0 <0.000027>
61332 0.000064 munmap(0x7f54c6789000, 4096) = 0 <0.000029>
61332 0.000071 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 6 <0.000029>
61332 0.000064 fstat(6</etc/ld.so.cache>, {st_mode=S_IFREG|0644, st_size=34793, ...}) = 0 <0.000027>
61332 0.000068 mmap(NULL, 34793, PROT_READ, MAP_PRIVATE, 6</etc/ld.so.cache>, 0) = 0x7f54c6781000 <0.000028>
61332 0.000066 close(6</etc/ld.so.cache>) = 0 <0.000025>
61332 0.000066 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000027>
61332 0.000066 open("/lib/x86_64-linux-gnu/libnss_compat.so.2", O_RDONLY|O_CLOEXEC) = 6 <0.000030>
61332 0.000064 read(6</lib/x86_64-linux-gnu/libnss_compat-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260\23\0\0\0\0\0\0"..., 832) = 832 <0.000028>
61332 0.000069 fstat(6</lib/x86_64-linux-gnu/libnss_compat-2.19.so>, {st_mode=S_IFREG|0644, st_size=39824, ...}) = 0 <0.000027>
61332 0.000073 mmap(NULL, 2135368, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6</lib/x86_64-linux-gnu/libnss_compat-2.19.so>, 0) = 0x7f54c41f6000 <0.000031>
61332 0.000071 mprotect(0x7f54c41ff000, 2093056, PROT_NONE) = 0 <0.000031>
61332 0.000070 mmap(0x7f54c43fe000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6</lib/x86_64-linux-gnu/libnss_compat-2.19.so>, 0x8000) = 0x7f54c43fe000 <0.000031>
61332 0.000082 close(6</lib/x86_64-linux-gnu/libnss_compat-2.19.so>) = 0 <0.000029>
61332 0.000071 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000026>
61332 0.000064 open("/lib/x86_64-linux-gnu/libnsl.so.1", O_RDONLY|O_CLOEXEC) = 6 <0.000030>
61332 0.000064 read(6</lib/x86_64-linux-gnu/libnsl-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`A\0\0\0\0\0\0"..., 832) = 832 <0.000027>
61332 0.000070 fstat(6</lib/x86_64-linux-gnu/libnsl-2.19.so>, {st_mode=S_IFREG|0644, st_size=97296, ...}) = 0 <0.000027>
61332 0.000069 mmap(NULL, 2202328, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6</lib/x86_64-linux-gnu/libnsl-2.19.so>, 0) = 0x7f54c3fdc000 <0.000030>
61332 0.000069 mprotect(0x7f54c3ff3000, 2093056, PROT_NONE) = 0 <0.000030>
61332 0.000064 mmap(0x7f54c41f2000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6</lib/x86_64-linux-gnu/libnsl-2.19.so>, 0x16000) = 0x7f54c41f2000 <0.000032>
61332 0.000075 mmap(0x7f54c41f4000, 6872, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f54c41f4000 <0.000029>
61332 0.000067 close(6</lib/x86_64-linux-gnu/libnsl-2.19.so>) = 0 <0.000026>
61332 0.000081 mprotect(0x7f54c41f2000, 4096, PROT_READ) = 0 <0.000029>
61332 0.000067 mprotect(0x7f54c43fe000, 4096, PROT_READ) = 0 <0.000027>
61332 0.000063 munmap(0x7f54c6781000, 34793) = 0 <0.000029>
61332 0.000073 open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 6 <0.000029>
61332 0.000064 fstat(6</etc/ld.so.cache>, {st_mode=S_IFREG|0644, st_size=34793, ...}) = 0 <0.000027>
61332 0.000068 mmap(NULL, 34793, PROT_READ, MAP_PRIVATE, 6</etc/ld.so.cache>, 0) = 0x7f54c6781000 <0.000029>
61332 0.000069 close(6</etc/ld.so.cache>) = 0 <0.000026>
61332 0.000065 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000026>
61332 0.000066 open("/lib/x86_64-linux-gnu/libnss_nis.so.2", O_RDONLY|O_CLOEXEC) = 6 <0.000029>
61332 0.000064 read(6</lib/x86_64-linux-gnu/libnss_nis-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240!\0\0\0\0\0\0"..., 832) = 832 <0.000027>
61332 0.000068 fstat(6</lib/x86_64-linux-gnu/libnss_nis-2.19.so>, {st_mode=S_IFREG|0644, st_size=47760, ...}) = 0 <0.000027>
61332 0.000072 mmap(NULL, 2143784, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6</lib/x86_64-linux-gnu/libnss_nis-2.19.so>, 0) = 0x7f54c3dd0000 <0.000030>
61332 0.000069 mprotect(0x7f54c3ddb000, 2093056, PROT_NONE) = 0 <0.000031>
61332 0.000064 mmap(0x7f54c3fda000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6</lib/x86_64-linux-gnu/libnss_nis-2.19.so>, 0xa000) = 0x7f54c3fda000 <0.000031>
61332 0.000077 close(6</lib/x86_64-linux-gnu/libnss_nis-2.19.so>) = 0 <0.000026>
61332 0.000070 access("/etc/ld.so.nohwcap", F_OK) = -1 ENOENT (No such file or directory) <0.000028>
61332 0.000064 open("/lib/x86_64-linux-gnu/libnss_files.so.2", O_RDONLY|O_CLOEXEC) = 6 <0.000030>
61332 0.000064 read(6</lib/x86_64-linux-gnu/libnss_files-2.19.so>, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\240\"\0\0\0\0\0\0"..., 832) = 832 <0.000027>
61332 0.000068 fstat(6</lib/x86_64-linux-gnu/libnss_files-2.19.so>, {st_mode=S_IFREG|0644, st_size=47712, ...}) = 0 <0.000027>
61332 0.000069 mmap(NULL, 2144392, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 6</lib/x86_64-linux-gnu/libnss_files-2.19.so>, 0) = 0x7f54c3bc4000 <0.000030>
61332 0.000069 mprotect(0x7f54c3bcf000, 2093056, PROT_NONE) = 0 <0.000030>
61332 0.000065 mmap(0x7f54c3dce000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 6</lib/x86_64-linux-gnu/libnss_files-2.19.so>, 0xa000) = 0x7f54c3dce000 <0.000031>
61332 0.000078 close(6</lib/x86_64-linux-gnu/libnss_files-2.19.so>) = 0 <0.000026>
61332 0.000078 mprotect(0x7f54c3dce000, 4096, PROT_READ) = 0 <0.000029>
61332 0.000072 mprotect(0x7f54c3fda000, 4096, PROT_READ) = 0 <0.000029>
61332 0.000067 munmap(0x7f54c6781000, 34793) = 0 <0.000029>
61332 0.000069 open("/etc/group", O_RDONLY|O_CLOEXEC) = 6 <0.000030>
61332 0.000068 lseek(6</etc/group>, 0, SEEK_CUR) = 0 <0.000027>
61332 0.000068 fstat(6</etc/group>, {st_mode=S_IFREG|0644, st_size=832, ...}) = 0 <0.000027>
61332 0.000069 mmap(NULL, 832, PROT_READ, MAP_SHARED, 6</etc/group>, 0) = 0x7f54c6789000 <0.000028>
61332 0.000067 lseek(6</etc/group>, 832, SEEK_SET) = 832 <0.000027>
61332 0.000074 munmap(0x7f54c6789000, 832) = 0 <0.000028>
61332 0.000063 close(6</etc/group>) = 0 <0.000027>
61332 0.000071 ioctl(5</dev/ptmx>, TIOCSPTLCK, [0]) = 0 <0.000026>
61332 0.000067 ioctl(5</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000067 ioctl(5</dev/ptmx>, TIOCGPTN, [86]) = 0 <0.000027>
61332 0.000066 stat("/dev/pts/86", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 86), ...}) = 0 <0.000028>
61332 0.000069 open("/dev/pts/86", O_RDWR|O_NOCTTY) = 6 <0.000032>
61332 0.000075 gettimeofday({1413476555, 40227}, NULL) = 0 <0.000025>
61332 0.000065 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.040 D"..., 85) = 85 <0.000033>
61332 0.000073 fcntl(5</dev/ptmx>, F_SETFD, FD_CLOEXEC) = 0 <0.000027>
61332 0.000065 fcntl(6</dev/pts/86>, F_SETFD, FD_CLOEXEC) = 0 <0.000025>
61332 0.000063 open("/dev/ptmx", O_RDWR) = 7 <0.000051>
61332 0.000087 ioctl(7</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000069 ioctl(7</dev/ptmx>, TIOCGPTN, [87]) = 0 <0.000027>
61332 0.000067 stat("/dev/pts/87", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 87), ...}) = 0 <0.000027>
61332 0.000063 getuid() = 0 <0.000024>
61332 0.000058 ioctl(7</dev/ptmx>, TIOCSPTLCK, [0]) = 0 <0.000026>
61332 0.000065 ioctl(7</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000067 ioctl(7</dev/ptmx>, TIOCGPTN, [87]) = 0 <0.000027>
61332 0.000065 stat("/dev/pts/87", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 87), ...}) = 0 <0.000027>
61332 0.000064 open("/dev/pts/87", O_RDWR|O_NOCTTY) = 8 <0.000029>
61332 0.000068 gettimeofday({1413476555, 41165}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.041 D"..., 85) = 85 <0.000031>
61332 0.000072 fcntl(7</dev/ptmx>, F_SETFD, FD_CLOEXEC) = 0 <0.000026>
61332 0.000063 fcntl(8</dev/pts/87>, F_SETFD, FD_CLOEXEC) = 0 <0.000027>
61332 0.000069 open("/dev/ptmx", O_RDWR) = 9 <0.000051>
61332 0.000086 ioctl(9</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000070 ioctl(9</dev/ptmx>, TIOCGPTN, [88]) = 0 <0.000027>
61332 0.000065 stat("/dev/pts/88", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 88), ...}) = 0 <0.000027>
61332 0.000064 getuid() = 0 <0.000024>
61332 0.000058 ioctl(9</dev/ptmx>, TIOCSPTLCK, [0]) = 0 <0.000026>
61332 0.000065 ioctl(9</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000066 ioctl(9</dev/ptmx>, TIOCGPTN, [88]) = 0 <0.000027>
61332 0.000065 stat("/dev/pts/88", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 88), ...}) = 0 <0.000027>
61332 0.000064 open("/dev/pts/88", O_RDWR|O_NOCTTY) = 10 <0.000029>
61332 0.000067 gettimeofday({1413476555, 42102}, NULL) = 0 <0.000024>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.042 D"..., 86) = 86 <0.000030>
61332 0.000072 fcntl(9</dev/ptmx>, F_SETFD, FD_CLOEXEC) = 0 <0.000026>
61332 0.000064 fcntl(10</dev/pts/88>, F_SETFD, FD_CLOEXEC) = 0 <0.000026>
61332 0.000073 open("/dev/ptmx", O_RDWR) = 11 <0.000051>
61332 0.000087 ioctl(11</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000028>
61332 0.000071 ioctl(11</dev/ptmx>, TIOCGPTN, [89]) = 0 <0.000026>
61332 0.000065 stat("/dev/pts/89", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 89), ...}) = 0 <0.000027>
61332 0.000064 getuid() = 0 <0.000024>
61332 0.000057 ioctl(11</dev/ptmx>, TIOCSPTLCK, [0]) = 0 <0.000026>
61332 0.000066 ioctl(11</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000067 ioctl(11</dev/ptmx>, TIOCGPTN, [89]) = 0 <0.000026>
61332 0.000065 stat("/dev/pts/89", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 89), ...}) = 0 <0.000027>
61332 0.000064 open("/dev/pts/89", O_RDWR|O_NOCTTY) = 12 <0.000029>
61332 0.000063 gettimeofday({1413476555, 43042}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.043 D"..., 87) = 87 <0.000030>
61332 0.000071 fcntl(11</dev/ptmx>, F_SETFD, FD_CLOEXEC) = 0 <0.000027>
61332 0.000063 fcntl(12</dev/pts/89>, F_SETFD, FD_CLOEXEC) = 0 <0.000026>
61332 0.000068 gettimeofday({1413476555, 43306}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.043 I"..., 68) = 68 <0.000030>
61332 0.000073 rt_sigprocmask(SIG_BLOCK, ~[ILL BUS SEGV WINCH RTMIN RT_1], [], 8) = 0 <0.000026>
61332 0.000067 signalfd4(-1, ~[ILL BUS SEGV WINCH RTMIN RT_1], 8, 0) = 13 <0.000028>
61332 0.000066 fcntl(13<anon_inode:[signalfd]>, F_SETFD, FD_CLOEXEC) = 0 <0.000027>
61332 0.000070 gettimeofday({1413476555, 43644}, NULL) = 0 <0.000026>
61332 0.000063 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.043 D"..., 73) = 73 <0.000030>
61332 0.000073 open("/dev/ptmx", O_RDWR) = 14 <0.000049>
61332 0.000092 ioctl(14</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000026>
61332 0.000069 ioctl(14</dev/ptmx>, TIOCGPTN, [90]) = 0 <0.000026>
61332 0.000066 stat("/dev/pts/90", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 90), ...}) = 0 <0.000028>
61332 0.000064 getuid() = 0 <0.000025>
61332 0.000057 ioctl(14</dev/ptmx>, TIOCSPTLCK, [0]) = 0 <0.000026>
61332 0.000065 ioctl(14</dev/ptmx>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000026>
61332 0.000066 ioctl(14</dev/ptmx>, TIOCGPTN, [90]) = 0 <0.000028>
61332 0.000066 stat("/dev/pts/90", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 90), ...}) = 0 <0.000027>
61332 0.000064 open("/dev/pts/90", O_RDWR|O_NOCTTY) = 15 <0.000029>
61332 0.000065 fcntl(14</dev/ptmx>, F_SETFD, FD_CLOEXEC) = 0 <0.000026>
61332 0.000063 fcntl(15</dev/pts/90>, F_SETFD, FD_CLOEXEC) = 0 <0.000027>
61332 0.000068 access("/dev/tty", F_OK) = 0 <0.000028>
61332 0.000063 open("/dev/tty", O_RDWR) = 16 <0.000028>
61332 0.000063 close(16</dev/tty>) = 0 <0.000029>
61332 0.000070 gettimeofday({1413476555, 44780}, NULL) = 0 <0.000025>
61332 0.000062 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.044 D"..., 88) = 88 <0.000032>
61332 0.000071 getuid() = 0 <0.000025>
61332 0.000057 open("/dev/tty", O_RDWR|O_CREAT|O_APPEND|O_CLOEXEC, 0600) = 16 <0.000030>
61332 0.000065 getuid() = 0 <0.000025>
61332 0.000058 gettimeofday({1413476555, 45095}, NULL) = 0 <0.000028>
61332 0.000064 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.045 D"..., 82) = 82 <0.000030>
61332 0.000071 ioctl(16</dev/tty>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000026>
61332 0.000067 rt_sigprocmask(SIG_BLOCK, [WINCH], ~[ILL BUS KILL SEGV STOP WINCH RTMIN RT_1], 8) = 0 <0.000025>
61332 0.000063 signalfd4(-1, [WINCH], 8, 0) = 17 <0.000027>
61332 0.000068 gettimeofday({1413476555, 45427}, NULL) = 0 <0.000024>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.045 D"..., 79) = 79 <0.000030>
61332 0.000071 ioctl(16</dev/tty>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000067 ioctl(16</dev/tty>, TIOCGWINSZ, {ws_row=66, ws_col=266, ws_xpixel=0, ws_ypixel=0}) = 0 <0.000027>
61332 0.000066 gettimeofday({1413476555, 45692}, NULL) = 0 <0.000024>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.045 D"..., 90) = 90 <0.000029>
61332 0.000069 ioctl(14</dev/ptmx>, SNDRV_TIMER_IOCTL_STATUS or TIOCSWINSZ, {ws_row=66, ws_col=266, ws_xpixel=0, ws_ypixel=0}) = 0 <0.000026>
61332 0.000067 ioctl(16</dev/tty>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000027>
61332 0.000066 ioctl(16</dev/tty>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000026>
61332 0.000066 ioctl(16</dev/tty>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost isig icanon echo ...}) = 0 <0.000026>
61332 0.000065 ioctl(16</dev/tty>, SNDCTL_TMR_CONTINUE or SNDRV_TIMER_IOCTL_GPARAMS or TCSETSF, {B38400 opost -isig -icanon -echo ...}) = 0 <0.000028>
61332 0.000069 ioctl(16</dev/tty>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, {B38400 opost -isig -icanon -echo ...}) = 0 <0.000026>
61332 0.000066 gettimeofday({1413476555, 46221}, NULL) = 0 <0.000024>
61332 0.000061 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.046 I"..., 72) = 72 <0.000029>
61332 0.000070 open("/proc/sys/kernel/ctrl-alt-del", O_RDONLY) = 18 <0.000032>
61332 0.000070 fstat(18</proc/sys/kernel/ctrl-alt-del>, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0 <0.000028>
61332 0.000072 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000026>
61332 0.000061 read(18</proc/sys/kernel/ctrl-alt-del>, "0\n", 1024) = 2 <0.000031>
61332 0.000073 close(18</proc/sys/kernel/ctrl-alt-del>) = 0 <0.000028>
61332 0.000065 munmap(0x7f54c6789000, 4096) = 0 <0.000029>
61332 0.000063 clone( <unfinished ...>
61333 0.000246 getpid( <unfinished ...>
61332 0.000016 <... clone resumed> child_stack=0x7ffff56ec2d0, flags=CLONE_NEWPID|SIGCHLD) = 61333 <0.000258>
61333 0.000015 <... getpid resumed> ) = 1 <0.000024>
61333 0.000036 reboot(LINUX_REBOOT_MAGIC1, LINUX_REBOOT_MAGIC2, LINUX_REBOOT_CMD_CAD_OFF <unfinished ...>
61332 0.000015 wait4(-1, <unfinished ...>
61333 0.000013 <... reboot resumed> ) = -1 EINVAL (Invalid argument) <0.000019>
61333 0.000041 exit_group(1) = ?
61333 0.012790 +++ exited with 1 +++
61332 0.000036 <... wait4 resumed> [{WIFEXITED(s) && WEXITSTATUS(s) == 1}], 0, NULL) = 61333 <0.012876>
61332 0.000042 gettimeofday({1413476555, 60006}, NULL) = 0 <0.000027>
61332 0.000074 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.060 D"..., 95) = 95 <0.000042>
61332 0.000097 geteuid() = 0 <0.000027>
61332 0.000064 socketpair(PF_LOCAL, SOCK_STREAM, 0, [18, 19]) = 0 <0.000037>
61332 0.000077 fcntl(18<socket:[9959289]>, F_SETFD, FD_CLOEXEC) = 0 <0.000029>
61332 0.000073 getuid() = 0 <0.000027>
61332 0.000069 socket(PF_NETLINK, SOCK_RAW, 0) = 20 <0.000031>
61332 0.000067 bind(20, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0 <0.000028>
61332 0.000066 getsockname(20, {sa_family=AF_NETLINK, pid=61332, groups=00000000}, [12]) = 0 <0.000028>
61332 0.000068 sendto(20, "\24\0\0\0\22\0\1\3\313\360?T\0\0\0\0\0\0\0\0", 20, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 20 <0.000259>
61332 0.000298 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"d\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\4\3\1\0\0\0I\0\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3400 <0.000249>
61332 0.000306 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\220\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\4\0\0\0\3\20\0\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3484 <0.000260>
61332 0.000306 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\224\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\201\0\0\0C\20\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3516 <0.000251>
61332 0.000295 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\224\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\211\0\0\0C\20\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3516 <0.000250>
61332 0.000296 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\224\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\223\0\0\0C\20\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3492 <0.000252>
61332 0.000296 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\224\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\227\0\0\0\3\20\0\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3492 <0.000029>
61332 0.000070 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\24\0\0\0\3\0\2\0\313\360?T\224\357\0\0\0\0\0\0", 4096}], msg_controllen=0, msg_flags=0}, 0) = 20 <0.000028>
61332 0.000069 sendto(20, "\24\0\0\0\26\0\1\3\314\360?T\0\0\0\0\0\0\0\0", 20, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 20 <0.000034>
61332 0.000072 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"L\0\0\0\24\0\2\0\314\360?T\224\357\0\0\2\10\200\376\1\0\0\0\10\0\1\0\177\0\0\1"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 340 <0.000032>
61332 0.000075 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\24\0\0\0\3\0\2\0\314\360?T\224\357\0\0\0\0\0\0", 4096}], msg_controllen=0, msg_flags=0}, 0) = 20 <0.000029>
61332 0.000083 close(20<socket:[9959291]>) = 0 <0.000036>
61332 0.000085 open("/dev/urandom", O_RDONLY) = 20 <0.000033>
61332 0.000073 fstat(20</dev/urandom>, {st_mode=S_IFCHR|0666, st_rdev=makedev(1, 9), ...}) = 0 <0.000028>
61332 0.000073 ioctl(20</dev/urandom>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, 0x7ffff56eafa0) = -1 EINVAL (Invalid argument) <0.000027>
61332 0.000072 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000030>
61332 0.000068 read(20</dev/urandom>, "\270D\337\17v7\273\345\v4\361\207\335\231\34h\243 \27W~U\210\233\3641;\250yV\224\210"..., 4096) = 4096 <0.000357>
61332 0.000402 close(20</dev/urandom>) = 0 <0.000030>
61332 0.000069 munmap(0x7f54c6789000, 4096) = 0 <0.000051>
61332 0.000092 socket(PF_NETLINK, SOCK_RAW, 0) = 20 <0.000030>
61332 0.000068 bind(20, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0 <0.000032>
61332 0.000071 getsockname(20, {sa_family=AF_NETLINK, pid=61332, groups=00000000}, [12]) = 0 <0.000028>
61332 0.000065 sendto(20, "\24\0\0\0\22\0\1\3\313\360?T\0\0\0\0\0\0\0\0", 20, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 20 <0.000250>
61332 0.000289 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"d\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\4\3\1\0\0\0I\0\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3400 <0.000244>
61332 0.000287 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\220\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\4\0\0\0\3\20\0\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3484 <0.000250>
61332 0.000291 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\224\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\201\0\0\0C\20\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3516 <0.000246>
61332 0.000294 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\224\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\211\0\0\0C\20\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3516 <0.000246>
61332 0.000289 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\224\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\223\0\0\0C\20\1\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3492 <0.000250>
61332 0.000291 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\224\4\0\0\20\0\2\0\313\360?T\224\357\0\0\0\0\1\0\227\0\0\0\3\20\0\0\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 3492 <0.000029>
61332 0.000070 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\24\0\0\0\3\0\2\0\313\360?T\224\357\0\0\0\0\0\0", 4096}], msg_controllen=0, msg_flags=0}, 0) = 20 <0.000028>
61332 0.000067 sendto(20, "\24\0\0\0\26\0\1\3\314\360?T\0\0\0\0\0\0\0\0", 20, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 20 <0.000033>
61332 0.000072 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"L\0\0\0\24\0\2\0\314\360?T\224\357\0\0\2\10\200\376\1\0\0\0\10\0\1\0\177\0\0\1"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 340 <0.000032>
61332 0.000071 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\24\0\0\0\3\0\2\0\314\360?T\224\357\0\0\0\0\0\0", 4096}], msg_controllen=0, msg_flags=0}, 0) = 20 <0.000028>
61332 0.000073 close(20<socket:[9959292]>) = 0 <0.000031>
61332 0.000073 open("/dev/urandom", O_RDONLY) = 20 <0.000031>
61332 0.000070 fstat(20</dev/urandom>, {st_mode=S_IFCHR|0666, st_rdev=makedev(1, 9), ...}) = 0 <0.000029>
61332 0.000072 ioctl(20</dev/urandom>, SNDCTL_TMR_TIMEBASE or SNDRV_TIMER_IOCTL_NEXT_DEVICE or TCGETS, 0x7ffff56eafa0) = -1 EINVAL (Invalid argument) <0.000027>
61332 0.000068 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f54c6789000 <0.000029>
61332 0.000066 read(20</dev/urandom>, "t\247S\304\344\315\260}\301\331)\343\242\24\327\213d\372\336\311,\"\306\10\22\4\316\276o\244m\333"..., 4096) = 4096 <0.000352>
61332 0.000394 close(20</dev/urandom>) = 0 <0.000030>
61332 0.000068 munmap(0x7f54c6789000, 4096) = 0 <0.000031>
61332 0.000069 socket(PF_NETLINK, SOCK_RAW, 0) = 20 <0.000030>
61332 0.000065 setsockopt(20, SOL_SOCKET, SO_SNDBUF, [32768], 4) = 0 <0.000027>
61332 0.000066 setsockopt(20, SOL_SOCKET, SO_RCVBUF, [32768], 4) = 0 <0.000027>
61332 0.000064 bind(20, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0 <0.000027>
61332 0.000064 getsockname(20, {sa_family=AF_NETLINK, pid=61332, groups=00000000}, [12]) = 0 <0.000027>
61332 0.000068 sendmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"h\0\0\0\20\0\5\6\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 104}], msg_controllen=0, msg_flags=0}, 0) = 104 <0.000674>
61332 0.000734 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"$\0\0\0\2\0\0\0\0\0\0\0\224\357\0\0\0\0\0\0h\0\0\0\20\0\5\6\0\0\0\0"..., 8192}], msg_controllen=0, msg_flags=0}, 0) = 36 <0.000032>
61332 0.000082 close(20<socket:[9959293]>) = 0 <0.000032>
61332 0.000080 socket(PF_INET, SOCK_DGRAM, IPPROTO_IP) = 20 <0.000031>
61332 0.000071 ioctl(20<socket:[9959294]>, SIOCGIFHWADDR, {ifr_name="vethXTAQ6L", ifr_hwaddr=ca:a0:d4:c4:db:4e}) = 0 <0.000032>
61332 0.000083 ioctl(20<socket:[9959294]>, SIOCSIFHWADDR, {ifr_name="vethXTAQ6L", ifr_hwaddr=fe:a0:d4:c4:db:4e}) = 0 <0.000125>
61332 0.000184 close(20<socket:[9959294]>) = 0 <0.000039>
61332 0.000109 access("/proc/net", R_OK) = 0 <0.000062>
61332 0.000130 access("/proc/net/unix", R_OK) = 0 <0.000062>
61332 0.000126 socket(PF_LOCAL, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 20 <0.000046>
61332 0.000103 ioctl(20<socket:[9959296]>, SIOCGIFINDEX, {ifr_name="vethXTAQ6L", ifr_index=155}) = 0 <0.000047>
61332 0.000125 close(20<socket:[9959296]>) = 0 <0.000050>
61332 0.000119 socket(PF_INET, SOCK_STREAM, IPPROTO_IP) = 20 <0.000047>
61332 0.000098 ioctl(20<socket:[9959297]>, SIOCBRADDIF, 0x7ffff56eb150) = 0 <0.000240>
61332 0.000281 close(20<socket:[9959297]>) = 0 <0.000029>
61332 0.000066 socket(PF_LOCAL, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 20 <0.000025>
61332 0.000057 ioctl(20<socket:[9959298]>, SIOCGIFINDEX, {ifr_name="vethETFVG8", ifr_index=154}) = 0 <0.000024>
61332 0.000066 close(20<socket:[9959298]>) = 0 <0.000030>
61332 0.000076 socket(PF_NETLINK, SOCK_RAW, 0) = 20 <0.000038>
61332 0.000092 setsockopt(20, SOL_SOCKET, SO_SNDBUF, [32768], 4) = 0 <0.000035>
61332 0.000075 setsockopt(20, SOL_SOCKET, SO_RCVBUF, [32768], 4) = 0 <0.000024>
61332 0.000059 bind(20, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0 <0.000027>
61332 0.000063 getsockname(20, {sa_family=AF_NETLINK, pid=61332, groups=00000000}, [12]) = 0 <0.000024>
61332 0.000063 socket(PF_LOCAL, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 21 <0.000026>
61332 0.000059 ioctl(21<socket:[9959300]>, SIOCGIFINDEX, {ifr_name="vethXTAQ6L", ifr_index=155}) = 0 <0.000026>
61332 0.000071 close(21<socket:[9959300]>) = 0 <0.000040>
61332 0.000079 sendmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{" \0\0\0\20\0\5\0\0\0\0\0\0\0\0\0\0\0\0\0\233\0\0\0\1\0\0\0\1\0\0\0", 32}], msg_controllen=0, msg_flags=0}, 0) = 32 <0.000127>
61332 0.000177 recvmsg(20, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"$\0\0\0\2\0\0\0\0\0\0\0\224\357\0\0\0\0\0\0 \0\0\0\20\0\5\0\0\0\0\0"..., 8192}], msg_controllen=0, msg_flags=0}, 0) = 36 <0.000029>
61332 0.000068 close(20<socket:[9959299]>) = 0 <0.000045>
61332 0.000095 gettimeofday({1413476555, 70756}, NULL) = 0 <0.000026>
61332 0.000072 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.070 D"..., 109) = 109 <0.000046>
61332 0.000099 gettimeofday({1413476555, 70928}, NULL) = 0 <0.000032>
61332 0.000084 write(3</home/ubuntu/p3.log>, " lxc-start 1413476555.070 I"..., 92) = 92 <0.000040>
61332 0.000110 socket(PF_LOCAL, SOCK_STREAM|SOCK_CLOEXEC, 0) = 20 <0.000036>
61332 0.000076 connect(20, {sa_family=AF_LOCAL, sun_path="/sys/fs/cgroup/cgmanager/sock"}, 31) = 0 <0.000048>
61332 0.000095 fcntl(20<socket:[10143024]>, F_GETFL) = 0x2 (flags O_RDWR) <0.000028>
61332 0.000104 fcntl(20<socket:[10143024]>, F_SETFL, O_RDWR|O_NONBLOCK) = 0 <0.000044>
61332 0.000116 geteuid() = 0 <0.000044>
61332 0.000107 getsockname(20, {sa_family=AF_LOCAL, NULL}, [2]) = 0 <0.000043>
61332 0.000157 poll([{fd=20<socket:[10143024]>, events=POLLOUT}], 1, 0) = 1 ([{fd=20, revents=POLLOUT}]) <0.000047>
61332 0.000123 sendto(20, "\0", 1, MSG_NOSIGNAL, NULL, 0) = 1 <0.000056>
61332 0.000100 sendto(20, "AUTH EXTERNAL 30\r\n", 18, MSG_NOSIGNAL, NULL, 0) = 18 <0.000031>
61332 0.000083 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 4294967295) = 1 ([{fd=20, revents=POLLIN}]) <0.000026>
61332 0.000081 read(20<socket:[10143024]>, "OK 813caec187cf23c482e954cd543fc"..., 2048) = 37 <0.000024>
61332 0.000088 poll([{fd=20<socket:[10143024]>, events=POLLOUT}], 1, 4294967295) = 1 ([{fd=20, revents=POLLOUT}]) <0.000033>
61332 0.000092 sendto(20, "NEGOTIATE_UNIX_FD\r\n", 19, MSG_NOSIGNAL, NULL, 0) = 19 <0.000031>
61332 0.000071 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 4294967295) = 1 ([{fd=20, revents=POLLIN}]) <0.000027>
61332 0.000073 read(20<socket:[10143024]>, "AGREE_UNIX_FD\r\n", 2048) = 15 <0.000026>
61332 0.000070 poll([{fd=20<socket:[10143024]>, events=POLLOUT}], 1, 4294967295) = 1 ([{fd=20, revents=POLLOUT}]) <0.000030>
61332 0.000077 sendto(20, "BEGIN\r\n", 7, MSG_NOSIGNAL, NULL, 0) = 7 <0.000034>
61332 0.000071 poll([{fd=20<socket:[10143024]>, events=POLLIN|POLLOUT}], 1, 4294967295) = 1 ([{fd=20, revents=POLLOUT}]) <0.000038>
61332 0.000090 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\0018\0\0\0\1\0\0\0h\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 120}, {" \0\0\0org.linuxcontainers.cgmanage"..., 56}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 176 <0.000041>
61332 0.000096 clock_gettime(CLOCK_MONOTONIC, {11045, 365107612}) = 0 <0.000028>
61332 0.000071 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000073>
61332 0.000128 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\10\0\0\0\1\0\0\0\17\0\0\0\5\1u\0\1\0\0\0\10\1g\0\1v\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 40 <0.000035>
61332 0.000083 recvmsg(20, 0x7ffff56eade0, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000024>
61332 0.000064 geteuid() = 0 <0.000024>
61332 0.000054 geteuid() = 0 <0.000032>
61332 0.000072 open("/etc/lxc/lxc.conf", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory) <0.000030>
61332 0.000098 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\37\0\0\0\2\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\f\0\0\0name=systemd\0\0\0\0\6\0\0\0lxc/p3\0", 31}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 159 <0.000032>
61332 0.000074 clock_gettime(CLOCK_MONOTONIC, {11045, 365749451}) = 0 <0.000026>
61332 0.000064 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000052>
61332 0.000096 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\2\0\0\0\17\0\0\0\5\1u\0\2\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000027>
61332 0.000072 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000080 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\27\0\0\0\3\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\7\0\0\0hugetlb\0\6\0\0\0lxc/p3\0", 23}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 151 <0.000032>
61332 0.000073 clock_gettime(CLOCK_MONOTONIC, {11045, 366134776}) = 0 <0.000025>
61332 0.000069 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000032>
61332 0.000078 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\3\0\0\0\17\0\0\0\5\1u\0\3\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000027>
61332 0.000071 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000025>
61332 0.000079 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\33\0\0\0\4\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\10\0\0\0net_prio\0\0\0\0\6\0\0\0lxc/p3\0", 27}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 155 <0.000032>
61332 0.000074 clock_gettime(CLOCK_MONOTONIC, {11045, 366505893}) = 0 <0.000027>
61332 0.000063 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000030>
61332 0.000074 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\4\0\0\0\17\0\0\0\5\1u\0\4\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000028>
61332 0.000073 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000077 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\33\0\0\0\5\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\n\0\0\0perf_event\0\0\6\0\0\0lxc/p3\0", 27}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 155 <0.000033>
61332 0.000073 clock_gettime(CLOCK_MONOTONIC, {11045, 366866358}) = 0 <0.000027>
61332 0.000063 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000029>
61332 0.000073 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\5\0\0\0\17\0\0\0\5\1u\0\5\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000027>
61332 0.000076 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000028>
61332 0.000082 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\27\0\0\0\6\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\5\0\0\0blkio\0\0\0\6\0\0\0lxc/p3\0", 23}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 151 <0.000032>
61332 0.000072 clock_gettime(CLOCK_MONOTONIC, {11045, 367232438}) = 0 <0.000029>
61332 0.000067 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000088>
61332 0.000131 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\6\0\0\0\17\0\0\0\5\1u\0\6\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000026>
61332 0.000069 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000079 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\27\0\0\0\7\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\7\0\0\0net_cls\0\6\0\0\0lxc/p3\0", 23}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 151 <0.000032>
61332 0.000072 clock_gettime(CLOCK_MONOTONIC, {11045, 367650329}) = 0 <0.000027>
61332 0.000064 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000027>
61332 0.000070 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\7\0\0\0\17\0\0\0\5\1u\0\7\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000026>
61332 0.000069 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000027>
61332 0.000077 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\27\0\0\0\10\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\7\0\0\0freezer\0\6\0\0\0lxc/p3\0", 23}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 151 <0.000034>
61332 0.000075 clock_gettime(CLOCK_MONOTONIC, {11045, 368006308}) = 0 <0.000027>
61332 0.000064 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000032>
61332 0.000093 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\10\0\0\0\17\0\0\0\5\1u\0\10\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000030>
61332 0.000076 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000089 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\27\0\0\0\t\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\7\0\0\0devices\0\6\0\0\0lxc/p3\0", 23}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 151 <0.000040>
61332 0.000092 clock_gettime(CLOCK_MONOTONIC, {11045, 368419792}) = 0 <0.000027>
61332 0.000065 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000029>
61332 0.000073 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\t\0\0\0\17\0\0\0\5\1u\0\t\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000027>
61332 0.000071 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000082 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\27\0\0\0\n\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\6\0\0\0memory\0\0\6\0\0\0lxc/p3\0", 23}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 151 <0.000033>
61332 0.000075 clock_gettime(CLOCK_MONOTONIC, {11045, 368785060}) = 0 <0.000027>
61332 0.000063 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000116>
61332 0.000160 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\n\0\0\0\17\0\0\0\5\1u\0\n\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000027>
61332 0.000069 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000026>
61332 0.000083 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\27\0\0\0\v\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\7\0\0\0cpuacct\0\6\0\0\0lxc/p3\0", 23}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 151 <0.000031>
61332 0.000073 clock_gettime(CLOCK_MONOTONIC, {11045, 369231865}) = 0 <0.000025>
61332 0.000060 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000070>
61332 0.000114 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\v\0\0\0\17\0\0\0\5\1u\0\v\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000027>
61332 0.000069 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000025>
61332 0.000075 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\23\0\0\0\f\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\3\0\0\0cpu\0\6\0\0\0lxc/p3\0", 19}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 147 <0.000031>
61332 0.000072 clock_gettime(CLOCK_MONOTONIC, {11045, 369622749}) = 0 <0.000025>
61332 0.000062 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000155>
61332 0.000198 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\f\0\0\0\17\0\0\0\5\1u\0\f\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000028>
61332 0.000071 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000030>
61332 0.000081 sendmsg(20, {msg_name(0)=NULL, msg_iov(2)=[{"l\1\0\1\27\0\0\0\r\0\0\0p\0\0\0\1\1o\0\36\0\0\0/org/lin"..., 128}, {"\6\0\0\0cpuset\0\0\6\0\0\0lxc/p3\0", 23}], msg_controllen=0, msg_flags=0}, MSG_NOSIGNAL) = 151 <0.000033>
61332 0.000074 clock_gettime(CLOCK_MONOTONIC, {11045, 370108279}) = 0 <0.000027>
61332 0.000064 poll([{fd=20<socket:[10143024]>, events=POLLIN}], 1, 25000) = 1 ([{fd=20, revents=POLLIN}]) <0.000028>
61332 0.000075 recvmsg(20, {msg_name(0)=NULL, msg_iov(1)=[{"l\2\1\1\4\0\0\0\r\0\0\0\17\0\0\0\5\1u\0\r\0\0\0\10\1g\0\1i\0\0"..., 2048}], msg_controllen=0, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 36 <0.000028>
61332 0.000069 recvmsg(20, 0x7ffff56e9e50, MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable) <0.000028>
61332 0.000068 close(20<socket:[10143024]>) = 0 <0.000035>
61332 0.000086 lstat("/var", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 <0.000029>
61332 0.000068 lstat("/var/lib", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 <0.000028>
61332 0.000065 lstat("/var/lib/lxc", {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0 <0.000029>
61332 0.000067 lstat("/var/lib/lxc/p3", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 <0.000027>
61332 0.000066 lstat("/var/lib/lxc/p3/rootfs", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 <0.000029>
61332 0.000070 access("/var/lib/lxc/p3/rootfs", F_OK) = 0 <0.000034>
61332 0.000072 stat("/var/lib/lxc/p3/rootfs", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 <0.000027>
61332 0.000066 open("/var/lib/lxc/p3/rootfs/lxc.hold", O_RDWR|O_CREAT, 0600) = 20 <0.000052>
61332 0.000090 unlink("/var/lib/lxc/p3/rootfs/lxc.hold") = 0 <0.000035>
61332 0.000071 access("/proc/self/ns", X_OK) = 0 <0.000031>
61332 0.000071 geteuid() = 0 <0.000025>
61332 0.000059 clone(
Raw
syscall
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.809762] INFO: task lxc-start:6944 blocked for more than 120 seconds.
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.813850] Not tainted 3.14.19-031419-generic #201409171336
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.817614] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822453] lxc-start D ffffffff81811ae0 0 6944 1 0x00000000
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822456] ffff88352c9b3cb0 0000000000000086 ffff883c7215ff00 ffff88352c9b3fd8
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822461] 0000000000014500 0000000000014500 ffff881dee634e80 ffff8831c5b39d70
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822464] 0000000000000000 ffffffff81cc9a20 ffffffff81cc9a24 00000000ffffffff
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822468] Call Trace:
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822474] [<ffffffff81777e99>] schedule+0x29/0x70
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822476] [<ffffffff817781be>] schedule_preempt_disabled+0xe/0x10
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822479] [<ffffffff81779ff4>] __mutex_lock_slowpath+0x114/0x1b0
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822481] [<ffffffff811bb483>] ? kmem_cache_alloc+0x1b3/0x1f0
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822483] [<ffffffff8165b5e9>] ? copy_net_ns+0x69/0x150
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822485] [<ffffffff8177a0b3>] mutex_lock+0x23/0x37
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822487] [<ffffffff8165b618>] copy_net_ns+0x98/0x150
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822490] [<ffffffff81097471>] create_new_namespaces+0x101/0x1b0
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822493] [<ffffffff810975ab>] copy_namespaces+0x8b/0xa0
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822495] [<ffffffff8106c53d>] copy_process.part.26+0x77d/0xf70
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822498] [<ffffffff8106cdb0>] copy_process+0x80/0x90
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822501] [<ffffffff8106cef2>] do_fork+0x62/0x280
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822503] [<ffffffff811f44e0>] ? get_unused_fd_flags+0x30/0x40
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822506] [<ffffffff8106d196>] SyS_clone+0x16/0x20
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822508] [<ffffffff81785149>] stub_clone+0x69/0x90
Oct 16 14:30:34 ip-10-63-130-120 kernel: [ 4324.822510] [<ffffffff81784ded>] ? system_call_fastpath+0x1a/0x1f
Oct 16 14:30:36 ip-10-63-130-120 kernel: [ 4326.336097] unregister_netdevice: waiting for lo to become free. Usage count = 1
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment