Dec 14 04:45:37.620 INFO testing VratnamT/firecracker against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 04:45:37.620 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 04:45:38.237 INFO [stdout] b135e0329e46f690a9a7345cfd0d9541e5ac916acc805013078d6a1fab94e914
Dec 14 04:45:38.239 INFO running `"docker" "start" "-a" "b135e0329e46f690a9a7345cfd0d9541e5ac916acc805013078d6a1fab94e914"`
Dec 14 04:45:39.525 INFO [stderr] usermod: no changes
Dec 14 04:45:39.879 INFO [stderr]    Compiling dtoa v0.4.3
Dec 14 04:45:39.879 INFO [stderr]    Compiling itoa v0.4.3
Dec 14 04:45:39.884 INFO [stderr]    Compiling serde v1.0.27
Dec 14 04:45:39.884 INFO [stderr]    Compiling rand_core v0.3.0
Dec 14 04:45:39.884 INFO [stderr]    Compiling cfg-if v0.1.6
Dec 14 04:45:39.884 INFO [stderr]    Compiling byteorder v1.2.1
Dec 14 04:45:39.884 INFO [stderr]    Compiling micro_http v0.1.0 (/source/micro_http)
Dec 14 04:45:39.891 INFO [stderr]    Compiling futures v0.1.18
Dec 14 04:45:40.198 INFO [stderr]    Compiling slab v0.4.1
Dec 14 04:45:41.659 INFO [stderr]    Compiling lazycell v1.2.0
Dec 14 04:45:41.727 INFO [stderr]    Compiling lazy_static v1.2.0
Dec 14 04:45:41.935 INFO [stderr]    Compiling bitflags v0.7.0
Dec 14 04:45:42.699 INFO [stderr]    Compiling scoped-tls v0.1.2
Dec 14 04:45:42.699 INFO [stderr]    Compiling bitflags v1.0.4
Dec 14 04:45:42.751 INFO [stderr]    Compiling safemem v0.3.0
Dec 14 04:45:42.863 INFO [stderr]    Compiling unicode-width v0.1.5
Dec 14 04:45:43.555 INFO [stderr]    Compiling virtio_sys v0.1.0 (/source/virtio_sys)
Dec 14 04:45:43.683 INFO [stderr]    Compiling ucd-util v0.1.3
Dec 14 04:45:44.311 INFO [stderr]    Compiling slab v0.3.0
Dec 14 04:45:44.943 INFO [stderr]    Compiling take v0.1.0
Dec 14 04:45:45.007 INFO [stderr]    Compiling smallvec v0.2.1
Dec 14 04:45:45.660 INFO [stderr]    Compiling language-tags v0.2.2
Dec 14 04:45:46.219 INFO [stderr]    Compiling ansi_term v0.9.0
Dec 14 04:45:47.772 INFO [stderr]    Compiling strsim v0.6.0
Dec 14 04:45:49.541 INFO [stderr]    Compiling bitflags v0.9.1
Dec 14 04:45:49.555 INFO [stderr]    Compiling vec_map v0.8.1
Dec 14 04:45:49.715 INFO [stderr]    Compiling utf8-ranges v1.0.2
Dec 14 04:45:49.735 INFO [stderr]    Compiling rustc-demangle v0.1.9
Dec 14 04:45:51.935 INFO [stderr]    Compiling log v0.4.6
Dec 14 04:45:51.937 INFO [stderr]    Compiling rand_xorshift v0.1.0
Dec 14 04:45:51.947 INFO [stderr]    Compiling rand_isaac v0.1.1
Dec 14 04:45:51.966 INFO [stderr]    Compiling rand_hc v0.1.0
Dec 14 04:45:52.003 INFO [stderr]    Compiling thread_local v0.3.6
Dec 14 04:45:54.314 INFO [stderr]    Compiling textwrap v0.9.0
Dec 14 04:45:54.495 INFO [stderr]    Compiling base64 v0.9.3
Dec 14 04:45:54.503 INFO [stderr]    Compiling regex-syntax v0.6.3
Dec 14 04:45:54.583 INFO [stderr]    Compiling num-traits v0.2.6
Dec 14 04:45:56.103 INFO [stderr]    Compiling libc v0.2.44
Dec 14 04:45:56.111 INFO [stderr]    Compiling httparse v1.3.3
Dec 14 04:45:56.167 INFO [stderr]    Compiling tokio-service v0.1.0
Dec 14 04:45:59.340 INFO [stderr]    Compiling relay v0.1.1
Dec 14 04:45:59.939 INFO [stderr]    Compiling log v0.3.9
Dec 14 04:46:00.043 INFO [stderr]    Compiling unicase v2.2.0
Dec 14 04:46:02.591 INFO [stderr]    Compiling iovec v0.1.2
Dec 14 04:46:02.591 INFO [stderr]    Compiling sys_util v0.1.0 (/source/sys_util)
Dec 14 04:46:02.596 INFO [stderr]    Compiling time v0.1.40
Dec 14 04:46:02.694 INFO [stderr]    Compiling net2 v0.2.33
Dec 14 04:46:05.217 INFO [stderr]    Compiling rand v0.4.3
Dec 14 04:46:06.299 INFO [stderr]    Compiling timerfd v1.0.0
Dec 14 04:46:06.312 INFO [stderr]    Compiling fc_util v0.1.0 (/source/fc_util)
Dec 14 04:46:10.075 INFO [stderr]    Compiling epoll v2.1.0
Dec 14 04:46:10.075 INFO [stderr]    Compiling num_cpus v1.8.0
Dec 14 04:46:10.075 INFO [stderr]    Compiling memchr v2.1.1
Dec 14 04:46:10.075 INFO [stderr]    Compiling atty v0.2.11
Dec 14 04:46:10.131 INFO [stderr]    Compiling seccomp v0.1.0 (/source/seccomp)
Dec 14 04:46:12.499 INFO [stderr]    Compiling backtrace-sys v0.1.24
Dec 14 04:46:16.523 INFO [stderr]    Compiling num-integer v0.1.39
Dec 14 04:46:16.523 INFO [stderr]    Compiling rand_chacha v0.1.0
Dec 14 04:46:16.547 INFO [stderr]    Compiling rand_pcg v0.1.1
Dec 14 04:46:16.599 INFO [stderr]    Compiling kvm_sys v0.1.0 (/source/kvm_sys)
Dec 14 04:46:16.943 INFO [stderr]    Compiling memory_model v0.1.0 (/source/memory_model)
Dec 14 04:46:20.428 INFO [stderr]    Compiling net_sys v0.1.0 (/source/net_sys)
Dec 14 04:46:20.431 INFO [stderr]    Compiling bytes v0.4.11
Dec 14 04:46:20.511 INFO [stderr]    Compiling mime v0.3.12
Dec 14 04:46:25.699 INFO [stderr]    Compiling mio v0.6.16
Dec 14 04:46:25.731 INFO [stderr]    Compiling clap v2.27.1
Dec 14 04:46:26.188 INFO [stderr]    Compiling backtrace v0.3.9
Dec 14 04:46:27.147 INFO [stderr]    Compiling aho-corasick v0.6.9
Dec 14 04:46:27.186 INFO [stderr]    Compiling futures-cpupool v0.1.8
Dec 14 04:46:27.235 INFO [stderr]    Compiling rand v0.3.22
Dec 14 04:46:29.742 INFO [stderr]    Compiling serde_json v1.0.17
Dec 14 04:46:29.758 INFO [stderr]    Compiling rand v0.6.1
Dec 14 04:46:29.758 INFO [stderr]    Compiling chrono v0.4.6
Dec 14 04:46:34.466 INFO [stderr]    Compiling kvm v0.1.0 (/source/kvm)
Dec 14 04:46:34.485 INFO [stderr]    Compiling net_util v0.1.0 (/source/net_util)
Dec 14 04:46:34.592 INFO [stderr]    Compiling tokio-io v0.1.5
Dec 14 04:46:34.753 INFO [stderr]    Compiling regex v1.0.6
Dec 14 04:46:39.223 INFO [stderr]    Compiling mio-uds v0.6.7
Dec 14 04:46:42.975 INFO [stderr]    Compiling x86_64 v0.1.0 (/source/x86_64)
Dec 14 04:46:42.979 INFO [stderr]    Compiling tokio-core v0.1.12
Dec 14 04:46:43.111 INFO [stderr]    Compiling json-patch v0.2.1
Dec 14 04:46:43.111 INFO [stderr]    Compiling logger v0.1.0 (/source/logger)
Dec 14 04:46:51.160 INFO [stderr]    Compiling rate_limiter v0.1.0 (/source/rate_limiter)
Dec 14 04:46:51.160 INFO [stderr]    Compiling cpuid v0.1.0 (/source/cpuid)
Dec 14 04:46:57.955 INFO [stderr]    Compiling kernel v0.1.0 (/source/kernel)
Dec 14 04:46:59.610 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 14 04:46:59.975 INFO [stderr]    Compiling tokio-uds v0.1.7
Dec 14 04:47:02.127 INFO [stderr]    Compiling mmds v0.1.0 (/source/mmds)
Dec 14 04:47:04.779 INFO [stderr]    Compiling dumbo v0.1.0 (/source/dumbo)
Dec 14 04:47:07.408 INFO [stderr]    Compiling hyper v0.11.16
Dec 14 04:47:14.943 INFO [stderr]    Compiling devices v0.1.0 (/source/devices)
Dec 14 04:47:21.163 INFO [stderr]    Compiling vmm v0.1.0 (/source/vmm)
Dec 14 04:47:21.395 INFO [stderr]    Compiling jailer v0.11.0 (/source/jailer)
Dec 14 04:47:28.959 INFO [stderr]    Compiling api_server v0.1.0 (/source/api_server)
Dec 14 04:47:33.416 INFO [stderr]    Compiling firecracker v0.11.0 (/source)
Dec 14 04:47:43.113 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 03s
Dec 14 04:47:43.125 INFO [stderr] su: No module specific data is present
Dec 14 04:47:43.501 INFO running `"docker" "inspect" "b135e0329e46f690a9a7345cfd0d9541e5ac916acc805013078d6a1fab94e914"`
Dec 14 04:47:43.811 INFO running `"docker" "rm" "-f" "b135e0329e46f690a9a7345cfd0d9541e5ac916acc805013078d6a1fab94e914"`
Dec 14 04:47:44.054 INFO [stdout] b135e0329e46f690a9a7345cfd0d9541e5ac916acc805013078d6a1fab94e914
Dec 14 04:47:44.059 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 04:47:44.356 INFO [stdout] 9cbf745322a2fd6c2c4339e8b66b20273888fbe42f83c87bfd786dbde7eb0421
Dec 14 04:47:44.362 INFO running `"docker" "start" "-a" "9cbf745322a2fd6c2c4339e8b66b20273888fbe42f83c87bfd786dbde7eb0421"`
Dec 14 04:47:44.821 INFO [stderr] usermod: no changes
Dec 14 04:47:45.076 INFO [stderr]    Compiling micro_http v0.1.0 (/source/micro_http)
Dec 14 04:47:45.079 INFO [stderr]    Compiling virtio_sys v0.1.0 (/source/virtio_sys)
Dec 14 04:47:45.087 INFO [stderr]    Compiling serde_json v1.0.17
Dec 14 04:47:45.087 INFO [stderr]    Compiling base64 v0.9.3
Dec 14 04:47:45.088 INFO [stderr]    Compiling sys_util v0.1.0 (/source/sys_util)
Dec 14 04:47:45.089 INFO [stderr]    Compiling timerfd v1.0.0
Dec 14 04:47:45.089 INFO [stderr]    Compiling fc_util v0.1.0 (/source/fc_util)
Dec 14 04:47:45.089 INFO [stderr]    Compiling epoll v2.1.0
Dec 14 04:47:47.103 INFO [stderr]    Compiling seccomp v0.1.0 (/source/seccomp)
Dec 14 04:47:47.103 INFO [stderr]    Compiling bytes v0.4.11
Dec 14 04:47:47.131 INFO [stderr]    Compiling futures-cpupool v0.1.8
Dec 14 04:47:49.078 INFO [stderr]    Compiling clap v2.27.1
Dec 14 04:47:49.183 INFO [stderr]    Compiling backtrace v0.3.9
Dec 14 04:47:49.191 INFO [stderr]    Compiling memory_model v0.1.0 (/source/memory_model)
Dec 14 04:47:49.268 INFO [stderr]    Compiling net_sys v0.1.0 (/source/net_sys)
Dec 14 04:47:53.531 INFO [stderr]    Compiling kvm_sys v0.1.0 (/source/kvm_sys)
Dec 14 04:47:53.551 INFO [stderr]    Compiling tokio-io v0.1.5
Dec 14 04:47:54.331 INFO [stderr]    Compiling net_util v0.1.0 (/source/net_util)
Dec 14 04:47:56.578 INFO [stderr]    Compiling json-patch v0.2.1
Dec 14 04:47:56.578 INFO [stderr]    Compiling logger v0.1.0 (/source/logger)
Dec 14 04:47:57.485 INFO [stderr]    Compiling tokio-core v0.1.12
Dec 14 04:47:57.607 INFO [stderr]    Compiling kvm v0.1.0 (/source/kvm)
Dec 14 04:47:59.375 INFO [stderr]    Compiling x86_64 v0.1.0 (/source/x86_64)
Dec 14 04:48:01.992 INFO [stderr]    Compiling mmds v0.1.0 (/source/mmds)
Dec 14 04:48:02.247 INFO [stderr]    Compiling rate_limiter v0.1.0 (/source/rate_limiter)
Dec 14 04:48:03.483 INFO [stderr]    Compiling cpuid v0.1.0 (/source/cpuid)
Dec 14 04:48:03.483 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 14 04:48:03.483 INFO [stderr]    Compiling tokio-uds v0.1.7
Dec 14 04:48:03.575 INFO [stderr]    Compiling kernel v0.1.0 (/source/kernel)
Dec 14 04:48:05.724 INFO [stderr]    Compiling dumbo v0.1.0 (/source/dumbo)
Dec 14 04:48:09.539 INFO [stderr]    Compiling hyper v0.11.16
Dec 14 04:48:13.075 INFO [stderr]    Compiling devices v0.1.0 (/source/devices)
Dec 14 04:48:25.867 INFO [stderr]    Compiling vmm v0.1.0 (/source/vmm)
Dec 14 04:48:33.786 INFO [stderr]    Compiling jailer v0.11.0 (/source/jailer)
Dec 14 04:48:36.574 INFO [stderr]    Compiling api_server v0.1.0 (/source/api_server)
Dec 14 04:48:42.991 INFO [stderr]    Compiling firecracker v0.11.0 (/source)
Dec 14 04:48:55.439 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 10s
Dec 14 04:48:55.458 INFO [stderr] su: No module specific data is present
Dec 14 04:48:56.129 INFO running `"docker" "inspect" "9cbf745322a2fd6c2c4339e8b66b20273888fbe42f83c87bfd786dbde7eb0421"`
Dec 14 04:48:56.358 INFO running `"docker" "rm" "-f" "9cbf745322a2fd6c2c4339e8b66b20273888fbe42f83c87bfd786dbde7eb0421"`
Dec 14 04:48:56.759 INFO [stdout] 9cbf745322a2fd6c2c4339e8b66b20273888fbe42f83c87bfd786dbde7eb0421
Dec 14 04:48:56.767 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 04:48:57.195 INFO [stdout] c4ba19a9c9cdb6b9609973be690308a4d0551e78b65f610732bf8f32e0595e2e
Dec 14 04:48:57.203 INFO running `"docker" "start" "-a" "c4ba19a9c9cdb6b9609973be690308a4d0551e78b65f610732bf8f32e0595e2e"`
Dec 14 04:48:58.762 INFO [stderr] usermod: no changes
Dec 14 04:48:59.027 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.25s
Dec 14 04:48:59.047 INFO [stderr]      Running /target/debug/deps/firecracker-c552ed5a43fc76f3
Dec 14 04:48:59.055 INFO [stdout] 
Dec 14 04:48:59.055 INFO [stdout] running 1 test
Dec 14 04:48:59.067 INFO [stderr] 2018-12-14T04:48:59.060042852 [:ERROR:src/main.rs:49] Panic occurred: PanicInfo { payload: Any, message: Some(Cannot create VMM.: Kvm(Error(2))), location: Location { file: "src/libcore/result.rs", line: 1009, col: 5 } }
Dec 14 04:48:59.404 INFO [stdout] test tests::test_main ... ok
Dec 14 04:48:59.404 INFO [stdout] 
Dec 14 04:48:59.404 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 04:48:59.404 INFO [stdout] 
Dec 14 04:48:59.413 INFO [stderr]      Running /target/debug/deps/jailer-c189baa1128f21f4
Dec 14 04:48:59.415 INFO [stdout] 
Dec 14 04:48:59.415 INFO [stdout] running 0 tests
Dec 14 04:48:59.415 INFO [stdout] 
Dec 14 04:48:59.415 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 04:48:59.416 INFO [stdout] 
Dec 14 04:48:59.427 INFO [stderr] su: No module specific data is present
Dec 14 04:49:00.114 INFO running `"docker" "inspect" "c4ba19a9c9cdb6b9609973be690308a4d0551e78b65f610732bf8f32e0595e2e"`
Dec 14 04:49:00.421 INFO running `"docker" "rm" "-f" "c4ba19a9c9cdb6b9609973be690308a4d0551e78b65f610732bf8f32e0595e2e"`
Dec 14 04:49:00.727 INFO [stdout] c4ba19a9c9cdb6b9609973be690308a4d0551e78b65f610732bf8f32e0595e2e