Nov 18 03:27:32.835 INFO testing portus-0.3.3 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 03:27:32.835 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 03:27:32.967 INFO [stdout] 2dc7f2837941c940dd021be75adbea4e039d68d81ae6dc641b477a687c7abcda
Nov 18 03:27:32.971 INFO running `"docker" "start" "-a" "2dc7f2837941c940dd021be75adbea4e039d68d81ae6dc641b477a687c7abcda"`
Nov 18 03:27:33.407 INFO [stderr] usermod: no changes
Nov 18 03:27:33.536 INFO [stderr]    Compiling nix v0.9.0
Nov 18 03:27:33.536 INFO [stderr]    Compiling syn v0.13.11
Nov 18 03:27:54.373 INFO [stderr]    Compiling portus v0.3.3 (/source)
Nov 18 03:28:14.879 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 41.44s
Nov 18 03:28:14.887 INFO [stderr] su: No module specific data is present
Nov 18 03:28:15.135 INFO running `"docker" "inspect" "2dc7f2837941c940dd021be75adbea4e039d68d81ae6dc641b477a687c7abcda"`
Nov 18 03:28:15.191 INFO running `"docker" "rm" "-f" "2dc7f2837941c940dd021be75adbea4e039d68d81ae6dc641b477a687c7abcda"`
Nov 18 03:28:15.302 INFO [stdout] 2dc7f2837941c940dd021be75adbea4e039d68d81ae6dc641b477a687c7abcda
Nov 18 03:28:15.303 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 03:28:15.490 INFO [stdout] 6283e7d99e24a3f0b12c59c6d1946637763d79cfb192f5455d72031d68eb6890
Nov 18 03:28:15.498 INFO running `"docker" "start" "-a" "6283e7d99e24a3f0b12c59c6d1946637763d79cfb192f5455d72031d68eb6890"`
Nov 18 03:28:16.547 INFO [stderr] usermod: no changes
Nov 18 03:28:16.744 INFO [stderr]    Compiling portus v0.3.3 (/source)
Nov 18 03:28:29.044 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.44s
Nov 18 03:28:29.055 INFO [stderr] su: No module specific data is present
Nov 18 03:28:29.320 INFO running `"docker" "inspect" "6283e7d99e24a3f0b12c59c6d1946637763d79cfb192f5455d72031d68eb6890"`
Nov 18 03:28:29.408 INFO running `"docker" "rm" "-f" "6283e7d99e24a3f0b12c59c6d1946637763d79cfb192f5455d72031d68eb6890"`
Nov 18 03:28:29.507 INFO [stdout] 6283e7d99e24a3f0b12c59c6d1946637763d79cfb192f5455d72031d68eb6890
Nov 18 03:28:29.509 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 03:28:29.684 INFO [stdout] bc221d09321c51f4a729e18ca7864439725d6f367ac9dc48c1f19e76909f1c04
Nov 18 03:28:29.688 INFO running `"docker" "start" "-a" "bc221d09321c51f4a729e18ca7864439725d6f367ac9dc48c1f19e76909f1c04"`
Nov 18 03:28:30.056 INFO [stderr] usermod: no changes
Nov 18 03:28:30.139 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Nov 18 03:28:30.161 INFO [stderr]      Running /target/debug/deps/portus-14a5821c2d27c11f
Nov 18 03:28:30.163 INFO [stdout] 
Nov 18 03:28:30.163 INFO [stdout] running 68 tests
Nov 18 03:28:30.167 INFO [stdout] test lang::ast::tests::atom_0 ... ok
Nov 18 03:28:30.167 INFO [stdout] test lang::ast::tests::atom_1 ... ok
Nov 18 03:28:30.167 INFO [stdout] test lang::ast::tests::atom_2 ... ok
Nov 18 03:28:30.169 INFO [stdout] test ipc::chan::tests::basic ... ok
Nov 18 03:28:30.169 INFO [stdout] test ipc::test::test_unix ... ok
Nov 18 03:28:30.169 INFO [stdout] test ipc::test::test_chan ... ok
Nov 18 03:28:30.169 INFO [stdout] test lang::ast::tests::atom_3 ... ok
Nov 18 03:28:30.169 INFO [stdout] test lang::ast::tests::atom_4 ... ok
Nov 18 03:28:30.172 INFO [stdout] test lang::ast::tests::atom_5 ... ok
Nov 18 03:28:30.174 INFO [stdout] test lang::ast::tests::atom_8 ... ok
Nov 18 03:28:30.174 INFO [stdout] test lang::ast::tests::atom_6 ... ok
Nov 18 03:28:30.174 INFO [stdout] test lang::ast::tests::bool_ops ... ok
Nov 18 03:28:30.174 INFO [stdout] test lang::ast::tests::expr_leftover ... ok
Nov 18 03:28:30.185 INFO [stdout] test lang::ast::tests::commands ... ok
Nov 18 03:28:30.185 INFO [stdout] test lang::ast::tests::atom_7 ... ok
Nov 18 03:28:30.185 INFO [stdout] test lang::ast::tests::whitespace ... ok
Nov 18 03:28:30.186 INFO [stdout] test lang::ast::tests::tree ... ok
Nov 18 03:28:30.186 INFO [stdout] test lang::ast::tests::simple_exprs ... ok
Nov 18 03:28:30.186 INFO [stdout] test lang::ast::tests::comments ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::datapath::tests::control_if_definition ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::datapath::tests::control_def ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::datapath::tests::bool_ops ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::datapath::tests::intermediate ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::datapath::tests::commands ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::ast::tests::maxtest ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::datapath::tests::ewma ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::datapath::tests::prog_reset_tmps ... ok
Nov 18 03:28:30.189 INFO [stdout] test lang::ast::tests::old_syntax ... ok
Nov 18 03:28:30.192 INFO [stdout] test lang::datapath::tests::reg ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::prog::tests::def_infinity ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::datapath::tests::infinity_if ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::prog::tests::defs ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::prog::tests::event ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::datapath::tests::underscored_var ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::datapath::tests::primitives ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::datapath::tests::multiple_events ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::serialize::tests::do_ser_def_max_imm ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::serialize::tests::do_ser ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::tests::bench_2_line ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::prog::tests::reserved_names ... ok
Nov 18 03:28:30.196 INFO [stdout] test lang::serialize::tests::do_ser_max_imm ... ok
Nov 18 03:28:30.198 INFO [stdout] test lang::prog::tests::events ... ok
Nov 18 03:28:30.198 INFO [stdout] test lang::prog::tests::simple_event ... ok
Nov 18 03:28:30.198 INFO [stdout] test lang::tests::bench_if ... ok
Nov 18 03:28:30.198 INFO [stdout] test lang::tests::bench_1_line_compileonly ... ok
Nov 18 03:28:30.198 INFO [stdout] test lang::tests::bench_3_line ... ok
Nov 18 03:28:30.198 INFO [stdout] test lang::prog::tests::combined ... ok
Nov 18 03:28:30.198 INFO [stdout] test lang::tests::bench_1_line ... ok
Nov 18 03:28:30.199 INFO [stdout] test lang::tests::bench_ewma ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::create::tests::bench_flip_create ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::changeprog::tests::serialize_changeprog_msg ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::measure::tests::test_measure_2 ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_from_u64 ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_from_u32 ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_multi_msg ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_other_msg ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_to_u16 ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_from_u16 ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_to_u32 ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_to_u64_0 ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::tests::test_to_u64_1 ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::update_field::tests::serialize_update_msg ... ok
Nov 18 03:28:30.199 INFO [stdout] test test::bench_ser_over_ipc ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::measure::tests::test_measure_3 ... ok
Nov 18 03:28:30.199 INFO [stdout] test test::test_ser_over_ipc ... ok
Nov 18 03:28:30.199 INFO [stdout] test serialize::create::tests::test_create_1 ... ok
Nov 18 03:28:30.200 INFO [stdout] test serialize::install::tests::serialize_install_msg ... ok
Nov 18 03:28:30.200 INFO [stdout] test serialize::measure::tests::test_measure_1 ... ok
Nov 18 03:28:30.200 INFO [stdout] 
Nov 18 03:28:30.200 INFO [stdout] test result: ok. 68 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:28:30.200 INFO [stdout] 
Nov 18 03:28:30.202 INFO [stderr]      Running /target/debug/deps/cargo_compile_fast_path-630ba8f874bece74
Nov 18 03:28:30.210 INFO [stderr]      Running /target/debug/deps/dump_fold-71cc4562122161ed
Nov 18 03:28:30.210 INFO [stdout] 
Nov 18 03:28:30.210 INFO [stdout] running 0 tests
Nov 18 03:28:30.210 INFO [stdout] 
Nov 18 03:28:30.210 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:28:30.210 INFO [stdout] 
Nov 18 03:28:30.213 INFO [stdout] 
Nov 18 03:28:30.213 INFO [stdout] running 0 tests
Nov 18 03:28:30.213 INFO [stdout] 
Nov 18 03:28:30.213 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:28:30.213 INFO [stdout] 
Nov 18 03:28:30.213 INFO [stderr]      Running /target/debug/deps/ipc_latency-fef9463da9af9ebe
Nov 18 03:28:30.216 INFO [stdout] 
Nov 18 03:28:30.216 INFO [stdout] running 0 tests
Nov 18 03:28:30.216 INFO [stdout] 
Nov 18 03:28:30.216 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:28:30.216 INFO [stdout] 
Nov 18 03:28:30.227 INFO [stderr]      Running /target/debug/deps/kptest-14632a7055d2d737
Nov 18 03:28:30.231 INFO [stderr]      Running /target/debug/deps/nltest-21e1c79303915d26
Nov 18 03:28:30.231 INFO [stdout] 
Nov 18 03:28:30.231 INFO [stdout] running 0 tests
Nov 18 03:28:30.231 INFO [stdout] 
Nov 18 03:28:30.231 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:28:30.231 INFO [stdout] 
Nov 18 03:28:30.232 INFO [stdout] 
Nov 18 03:28:30.232 INFO [stdout] running 0 tests
Nov 18 03:28:30.232 INFO [stdout] 
Nov 18 03:28:30.232 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:28:30.232 INFO [stdout] 
Nov 18 03:28:30.232 INFO [stderr]    Doc-tests portus
Nov 18 03:28:33.586 INFO [stdout] 
Nov 18 03:28:33.587 INFO [stdout] running 3 tests
Nov 18 03:28:34.759 INFO [stdout] test src/lib.rs - CongAlg::init_programs (line 307) ... ok
Nov 18 03:28:38.152 INFO [stdout] test src/lib.rs -  (line 19) ... ok
Nov 18 03:28:38.783 INFO [stdout] test src/lang/mod.rs - lang (line 60) ... ok
Nov 18 03:28:38.783 INFO [stdout] 
Nov 18 03:28:38.783 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:28:38.783 INFO [stdout] 
Nov 18 03:28:38.801 INFO [stderr] su: No module specific data is present
Nov 18 03:28:39.184 INFO running `"docker" "inspect" "bc221d09321c51f4a729e18ca7864439725d6f367ac9dc48c1f19e76909f1c04"`
Nov 18 03:28:39.303 INFO running `"docker" "rm" "-f" "bc221d09321c51f4a729e18ca7864439725d6f367ac9dc48c1f19e76909f1c04"`
Nov 18 03:28:39.433 INFO [stdout] bc221d09321c51f4a729e18ca7864439725d6f367ac9dc48c1f19e76909f1c04