Dec 06 08:39:31.174 INFO testing VratnamT/firecracker against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 06 08:39:31.174 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 08:39:31.581 INFO [stdout] 4c2edf34606394c33873df3cf37bce84eba9fb0d744fdd274b89c72273a28783 Dec 06 08:39:31.583 INFO running `"docker" "start" "-a" "4c2edf34606394c33873df3cf37bce84eba9fb0d744fdd274b89c72273a28783"` Dec 06 08:39:32.716 INFO [stderr] usermod: no changes Dec 06 08:39:32.993 INFO [stderr] Compiling serde v1.0.27 Dec 06 08:39:32.993 INFO [stderr] Compiling dtoa v0.4.3 Dec 06 08:39:32.993 INFO [stderr] Compiling cfg-if v0.1.6 Dec 06 08:39:32.993 INFO [stderr] Compiling rand_core v0.3.0 Dec 06 08:39:32.993 INFO [stderr] Compiling byteorder v1.2.1 Dec 06 08:39:32.993 INFO [stderr] Compiling lazy_static v1.2.0 Dec 06 08:39:33.000 INFO [stderr] Compiling futures v0.1.18 Dec 06 08:39:33.000 INFO [stderr] Compiling micro_http v0.1.0 (/source/micro_http) Dec 06 08:39:33.456 INFO [stderr] Compiling scoped-tls v0.1.2 Dec 06 08:39:34.476 INFO [stderr] Compiling bitflags v0.7.0 Dec 06 08:39:34.700 INFO [stderr] Compiling ucd-util v0.1.3 Dec 06 08:39:34.724 INFO [stderr] Compiling virtio_sys v0.1.0 (/source/virtio_sys) Dec 06 08:39:35.596 INFO [stderr] Compiling safemem v0.3.0 Dec 06 08:39:36.956 INFO [stderr] Compiling slab v0.3.0 Dec 06 08:39:36.963 INFO [stderr] Compiling take v0.1.0 Dec 06 08:39:36.965 INFO [stderr] Compiling smallvec v0.2.1 Dec 06 08:39:36.967 INFO [stderr] Compiling ansi_term v0.9.0 Dec 06 08:39:36.981 INFO [stderr] Compiling language-tags v0.2.2 Dec 06 08:39:38.356 INFO [stderr] Compiling utf8-ranges v1.0.2 Dec 06 08:39:38.368 INFO [stderr] Compiling strsim v0.6.0 Dec 06 08:39:38.595 INFO [stderr] Compiling bitflags v0.9.1 Dec 06 08:39:39.504 INFO [stderr] Compiling log v0.4.6 Dec 06 08:39:39.504 INFO [stderr] Compiling thread_local v0.3.6 Dec 06 08:39:39.560 INFO [stderr] Compiling rand_xorshift v0.1.0 Dec 06 08:39:42.700 INFO [stderr] Compiling rand_hc v0.1.0 Dec 06 08:39:42.706 INFO [stderr] Compiling rand_isaac v0.1.1 Dec 06 08:39:42.936 INFO [stderr] Compiling textwrap v0.9.0 Dec 06 08:39:43.224 INFO [stderr] Compiling base64 v0.9.3 Dec 06 08:39:43.244 INFO [stderr] Compiling regex-syntax v0.6.3 Dec 06 08:39:45.180 INFO [stderr] Compiling libc v0.2.44 Dec 06 08:39:45.300 INFO [stderr] Compiling num-traits v0.2.6 Dec 06 08:39:46.763 INFO [stderr] Compiling httparse v1.3.3 Dec 06 08:39:46.768 INFO [stderr] Compiling log v0.3.9 Dec 06 08:39:46.768 INFO [stderr] Compiling tokio-service v0.1.0 Dec 06 08:39:46.791 INFO [stderr] Compiling relay v0.1.1 Dec 06 08:39:47.967 INFO [stderr] Compiling unicase v2.2.0 Dec 06 08:39:48.092 INFO [stderr] Compiling rand_pcg v0.1.1 Dec 06 08:39:49.846 INFO [stderr] Compiling rand_chacha v0.1.0 Dec 06 08:39:49.846 INFO [stderr] Compiling sys_util v0.1.0 (/source/sys_util) Dec 06 08:39:49.869 INFO [stderr] Compiling time v0.1.40 Dec 06 08:39:49.869 INFO [stderr] Compiling iovec v0.1.2 Dec 06 08:39:49.922 INFO [stderr] Compiling net2 v0.2.33 Dec 06 08:39:51.460 INFO [stderr] Compiling timerfd v1.0.0 Dec 06 08:39:51.528 INFO [stderr] Compiling fc_util v0.1.0 (/source/fc_util) Dec 06 08:39:51.566 INFO [stderr] Compiling rand v0.4.3 Dec 06 08:39:53.844 INFO [stderr] Compiling epoll v2.1.0 Dec 06 08:39:53.860 INFO [stderr] Compiling memchr v2.1.1 Dec 06 08:39:53.888 INFO [stderr] Compiling num_cpus v1.8.0 Dec 06 08:39:53.909 INFO [stderr] Compiling seccomp v0.1.0 (/source/seccomp) Dec 06 08:39:53.961 INFO [stderr] Compiling atty v0.2.11 Dec 06 08:39:55.880 INFO [stderr] Compiling backtrace-sys v0.1.24 Dec 06 08:39:56.887 INFO [stderr] Compiling num-integer v0.1.39 Dec 06 08:40:03.448 INFO [stderr] Compiling net_sys v0.1.0 (/source/net_sys) Dec 06 08:40:03.470 INFO [stderr] Compiling memory_model v0.1.0 (/source/memory_model) Dec 06 08:40:03.494 INFO [stderr] Compiling kvm_sys v0.1.0 (/source/kvm_sys) Dec 06 08:40:03.578 INFO [stderr] Compiling rand v0.6.1 Dec 06 08:40:03.688 INFO [stderr] Compiling bytes v0.4.11 Dec 06 08:40:03.768 INFO [stderr] Compiling mime v0.3.12 Dec 06 08:40:03.816 INFO [stderr] Compiling mio v0.6.16 Dec 06 08:40:03.972 INFO [stderr] Compiling clap v2.27.1 Dec 06 08:40:09.170 INFO [stderr] Compiling backtrace v0.3.9 Dec 06 08:40:10.140 INFO [stderr] Compiling futures-cpupool v0.1.8 Dec 06 08:40:10.174 INFO [stderr] Compiling aho-corasick v0.6.9 Dec 06 08:40:10.184 INFO [stderr] Compiling chrono v0.4.6 Dec 06 08:40:10.208 INFO [stderr] Compiling serde_json v1.0.17 Dec 06 08:40:15.796 INFO [stderr] Compiling rand v0.3.22 Dec 06 08:40:15.812 INFO [stderr] Compiling net_util v0.1.0 (/source/net_util) Dec 06 08:40:15.840 INFO [stderr] Compiling tokio-io v0.1.5 Dec 06 08:40:19.192 INFO [stderr] Compiling kvm v0.1.0 (/source/kvm) Dec 06 08:40:19.204 INFO [stderr] Compiling regex v1.0.6 Dec 06 08:40:19.220 INFO [stderr] Compiling mio-uds v0.6.7 Dec 06 08:40:21.768 INFO [stderr] Compiling tokio-core v0.1.12 Dec 06 08:40:22.540 INFO [stderr] Compiling json-patch v0.2.1 Dec 06 08:40:22.547 INFO [stderr] Compiling logger v0.1.0 (/source/logger) Dec 06 08:40:22.812 INFO [stderr] Compiling x86_64 v0.1.0 (/source/x86_64) Dec 06 08:40:29.103 INFO [stderr] Compiling mmds v0.1.0 (/source/mmds) Dec 06 08:40:29.237 INFO [stderr] Compiling kernel v0.1.0 (/source/kernel) Dec 06 08:40:35.344 INFO [stderr] Compiling rate_limiter v0.1.0 (/source/rate_limiter) Dec 06 08:40:35.492 INFO [stderr] Compiling cpuid v0.1.0 (/source/cpuid) Dec 06 08:40:35.674 INFO [stderr] Compiling tokio-proto v0.1.1 Dec 06 08:40:35.836 INFO [stderr] Compiling tokio-uds v0.1.7 Dec 06 08:40:43.885 INFO [stderr] Compiling dumbo v0.1.0 (/source/dumbo) Dec 06 08:40:44.116 INFO [stderr] Compiling hyper v0.11.16 Dec 06 08:40:48.675 INFO [stderr] Compiling devices v0.1.0 (/source/devices) Dec 06 08:40:48.970 INFO [stderr] Compiling jailer v0.11.0 (/source/jailer) Dec 06 08:40:52.996 INFO [stderr] Compiling vmm v0.1.0 (/source/vmm) Dec 06 08:40:57.933 INFO [stderr] Compiling api_server v0.1.0 (/source/api_server) Dec 06 08:41:02.072 INFO [stderr] Compiling firecracker v0.11.0 (/source) Dec 06 08:41:11.168 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 38s Dec 06 08:41:11.188 INFO [stderr] su: No module specific data is present Dec 06 08:41:11.623 INFO running `"docker" "inspect" "4c2edf34606394c33873df3cf37bce84eba9fb0d744fdd274b89c72273a28783"` Dec 06 08:41:11.867 INFO running `"docker" "rm" "-f" "4c2edf34606394c33873df3cf37bce84eba9fb0d744fdd274b89c72273a28783"` Dec 06 08:41:12.124 INFO [stdout] 4c2edf34606394c33873df3cf37bce84eba9fb0d744fdd274b89c72273a28783 Dec 06 08:41:12.126 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 08:41:12.468 INFO [stdout] 06f6c860b54d15bd1dd9ed78c34307196f608bc1ea3e8bdc6cb6da92e5bd050f Dec 06 08:41:12.480 INFO running `"docker" "start" "-a" "06f6c860b54d15bd1dd9ed78c34307196f608bc1ea3e8bdc6cb6da92e5bd050f"` Dec 06 08:41:13.759 INFO [stderr] usermod: no changes Dec 06 08:41:14.053 INFO [stderr] Compiling micro_http v0.1.0 (/source/micro_http) Dec 06 08:41:14.063 INFO [stderr] Compiling virtio_sys v0.1.0 (/source/virtio_sys) Dec 06 08:41:14.063 INFO [stderr] Compiling serde_json v1.0.17 Dec 06 08:41:14.063 INFO [stderr] Compiling base64 v0.9.3 Dec 06 08:41:14.067 INFO [stderr] Compiling sys_util v0.1.0 (/source/sys_util) Dec 06 08:41:14.067 INFO [stderr] Compiling fc_util v0.1.0 (/source/fc_util) Dec 06 08:41:14.067 INFO [stderr] Compiling epoll v2.1.0 Dec 06 08:41:14.067 INFO [stderr] Compiling seccomp v0.1.0 (/source/seccomp) Dec 06 08:41:16.812 INFO [stderr] Compiling bytes v0.4.11 Dec 06 08:41:16.812 INFO [stderr] Compiling futures-cpupool v0.1.8 Dec 06 08:41:16.816 INFO [stderr] Compiling clap v2.27.1 Dec 06 08:41:16.816 INFO [stderr] Compiling kvm_sys v0.1.0 (/source/kvm_sys) Dec 06 08:41:16.836 INFO [stderr] Compiling net_sys v0.1.0 (/source/net_sys) Dec 06 08:41:16.854 INFO [stderr] Compiling memory_model v0.1.0 (/source/memory_model) Dec 06 08:41:16.904 INFO [stderr] Compiling backtrace v0.3.9 Dec 06 08:41:22.168 INFO [stderr] Compiling net_util v0.1.0 (/source/net_util) Dec 06 08:41:22.168 INFO [stderr] Compiling tokio-io v0.1.5 Dec 06 08:41:22.168 INFO [stderr] Compiling kvm v0.1.0 (/source/kvm) Dec 06 08:41:22.329 INFO [stderr] Compiling json-patch v0.2.1 Dec 06 08:41:22.329 INFO [stderr] Compiling logger v0.1.0 (/source/logger) Dec 06 08:41:23.910 INFO [stderr] Compiling x86_64 v0.1.0 (/source/x86_64) Dec 06 08:41:24.676 INFO [stderr] Compiling tokio-core v0.1.12 Dec 06 08:41:27.975 INFO [stderr] Compiling mmds v0.1.0 (/source/mmds) Dec 06 08:41:28.200 INFO [stderr] Compiling rate_limiter v0.1.0 (/source/rate_limiter) Dec 06 08:41:28.201 INFO [stderr] Compiling cpuid v0.1.0 (/source/cpuid) Dec 06 08:41:28.244 INFO [stderr] Compiling kernel v0.1.0 (/source/kernel) Dec 06 08:41:31.486 INFO [stderr] Compiling dumbo v0.1.0 (/source/dumbo) Dec 06 08:41:31.544 INFO [stderr] Compiling tokio-proto v0.1.1 Dec 06 08:41:31.544 INFO [stderr] Compiling tokio-uds v0.1.7 Dec 06 08:41:35.021 INFO [stderr] Compiling hyper v0.11.16 Dec 06 08:41:36.126 INFO [stderr] Compiling devices v0.1.0 (/source/devices) Dec 06 08:41:44.831 INFO [stderr] Compiling vmm v0.1.0 (/source/vmm) Dec 06 08:41:52.445 INFO [stderr] Compiling api_server v0.1.0 (/source/api_server) Dec 06 08:41:52.642 INFO [stderr] Compiling jailer v0.11.0 (/source/jailer) Dec 06 08:41:58.080 INFO [stderr] Compiling firecracker v0.11.0 (/source) Dec 06 08:42:08.341 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 54.56s Dec 06 08:42:08.358 INFO [stderr] su: No module specific data is present Dec 06 08:42:09.284 INFO running `"docker" "inspect" "06f6c860b54d15bd1dd9ed78c34307196f608bc1ea3e8bdc6cb6da92e5bd050f"` Dec 06 08:42:09.560 INFO running `"docker" "rm" "-f" "06f6c860b54d15bd1dd9ed78c34307196f608bc1ea3e8bdc6cb6da92e5bd050f"` Dec 06 08:42:09.922 INFO [stdout] 06f6c860b54d15bd1dd9ed78c34307196f608bc1ea3e8bdc6cb6da92e5bd050f Dec 06 08:42:09.932 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 08:42:10.358 INFO [stdout] 2e6c6bbfdb117ec071d00589acbb5dd88ac00a4bc8fd55aadea964bc3a8fd3c2 Dec 06 08:42:10.361 INFO running `"docker" "start" "-a" "2e6c6bbfdb117ec071d00589acbb5dd88ac00a4bc8fd55aadea964bc3a8fd3c2"` Dec 06 08:42:11.732 INFO [stderr] usermod: no changes Dec 06 08:42:12.051 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.29s Dec 06 08:42:12.076 INFO [stderr] Running /target/debug/deps/firecracker-3732bf091dfa3801 Dec 06 08:42:12.096 INFO [stdout] Dec 06 08:42:12.096 INFO [stdout] running 1 test Dec 06 08:42:12.100 INFO [stderr] 2018-12-06T08:42:12.092491763 [: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 06 08:42:12.380 INFO [stdout] test tests::test_main ... ok Dec 06 08:42:12.380 INFO [stdout] Dec 06 08:42:12.380 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 08:42:12.380 INFO [stdout] Dec 06 08:42:12.385 INFO [stderr] Running /target/debug/deps/jailer-afa00d5b92d4d3de Dec 06 08:42:12.387 INFO [stdout] Dec 06 08:42:12.388 INFO [stdout] running 0 tests Dec 06 08:42:12.388 INFO [stdout] Dec 06 08:42:12.388 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 08:42:12.388 INFO [stdout] Dec 06 08:42:12.391 INFO [stderr] su: No module specific data is present Dec 06 08:42:13.118 INFO running `"docker" "inspect" "2e6c6bbfdb117ec071d00589acbb5dd88ac00a4bc8fd55aadea964bc3a8fd3c2"` Dec 06 08:42:13.380 INFO running `"docker" "rm" "-f" "2e6c6bbfdb117ec071d00589acbb5dd88ac00a4bc8fd55aadea964bc3a8fd3c2"` Dec 06 08:42:13.588 INFO [stdout] 2e6c6bbfdb117ec071d00589acbb5dd88ac00a4bc8fd55aadea964bc3a8fd3c2