Dec 14 04:45:37.713 INFO testing VratnamT/firecracker against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 04:45:37.713 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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.299 INFO [stdout] f7c94eeca054a5f4d27394ce1e75677d92067fd7b94b71ec196587c5f19e6dae
Dec 14 04:45:38.301 INFO running `"docker" "start" "-a" "f7c94eeca054a5f4d27394ce1e75677d92067fd7b94b71ec196587c5f19e6dae"`
Dec 14 04:45:39.363 INFO [stderr] usermod: no changes
Dec 14 04:45:39.719 INFO [stderr]    Compiling itoa v0.4.3
Dec 14 04:45:39.719 INFO [stderr]    Compiling dtoa v0.4.3
Dec 14 04:45:39.719 INFO [stderr]    Compiling serde v1.0.27
Dec 14 04:45:39.731 INFO [stderr]    Compiling cfg-if v0.1.6
Dec 14 04:45:39.731 INFO [stderr]    Compiling byteorder v1.2.1
Dec 14 04:45:39.731 INFO [stderr]    Compiling rand_core v0.3.0
Dec 14 04:45:39.731 INFO [stderr]    Compiling slab v0.4.1
Dec 14 04:45:39.731 INFO [stderr]    Compiling futures v0.1.18
Dec 14 04:45:40.343 INFO [stderr]    Compiling lazycell v1.2.0
Dec 14 04:45:41.428 INFO [stderr]    Compiling micro_http v0.1.0 (/source/micro_http)
Dec 14 04:45:41.599 INFO [stderr]    Compiling lazy_static v1.2.0
Dec 14 04:45:41.959 INFO [stderr]    Compiling bitflags v1.0.4
Dec 14 04:45:42.565 INFO [stderr]    Compiling scoped-tls v0.1.2
Dec 14 04:45:42.613 INFO [stderr]    Compiling bitflags v0.7.0
Dec 14 04:45:43.455 INFO [stderr]    Compiling slab v0.3.0
Dec 14 04:45:43.467 INFO [stderr]    Compiling smallvec v0.2.1
Dec 14 04:45:43.506 INFO [stderr]    Compiling ucd-util v0.1.3
Dec 14 04:45:45.172 INFO [stderr]    Compiling virtio_sys v0.1.0 (/source/virtio_sys)
Dec 14 04:45:45.180 INFO [stderr]    Compiling unicode-width v0.1.5
Dec 14 04:45:45.263 INFO [stderr]    Compiling take v0.1.0
Dec 14 04:45:45.580 INFO [stderr]    Compiling safemem v0.3.0
Dec 14 04:45:46.451 INFO [stderr]    Compiling ansi_term v0.9.0
Dec 14 04:45:46.451 INFO [stderr]    Compiling strsim v0.6.0
Dec 14 04:45:46.515 INFO [stderr]    Compiling language-tags v0.2.2
Dec 14 04:45:47.067 INFO [stderr]    Compiling bitflags v0.9.1
Dec 14 04:45:47.527 INFO [stderr]    Compiling utf8-ranges v1.0.2
Dec 14 04:45:48.147 INFO [stderr]    Compiling vec_map v0.8.1
Dec 14 04:45:49.132 INFO [stderr]    Compiling rustc-demangle v0.1.9
Dec 14 04:45:50.652 INFO [stderr]    Compiling log v0.4.6
Dec 14 04:45:52.335 INFO [stderr]    Compiling thread_local v0.3.6
Dec 14 04:45:53.067 INFO [stderr]    Compiling rand_xorshift v0.1.0
Dec 14 04:45:53.220 INFO [stderr]    Compiling rand_isaac v0.1.1
Dec 14 04:45:53.220 INFO [stderr]    Compiling rand_hc v0.1.0
Dec 14 04:45:53.251 INFO [stderr]    Compiling textwrap v0.9.0
Dec 14 04:45:53.251 INFO [stderr]    Compiling regex-syntax v0.6.3
Dec 14 04:45:53.271 INFO [stderr]    Compiling base64 v0.9.3
Dec 14 04:45:57.148 INFO [stderr]    Compiling num-traits v0.2.6
Dec 14 04:45:57.159 INFO [stderr]    Compiling libc v0.2.44
Dec 14 04:45:57.161 INFO [stderr]    Compiling httparse v1.3.3
Dec 14 04:45:57.192 INFO [stderr]    Compiling tokio-service v0.1.0
Dec 14 04:45:57.201 INFO [stderr]    Compiling relay v0.1.1
Dec 14 04:45:57.273 INFO [stderr]    Compiling log v0.3.9
Dec 14 04:45:59.687 INFO [stderr]    Compiling unicase v2.2.0
Dec 14 04:46:00.609 INFO [stderr]    Compiling rand_chacha v0.1.0
Dec 14 04:46:00.635 INFO [stderr]    Compiling rand_pcg v0.1.1
Dec 14 04:46:03.021 INFO [stderr]    Compiling sys_util v0.1.0 (/source/sys_util)
Dec 14 04:46:03.021 INFO [stderr]    Compiling iovec v0.1.2
Dec 14 04:46:03.053 INFO [stderr]    Compiling time v0.1.40
Dec 14 04:46:03.071 INFO [stderr]    Compiling net2 v0.2.33
Dec 14 04:46:05.123 INFO [stderr]    Compiling fc_util v0.1.0 (/source/fc_util)
Dec 14 04:46:09.139 INFO [stderr]    Compiling rand v0.4.3
Dec 14 04:46:09.139 INFO [stderr]    Compiling timerfd v1.0.0
Dec 14 04:46:09.144 INFO [stderr]    Compiling num_cpus v1.8.0
Dec 14 04:46:09.211 INFO [stderr]    Compiling memchr v2.1.1
Dec 14 04:46:09.211 INFO [stderr]    Compiling epoll v2.1.0
Dec 14 04:46:09.407 INFO [stderr]    Compiling seccomp v0.1.0 (/source/seccomp)
Dec 14 04:46:14.307 INFO [stderr]    Compiling atty v0.2.11
Dec 14 04:46:14.383 INFO [stderr]    Compiling backtrace-sys v0.1.24
Dec 14 04:46:14.403 INFO [stderr]    Compiling rand v0.6.1
Dec 14 04:46:14.625 INFO [stderr]    Compiling memory_model v0.1.0 (/source/memory_model)
Dec 14 04:46:16.883 INFO [stderr]    Compiling kvm_sys v0.1.0 (/source/kvm_sys)
Dec 14 04:46:17.228 INFO [stderr]    Compiling net_sys v0.1.0 (/source/net_sys)
Dec 14 04:46:18.079 INFO [stderr]    Compiling bytes v0.4.11
Dec 14 04:46:20.897 INFO [stderr]    Compiling mime v0.3.12
Dec 14 04:46:24.525 INFO [stderr]    Compiling num-integer v0.1.39
Dec 14 04:46:24.530 INFO [stderr]    Compiling mio v0.6.16
Dec 14 04:46:25.975 INFO [stderr]    Compiling futures-cpupool v0.1.8
Dec 14 04:46:25.999 INFO [stderr]    Compiling aho-corasick v0.6.9
Dec 14 04:46:26.007 INFO [stderr]    Compiling backtrace v0.3.9
Dec 14 04:46:26.627 INFO [stderr]    Compiling clap v2.27.1
Dec 14 04:46:29.423 INFO [stderr]    Compiling rand v0.3.22
Dec 14 04:46:29.487 INFO [stderr]    Compiling serde_json v1.0.17
Dec 14 04:46:33.079 INFO [stderr]    Compiling net_util v0.1.0 (/source/net_util)
Dec 14 04:46:33.079 INFO [stderr]    Compiling kvm v0.1.0 (/source/kvm)
Dec 14 04:46:33.079 INFO [stderr]    Compiling tokio-io v0.1.5
Dec 14 04:46:33.117 INFO [stderr]    Compiling chrono v0.4.6
Dec 14 04:46:33.135 INFO [stderr]    Compiling regex v1.0.6
Dec 14 04:46:38.401 INFO [stderr]    Compiling x86_64 v0.1.0 (/source/x86_64)
Dec 14 04:46:38.484 INFO [stderr]    Compiling mio-uds v0.6.7
Dec 14 04:46:39.536 INFO [stderr]    Compiling tokio-core v0.1.12
Dec 14 04:46:46.703 INFO [stderr]    Compiling kernel v0.1.0 (/source/kernel)
Dec 14 04:46:54.313 INFO [stderr]    Compiling json-patch v0.2.1
Dec 14 04:46:54.523 INFO [stderr]    Compiling logger v0.1.0 (/source/logger)
Dec 14 04:46:54.935 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 14 04:46:55.159 INFO [stderr]    Compiling tokio-uds v0.1.7
Dec 14 04:47:01.491 INFO [stderr]    Compiling rate_limiter v0.1.0 (/source/rate_limiter)
Dec 14 04:47:01.491 INFO [stderr]    Compiling cpuid v0.1.0 (/source/cpuid)
Dec 14 04:47:01.777 INFO [stderr]    Compiling mmds v0.1.0 (/source/mmds)
Dec 14 04:47:04.506 INFO [stderr]    Compiling hyper v0.11.16
Dec 14 04:47:08.847 INFO [stderr]    Compiling dumbo v0.1.0 (/source/dumbo)
Dec 14 04:47:17.731 INFO [stderr]    Compiling devices v0.1.0 (/source/devices)
Dec 14 04:47:21.705 INFO [stderr]    Compiling jailer v0.11.0 (/source/jailer)
Dec 14 04:47:23.179 INFO [stderr]    Compiling vmm v0.1.0 (/source/vmm)
Dec 14 04:47:29.451 INFO [stderr]    Compiling api_server v0.1.0 (/source/api_server)
Dec 14 04:47:33.788 INFO [stderr]    Compiling firecracker v0.11.0 (/source)
Dec 14 04:47:43.266 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 03s
Dec 14 04:47:43.279 INFO [stderr] su: No module specific data is present
Dec 14 04:47:43.837 INFO running `"docker" "inspect" "f7c94eeca054a5f4d27394ce1e75677d92067fd7b94b71ec196587c5f19e6dae"`
Dec 14 04:47:44.059 INFO running `"docker" "rm" "-f" "f7c94eeca054a5f4d27394ce1e75677d92067fd7b94b71ec196587c5f19e6dae"`
Dec 14 04:47:44.272 INFO [stdout] f7c94eeca054a5f4d27394ce1e75677d92067fd7b94b71ec196587c5f19e6dae
Dec 14 04:47:44.276 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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.463 INFO [stdout] dcd28bc0a19a8ca834ee80264e2b7aba0291462a0a2521d968893fbfb1aa9cda
Dec 14 04:47:44.465 INFO running `"docker" "start" "-a" "dcd28bc0a19a8ca834ee80264e2b7aba0291462a0a2521d968893fbfb1aa9cda"`
Dec 14 04:47:44.887 INFO [stderr] usermod: no changes
Dec 14 04:47:45.191 INFO [stderr]    Compiling micro_http v0.1.0 (/source/micro_http)
Dec 14 04:47:45.191 INFO [stderr]    Compiling virtio_sys v0.1.0 (/source/virtio_sys)
Dec 14 04:47:45.191 INFO [stderr]    Compiling serde_json v1.0.17
Dec 14 04:47:45.207 INFO [stderr]    Compiling base64 v0.9.3
Dec 14 04:47:45.207 INFO [stderr]    Compiling sys_util v0.1.0 (/source/sys_util)
Dec 14 04:47:45.207 INFO [stderr]    Compiling fc_util v0.1.0 (/source/fc_util)
Dec 14 04:47:45.207 INFO [stderr]    Compiling epoll v2.1.0
Dec 14 04:47:45.207 INFO [stderr]    Compiling seccomp v0.1.0 (/source/seccomp)
Dec 14 04:47:47.071 INFO [stderr]    Compiling bytes v0.4.11
Dec 14 04:47:47.083 INFO [stderr]    Compiling futures-cpupool v0.1.8
Dec 14 04:47:49.198 INFO [stderr]    Compiling memory_model v0.1.0 (/source/memory_model)
Dec 14 04:47:49.199 INFO [stderr]    Compiling kvm_sys v0.1.0 (/source/kvm_sys)
Dec 14 04:47:49.215 INFO [stderr]    Compiling net_sys v0.1.0 (/source/net_sys)
Dec 14 04:47:49.218 INFO [stderr]    Compiling clap v2.27.1
Dec 14 04:47:49.239 INFO [stderr]    Compiling backtrace v0.3.9
Dec 14 04:47:54.036 INFO [stderr]    Compiling tokio-io v0.1.5
Dec 14 04:47:54.115 INFO [stderr]    Compiling net_util v0.1.0 (/source/net_util)
Dec 14 04:47:56.043 INFO [stderr]    Compiling kvm v0.1.0 (/source/kvm)
Dec 14 04:47:56.235 INFO [stderr]    Compiling json-patch v0.2.1
Dec 14 04:47:56.235 INFO [stderr]    Compiling logger v0.1.0 (/source/logger)
Dec 14 04:47:57.383 INFO [stderr]    Compiling tokio-core v0.1.12
Dec 14 04:47:58.183 INFO [stderr]    Compiling x86_64 v0.1.0 (/source/x86_64)
Dec 14 04:48:01.378 INFO [stderr]    Compiling rate_limiter v0.1.0 (/source/rate_limiter)
Dec 14 04:48:01.379 INFO [stderr]    Compiling cpuid v0.1.0 (/source/cpuid)
Dec 14 04:48:02.008 INFO [stderr]    Compiling kernel v0.1.0 (/source/kernel)
Dec 14 04:48:02.346 INFO [stderr]    Compiling mmds v0.1.0 (/source/mmds)
Dec 14 04:48:03.974 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 14 04:48:03.974 INFO [stderr]    Compiling tokio-uds v0.1.7
Dec 14 04:48:05.655 INFO [stderr]    Compiling dumbo v0.1.0 (/source/dumbo)
Dec 14 04:48:09.475 INFO [stderr]    Compiling hyper v0.11.16
Dec 14 04:48:10.863 INFO [stderr]    Compiling devices v0.1.0 (/source/devices)
Dec 14 04:48:24.127 INFO [stderr]    Compiling vmm v0.1.0 (/source/vmm)
Dec 14 04:48:34.679 INFO [stderr]    Compiling api_server v0.1.0 (/source/api_server)
Dec 14 04:48:34.733 INFO [stderr]    Compiling jailer v0.11.0 (/source/jailer)
Dec 14 04:48:42.027 INFO [stderr]    Compiling firecracker v0.11.0 (/source)
Dec 14 04:48:54.560 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 09s
Dec 14 04:48:54.583 INFO [stderr] su: No module specific data is present
Dec 14 04:48:55.843 INFO running `"docker" "inspect" "dcd28bc0a19a8ca834ee80264e2b7aba0291462a0a2521d968893fbfb1aa9cda"`
Dec 14 04:48:56.109 INFO running `"docker" "rm" "-f" "dcd28bc0a19a8ca834ee80264e2b7aba0291462a0a2521d968893fbfb1aa9cda"`
Dec 14 04:48:56.431 INFO [stdout] dcd28bc0a19a8ca834ee80264e2b7aba0291462a0a2521d968893fbfb1aa9cda
Dec 14 04:48:56.433 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:56.887 INFO [stdout] 40ccc538971139041286afc233aa97b2c1117e4b88bf91208f49ac2b5bbf0e9b
Dec 14 04:48:56.895 INFO running `"docker" "start" "-a" "40ccc538971139041286afc233aa97b2c1117e4b88bf91208f49ac2b5bbf0e9b"`
Dec 14 04:48:58.184 INFO [stderr] usermod: no changes
Dec 14 04:48:58.459 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.23s
Dec 14 04:48:58.464 INFO [stderr]      Running /target/debug/deps/firecracker-d5993327c0889bde
Dec 14 04:48:58.479 INFO [stdout] 
Dec 14 04:48:58.479 INFO [stdout] running 1 test
Dec 14 04:48:58.487 INFO [stderr] 2018-12-14T04:48:58.482944859 [: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:58.803 INFO [stdout] test tests::test_main ... ok
Dec 14 04:48:58.803 INFO [stdout] 
Dec 14 04:48:58.803 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 04:48:58.803 INFO [stdout] 
Dec 14 04:48:58.815 INFO [stdout] 
Dec 14 04:48:58.815 INFO [stderr]      Running /target/debug/deps/jailer-46a29e74dc4f7240
Dec 14 04:48:58.815 INFO [stdout] running 0 tests
Dec 14 04:48:58.815 INFO [stdout] 
Dec 14 04:48:58.815 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 04:48:58.815 INFO [stdout] 
Dec 14 04:48:58.815 INFO [stderr] su: No module specific data is present
Dec 14 04:48:59.609 INFO running `"docker" "inspect" "40ccc538971139041286afc233aa97b2c1117e4b88bf91208f49ac2b5bbf0e9b"`
Dec 14 04:48:59.907 INFO running `"docker" "rm" "-f" "40ccc538971139041286afc233aa97b2c1117e4b88bf91208f49ac2b5bbf0e9b"`
Dec 14 04:49:00.102 INFO [stdout] 40ccc538971139041286afc233aa97b2c1117e4b88bf91208f49ac2b5bbf0e9b