Nov 17 16:34:41.791 INFO testing BooleanCat/prefab against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 16:34:41.793 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 16:34:41.989 INFO [stdout] e89f123d42a43d49f967d4b606d65b3642da945521c9d84a40ccb14f9841d8a3
Nov 17 16:34:41.994 INFO running `"docker" "start" "-a" "e89f123d42a43d49f967d4b606d65b3642da945521c9d84a40ccb14f9841d8a3"`
Nov 17 16:34:42.779 INFO [stderr] usermod: no changes
Nov 17 16:34:42.873 INFO [stderr]    Compiling syn v0.15.21
Nov 17 16:34:51.413 INFO [stderr]    Compiling structopt-derive v0.2.13
Nov 17 16:34:51.413 INFO [stderr]    Compiling serde_derive v1.0.80
Nov 17 16:34:56.227 INFO [stderr]    Compiling structopt v0.2.13
Nov 17 16:35:05.175 INFO [stderr]    Compiling prefab v0.1.0 (/source)
Nov 17 16:35:12.168 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 29.37s
Nov 17 16:35:12.174 INFO [stderr] su: No module specific data is present
Nov 17 16:35:12.436 INFO running `"docker" "inspect" "e89f123d42a43d49f967d4b606d65b3642da945521c9d84a40ccb14f9841d8a3"`
Nov 17 16:35:12.536 INFO running `"docker" "rm" "-f" "e89f123d42a43d49f967d4b606d65b3642da945521c9d84a40ccb14f9841d8a3"`
Nov 17 16:35:12.624 INFO [stdout] e89f123d42a43d49f967d4b606d65b3642da945521c9d84a40ccb14f9841d8a3
Nov 17 16:35:12.625 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 16:35:12.811 INFO [stdout] 42d1c3021614e347b69d5fa22982f21ecb5ff120e8585430ecd4cdd54608060b
Nov 17 16:35:12.813 INFO running `"docker" "start" "-a" "42d1c3021614e347b69d5fa22982f21ecb5ff120e8585430ecd4cdd54608060b"`
Nov 17 16:35:13.353 INFO [stderr] usermod: no changes
Nov 17 16:35:13.429 INFO [stderr]    Compiling prefab v0.1.0 (/source)
Nov 17 16:35:24.950 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.58s
Nov 17 16:35:24.955 INFO [stderr] su: No module specific data is present
Nov 17 16:35:25.196 INFO running `"docker" "inspect" "42d1c3021614e347b69d5fa22982f21ecb5ff120e8585430ecd4cdd54608060b"`
Nov 17 16:35:25.256 INFO running `"docker" "rm" "-f" "42d1c3021614e347b69d5fa22982f21ecb5ff120e8585430ecd4cdd54608060b"`
Nov 17 16:35:25.350 INFO [stdout] 42d1c3021614e347b69d5fa22982f21ecb5ff120e8585430ecd4cdd54608060b
Nov 17 16:35:25.356 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 16:35:25.532 INFO [stdout] 0099333e917bd35fe0a56815963df171d6a0b34378509da003f9ae9a12d0bdfe
Nov 17 16:35:25.536 INFO running `"docker" "start" "-a" "0099333e917bd35fe0a56815963df171d6a0b34378509da003f9ae9a12d0bdfe"`
Nov 17 16:35:26.095 INFO [stderr] usermod: no changes
Nov 17 16:35:26.160 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 17 16:35:26.175 INFO [stderr]      Running /target/debug/deps/prefab-1bef6454dbbed386
Nov 17 16:35:26.181 INFO [stdout] 
Nov 17 16:35:26.181 INFO [stdout] running 129 tests
Nov 17 16:35:26.208 INFO [stdout] test config::hooks::tests::deserialize_hooks_optional_fields ... ok
Nov 17 16:35:26.208 INFO [stdout] test config::hooks::hook::tests::deserialize_hooks_optional_fields ... ok
Nov 17 16:35:26.208 INFO [stdout] test config::hooks::hook::tests::deserialize_hook ... ok
Nov 17 16:35:26.209 INFO [stdout] test config::linux::id_mapping::tests::deserialize_id_mapping ... ok
Nov 17 16:35:26.209 INFO [stdout] test config::linux::device::tests::serialize_device ... ok
Nov 17 16:35:26.209 INFO [stdout] test config::linux::device::tests::deserialize_device ... ok
Nov 17 16:35:26.209 INFO [stdout] test config::hooks::tests::deserialize_hooks ... ok
Nov 17 16:35:26.210 INFO [stdout] test config::linux::device::tests::deserialize_device_optional_fields ... ok
Nov 17 16:35:26.210 INFO [stdout] test config::hooks::hook::tests::serialize_hook ... ok
Nov 17 16:35:26.210 INFO [stdout] test config::hooks::tests::serialize_hooks ... ok
Nov 17 16:35:26.215 INFO [stdout] test config::linux::intel_rdt::tests::deserialize_intel_rdt ... ok
Nov 17 16:35:26.215 INFO [stdout] test config::linux::namespace::tests::serialize_namespace ... ok
Nov 17 16:35:26.216 INFO [stdout] test config::linux::namespace::tests::deserialize_namespace_optional_fields ... ok
Nov 17 16:35:26.216 INFO [stdout] test config::linux::resources::block_io::tests::deserialize_block_io ... ok
Nov 17 16:35:26.216 INFO [stdout] test config::linux::resources::block_io::tests::deserialize_block_io_optional_fields ... ok
Nov 17 16:35:26.217 INFO [stdout] test config::linux::resources::block_io::weight_device::tests::deserialize_weight_device ... ok
Nov 17 16:35:26.217 INFO [stdout] test config::linux::namespace::tests::deserialize_namespace ... ok
Nov 17 16:35:26.217 INFO [stdout] test config::linux::intel_rdt::tests::deserialize_intel_rdt_optional_fields ... ok
Nov 17 16:35:26.218 INFO [stdout] test config::linux::intel_rdt::tests::serialize_intel_rdt ... ok
Nov 17 16:35:26.218 INFO [stdout] test config::linux::resources::cpu::tests::deserialize_cpu ... ok
Nov 17 16:35:26.218 INFO [stdout] test config::linux::resources::cpu::tests::deserialize_cpu_optional_fields ... ok
Nov 17 16:35:26.218 INFO [stdout] test config::linux::resources::cpu::tests::serialize_cpu ... ok
Nov 17 16:35:26.219 INFO [stdout] test config::linux::resources::device::tests::deserialize_device ... ok
Nov 17 16:35:26.219 INFO [stdout] test config::linux::resources::device::tests::deserialize_device_optional_fields ... ok
Nov 17 16:35:26.219 INFO [stdout] test config::linux::resources::device::tests::serialize_device ... ok
Nov 17 16:35:26.219 INFO [stdout] test config::linux::resources::hugepage_limit::tests::deserialize_hugepage_limit ... ok
Nov 17 16:35:26.219 INFO [stdout] test config::linux::resources::hugepage_limit::tests::serialize_hugepage_limit ... ok
Nov 17 16:35:26.220 INFO [stdout] test config::linux::resources::memory::tests::deserialize_memory ... ok
Nov 17 16:35:26.220 INFO [stdout] test config::linux::resources::memory::tests::deserialize_memory_optional_fields ... ok
Nov 17 16:35:26.220 INFO [stdout] test config::linux::resources::memory::tests::serialize_memory ... ok
Nov 17 16:35:26.220 INFO [stdout] test config::linux::resources::network::priority::tests::deserialize_priority ... ok
Nov 17 16:35:26.220 INFO [stdout] test config::linux::resources::network::priority::tests::serialize_priority ... ok
Nov 17 16:35:26.220 INFO [stdout] test config::linux::resources::network::tests::deserialize_network ... ok
Nov 17 16:35:26.220 INFO [stdout] test config::linux::resources::network::tests::deserialize_network_optional_fields ... ok
Nov 17 16:35:26.221 INFO [stdout] test config::linux::resources::network::tests::serialize_network ... ok
Nov 17 16:35:26.221 INFO [stdout] test config::linux::resources::pids::tests::deserialize_pids ... ok
Nov 17 16:35:26.221 INFO [stdout] test config::linux::resources::rdma::tests::deserialize_rdma ... ok
Nov 17 16:35:26.221 INFO [stdout] test config::linux::resources::pids::tests::serialize_pids ... ok
Nov 17 16:35:26.221 INFO [stdout] test config::linux::resources::rdma::tests::deserialize_rdma_optional_fields ... ok
Nov 17 16:35:26.227 INFO [stdout] test config::linux::resources::rdma::tests::serialize_rdma ... ok
Nov 17 16:35:26.227 INFO [stdout] test config::linux::resources::block_io::iops_device::tests::deserialize_rate_device ... ok
Nov 17 16:35:26.228 INFO [stdout] test config::linux::resources::block_io::iops_device::tests::serialize_rate_device ... ok
Nov 17 16:35:26.228 INFO [stdout] test config::linux::id_mapping::tests::serialize_id_mapping ... ok
Nov 17 16:35:26.228 INFO [stdout] test config::linux::resources::tests::deserialize_resources ... ok
Nov 17 16:35:26.228 INFO [stdout] test config::linux::resources::block_io::tests::serialize_block_io ... ok
Nov 17 16:35:26.228 INFO [stdout] test config::linux::resources::block_io::weight_device::tests::serialize_weight_device ... ok
Nov 17 16:35:26.229 INFO [stdout] test config::linux::resources::block_io::weight_device::tests::deserialize_weight_device_optional_fields ... ok
Nov 17 16:35:26.229 INFO [stdout] test config::linux::seccomp::syscall::tests::deserialize_syscall_optional_fields ... ok
Nov 17 16:35:26.229 INFO [stdout] test config::linux::seccomp::syscall::tests::deserialize_syscall ... ok
Nov 17 16:35:26.229 INFO [stdout] test config::linux::seccomp::syscall::arg::tests::deserialize_arg_optional_fields ... ok
Nov 17 16:35:26.229 INFO [stdout] test config::linux::resources::tests::deserialize_resources_optional_fields ... ok
Nov 17 16:35:26.230 INFO [stdout] test config::linux::seccomp::syscall::arg::tests::deserialize_arg ... ok
Nov 17 16:35:26.230 INFO [stdout] test config::linux::seccomp::tests::deserialize_seccomp_optional_fields ... ok
Nov 17 16:35:26.230 INFO [stdout] test config::linux::seccomp::tests::serialize_seccomp ... ok
Nov 17 16:35:26.230 INFO [stdout] test config::linux::tests::deserialize_linux ... ok
Nov 17 16:35:26.230 INFO [stdout] test config::linux::tests::deserialize_linux_optional_fields ... ok
Nov 17 16:35:26.230 INFO [stdout] test config::linux::tests::serialize_linux ... ok
Nov 17 16:35:26.231 INFO [stdout] test config::mount::tests::deserialize_mount ... ok
Nov 17 16:35:26.231 INFO [stdout] test config::mount::tests::deserialize_mount_optional_fields ... ok
Nov 17 16:35:26.231 INFO [stdout] test config::mount::tests::serialize_mount ... ok
Nov 17 16:35:26.231 INFO [stdout] test config::process::capabilities::tests::deserialize_capabilities ... ok
Nov 17 16:35:26.231 INFO [stdout] test config::process::capabilities::tests::deserialize_capabilities_optional_fields ... ok
Nov 17 16:35:26.232 INFO [stdout] test config::process::capabilities::tests::serialize_capabilities ... ok
Nov 17 16:35:26.232 INFO [stdout] test config::process::console_size::tests::deserialize_console_size ... ok
Nov 17 16:35:26.232 INFO [stdout] test config::process::console_size::tests::serialize_console_size ... ok
Nov 17 16:35:26.232 INFO [stdout] test config::process::rlimit::tests::deserialize_rlimit ... ok
Nov 17 16:35:26.232 INFO [stdout] test config::process::rlimit::tests::serialize_rlimit ... ok
Nov 17 16:35:26.233 INFO [stdout] test config::process::tests::deserialize_process ... ok
Nov 17 16:35:26.233 INFO [stdout] test config::process::tests::deserialize_process_optional_fields ... ok
Nov 17 16:35:26.233 INFO [stdout] test config::process::tests::serialize_process ... ok
Nov 17 16:35:26.233 INFO [stdout] test config::process::user::tests::deserialize_user ... ok
Nov 17 16:35:26.233 INFO [stdout] test config::process::user::tests::deserialize_user_optional_fields ... ok
Nov 17 16:35:26.233 INFO [stdout] test config::process::user::tests::serialize_user ... ok
Nov 17 16:35:26.234 INFO [stdout] test config::root::tests::deserialize_root ... ok
Nov 17 16:35:26.234 INFO [stdout] test config::root::tests::deserialize_root_optional_fields ... ok
Nov 17 16:35:26.234 INFO [stdout] test config::root::tests::serialize_root ... ok
Nov 17 16:35:26.234 INFO [stdout] test config::solaris::anet::tests::deserialize_anet ... ok
Nov 17 16:35:26.234 INFO [stdout] test config::solaris::anet::tests::deserialize_anet_optional_fields ... ok
Nov 17 16:35:26.235 INFO [stdout] test config::solaris::anet::tests::serialize_anet ... ok
Nov 17 16:35:26.235 INFO [stdout] test config::solaris::capped_cpu::tests::deserialize_capped_cpu ... ok
Nov 17 16:35:26.235 INFO [stdout] test config::solaris::capped_cpu::tests::deserialize_capped_cpu_optional_fields ... ok
Nov 17 16:35:26.235 INFO [stdout] test config::solaris::capped_cpu::tests::serialize_capped_cpu ... ok
Nov 17 16:35:26.235 INFO [stdout] test config::linux::seccomp::tests::deserialize_seccomp ... ok
Nov 17 16:35:26.235 INFO [stdout] test config::solaris::capped_memory::tests::deserialize_capped_memory ... ok
Nov 17 16:35:26.236 INFO [stdout] test config::solaris::capped_memory::tests::deserialize_capped_memory_optional_fields ... ok
Nov 17 16:35:26.236 INFO [stdout] test config::linux::seccomp::syscall::tests::serialize_syscall ... ok
Nov 17 16:35:26.236 INFO [stdout] test config::linux::seccomp::syscall::arg::tests::serialize_arg ... ok
Nov 17 16:35:26.236 INFO [stdout] test config::solaris::capped_memory::tests::serialize_capped_memory ... ok
Nov 17 16:35:26.236 INFO [stdout] test config::solaris::tests::deserialize_solaris ... ok
Nov 17 16:35:26.236 INFO [stdout] test config::linux::resources::tests::serialize_resources ... ok
Nov 17 16:35:26.237 INFO [stdout] test config::solaris::tests::serialize_solaris ... ok
Nov 17 16:35:26.237 INFO [stdout] test config::solaris::tests::deserialize_solaris_optional_fields ... ok
Nov 17 16:35:26.237 INFO [stdout] test config::vm::hypervisor::tests::deserialize_hypervisor_optional_fields ... ok
Nov 17 16:35:26.237 INFO [stdout] test config::vm::hypervisor::tests::deserialize_hypervisor ... ok
Nov 17 16:35:26.247 INFO [stdout] test config::vm::kernel::tests::deserialize_kernel ... ok
Nov 17 16:35:26.247 INFO [stdout] test config::vm::image::tests::deserialize_image ... ok
Nov 17 16:35:26.247 INFO [stdout] test config::vm::hypervisor::tests::serialize_hypervisor ... ok
Nov 17 16:35:26.247 INFO [stdout] test config::vm::image::tests::serialize_image ... ok
Nov 17 16:35:26.248 INFO [stdout] test config::tests::deserialize_config_optional_fields ... ok
Nov 17 16:35:26.248 INFO [stdout] test config::tests::serialize_config ... ok
Nov 17 16:35:26.248 INFO [stdout] test config::tests::deserialize_config ... ok
Nov 17 16:35:26.251 INFO [stdout] test config::vm::kernel::tests::deserialize_kernel_optional_fields ... ok
Nov 17 16:35:26.251 INFO [stdout] test config::windows::hyperv::tests::deserialize_hyperv ... ok
Nov 17 16:35:26.251 INFO [stdout] test config::windows::hyperv::tests::deserialize_hyperv_optional_fields ... ok
Nov 17 16:35:26.252 INFO [stdout] test config::windows::hyperv::tests::serialize_hyperv ... ok
Nov 17 16:35:26.252 INFO [stdout] test config::windows::network::tests::deserialize_network ... ok
Nov 17 16:35:26.252 INFO [stdout] test config::windows::network::tests::deserialize_network_optional_fields ... ok
Nov 17 16:35:26.252 INFO [stdout] test config::windows::network::tests::serialize_network ... ok
Nov 17 16:35:26.252 INFO [stdout] test config::windows::resources::cpu::tests::deserialize_cpu ... ok
Nov 17 16:35:26.252 INFO [stdout] test config::windows::resources::cpu::tests::deserialize_cpu_optional_fields ... ok
Nov 17 16:35:26.253 INFO [stdout] test config::windows::resources::cpu::tests::serialize_cpu ... ok
Nov 17 16:35:26.253 INFO [stdout] test config::windows::resources::memory::tests::deserialize_memory ... ok
Nov 17 16:35:26.253 INFO [stdout] test config::windows::resources::memory::tests::deserialize_memory_optional_fields ... ok
Nov 17 16:35:26.253 INFO [stdout] test config::windows::device::tests::serialize_device ... ok
Nov 17 16:35:26.253 INFO [stdout] test config::windows::resources::memory::tests::serialize_memory ... ok
Nov 17 16:35:26.253 INFO [stdout] test config::windows::device::tests::deserialize_device ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::vm::tests::deserialize_vm ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::resources::tests::deserialize_resources ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::vm::tests::serialize_vm ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::resources::storage::tests::serialize_storage ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::resources::storage::tests::deserialize_storage ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::vm::kernel::tests::serialize_kernel ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::resources::storage::tests::deserialize_storage_optional_fields ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::resources::tests::serialize_resources ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::tests::deserialize_windows_optional_fields ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::resources::tests::deserialize_resources_optional_fields ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::tests::deserialize_windows ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::vm::tests::deserialize_vm_optional_fields ... ok
Nov 17 16:35:26.254 INFO [stdout] test config::windows::tests::serialize_windows ... ok
Nov 17 16:35:26.254 INFO [stdout] 
Nov 17 16:35:26.254 INFO [stdout] test result: ok. 129 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 16:35:26.254 INFO [stdout] 
Nov 17 16:35:26.254 INFO [stdout] 
Nov 17 16:35:26.254 INFO [stdout] running 0 tests
Nov 17 16:35:26.254 INFO [stdout] 
Nov 17 16:35:26.254 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 16:35:26.254 INFO [stdout] 
Nov 17 16:35:26.254 INFO [stderr]      Running /target/debug/deps/prefab_init-d06423e21f518e99
Nov 17 16:35:26.263 INFO [stderr] su: No module specific data is present
Nov 17 16:35:26.693 INFO running `"docker" "inspect" "0099333e917bd35fe0a56815963df171d6a0b34378509da003f9ae9a12d0bdfe"`
Nov 17 16:35:26.839 INFO running `"docker" "rm" "-f" "0099333e917bd35fe0a56815963df171d6a0b34378509da003f9ae9a12d0bdfe"`
Nov 17 16:35:26.983 INFO [stdout] 0099333e917bd35fe0a56815963df171d6a0b34378509da003f9ae9a12d0bdfe