Dec 01 00:37:10.054 INFO testing sux2mfgj/nslfmt against 1.30.1 for beta-1.31-5
Dec 01 00:37:10.054 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 00:37:10.459 INFO [stdout] d2089cc6932078e35c3224d0196d79dc9a2ace83c8408c21e7a38b11c62906e5
Dec 01 00:37:10.461 INFO running `"docker" "start" "-a" "d2089cc6932078e35c3224d0196d79dc9a2ace83c8408c21e7a38b11c62906e5"`
Dec 01 00:37:11.603 INFO [stderr] usermod: no changes
Dec 01 00:37:11.667 INFO [stderr]    Compiling nslfmt v0.0.1 (/source)
Dec 01 00:37:13.542 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 01 00:37:13.542 INFO [stderr]    --> src/lexer.rs:423:21
Dec 01 00:37:13.542 INFO [stderr]     |
Dec 01 00:37:13.542 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 01 00:37:13.542 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 01 00:37:13.543 INFO [stderr]     |
Dec 01 00:37:13.543 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 01 00:37:13.543 INFO [stderr] 
Dec 01 00:37:13.747 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 01 00:37:13.747 INFO [stderr]  --> src/parser.rs:7:5
Dec 01 00:37:13.747 INFO [stderr]   |
Dec 01 00:37:13.747 INFO [stderr] 7 |     number_of_nest: usize,
Dec 01 00:37:13.747 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 01 00:37:13.747 INFO [stderr]   |
Dec 01 00:37:13.747 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 01 00:37:13.747 INFO [stderr] 
Dec 01 00:37:16.155 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 01 00:37:16.155 INFO [stderr]    --> src/lexer.rs:423:21
Dec 01 00:37:16.155 INFO [stderr]     |
Dec 01 00:37:16.155 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 01 00:37:16.155 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 01 00:37:16.155 INFO [stderr]     |
Dec 01 00:37:16.155 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 01 00:37:16.155 INFO [stderr] 
Dec 01 00:37:16.335 INFO [stderr] warning: method is never used: `peek`
Dec 01 00:37:16.335 INFO [stderr]   --> src/lexer.rs:38:5
Dec 01 00:37:16.336 INFO [stderr]    |
Dec 01 00:37:16.336 INFO [stderr] 38 |     pub fn peek(&mut self, is_pass_nl: bool) -> Option<&Token>
Dec 01 00:37:16.336 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 01 00:37:16.336 INFO [stderr]    |
Dec 01 00:37:16.337 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 01 00:37:16.337 INFO [stderr] 
Dec 01 00:37:16.337 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 01 00:37:16.338 INFO [stderr]  --> src/parser.rs:7:5
Dec 01 00:37:16.338 INFO [stderr]   |
Dec 01 00:37:16.338 INFO [stderr] 7 |     number_of_nest: usize,
Dec 01 00:37:16.338 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 01 00:37:16.339 INFO [stderr] 
Dec 01 00:37:18.208 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.57s
Dec 01 00:37:18.211 INFO [stderr] su: No module specific data is present
Dec 01 00:37:19.076 INFO running `"docker" "inspect" "d2089cc6932078e35c3224d0196d79dc9a2ace83c8408c21e7a38b11c62906e5"`
Dec 01 00:37:19.353 INFO running `"docker" "rm" "-f" "d2089cc6932078e35c3224d0196d79dc9a2ace83c8408c21e7a38b11c62906e5"`
Dec 01 00:37:19.616 INFO [stdout] d2089cc6932078e35c3224d0196d79dc9a2ace83c8408c21e7a38b11c62906e5
Dec 01 00:37:19.623 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 00:37:20.227 INFO [stdout] af80b89aff8e2b68548d573d1ceafbae4c107d332128367976abfd6840133376
Dec 01 00:37:20.229 INFO running `"docker" "start" "-a" "af80b89aff8e2b68548d573d1ceafbae4c107d332128367976abfd6840133376"`
Dec 01 00:37:21.393 INFO [stderr] usermod: no changes
Dec 01 00:37:21.447 INFO [stderr]    Compiling nslfmt v0.0.1 (/source)
Dec 01 00:37:22.727 INFO [stderr] warning: static variable `call_count` should have an upper case name such as `CALL_COUNT`
Dec 01 00:37:22.727 INFO [stderr]   --> tests/generator_test.rs:11:1
Dec 01 00:37:22.727 INFO [stderr]    |
Dec 01 00:37:22.727 INFO [stderr] 11 | static call_count: AtomicUsize = AtomicUsize::new(0);
Dec 01 00:37:22.727 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 01 00:37:22.727 INFO [stderr]    |
Dec 01 00:37:22.727 INFO [stderr]    = note: #[warn(non_upper_case_globals)] on by default
Dec 01 00:37:22.727 INFO [stderr] 
Dec 01 00:37:23.807 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 01 00:37:23.807 INFO [stderr]    --> src/lexer.rs:423:21
Dec 01 00:37:23.807 INFO [stderr]     |
Dec 01 00:37:23.807 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 01 00:37:23.807 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 01 00:37:23.807 INFO [stderr]     |
Dec 01 00:37:23.807 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 01 00:37:23.807 INFO [stderr] 
Dec 01 00:37:24.115 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 01 00:37:24.116 INFO [stderr]  --> src/parser.rs:7:5
Dec 01 00:37:24.116 INFO [stderr]   |
Dec 01 00:37:24.116 INFO [stderr] 7 |     number_of_nest: usize,
Dec 01 00:37:24.117 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 01 00:37:24.117 INFO [stderr]   |
Dec 01 00:37:24.117 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 01 00:37:24.117 INFO [stderr] 
Dec 01 00:37:24.367 INFO [stderr] warning: unused variable: `p`
Dec 01 00:37:24.367 INFO [stderr]     --> tests/parser_test.rs:1186:13
Dec 01 00:37:24.367 INFO [stderr]      |
Dec 01 00:37:24.367 INFO [stderr] 1186 |         let p = Parser::new(&mut l);
Dec 01 00:37:24.367 INFO [stderr]      |             ^ help: consider using `_p` instead
Dec 01 00:37:24.367 INFO [stderr]      |
Dec 01 00:37:24.367 INFO [stderr]      = note: #[warn(unused_variables)] on by default
Dec 01 00:37:24.367 INFO [stderr] 
Dec 01 00:37:24.367 INFO [stderr] warning: unused variable: `module`
Dec 01 00:37:24.367 INFO [stderr]     --> tests/parser_test.rs:1206:13
Dec 01 00:37:24.367 INFO [stderr]      |
Dec 01 00:37:24.367 INFO [stderr] 1206 |         let module = create_node!(ASTClass::Module(
Dec 01 00:37:24.367 INFO [stderr]      |             ^^^^^^ help: consider using `_module` instead
Dec 01 00:37:24.367 INFO [stderr] 
Dec 01 00:37:24.367 INFO [stderr] warning: unused variable: `p`
Dec 01 00:37:24.367 INFO [stderr]     --> tests/parser_test.rs:1751:17
Dec 01 00:37:24.367 INFO [stderr]      |
Dec 01 00:37:24.367 INFO [stderr] 1751 |         let mut p = Parser::new(&mut l);
Dec 01 00:37:24.367 INFO [stderr]      |                 ^ help: consider using `_p` instead
Dec 01 00:37:24.367 INFO [stderr] 
Dec 01 00:37:24.523 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 01 00:37:24.523 INFO [stderr]    --> src/lexer.rs:423:21
Dec 01 00:37:24.523 INFO [stderr]     |
Dec 01 00:37:24.523 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 01 00:37:24.523 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 01 00:37:24.523 INFO [stderr]     |
Dec 01 00:37:24.523 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 01 00:37:24.523 INFO [stderr] 
Dec 01 00:37:24.907 INFO [stderr] warning: variable does not need to be mutable
Dec 01 00:37:24.907 INFO [stderr]     --> tests/parser_test.rs:1751:13
Dec 01 00:37:24.907 INFO [stderr]      |
Dec 01 00:37:24.907 INFO [stderr] 1751 |         let mut p = Parser::new(&mut l);
Dec 01 00:37:24.907 INFO [stderr]      |             ----^
Dec 01 00:37:24.907 INFO [stderr]      |             |
Dec 01 00:37:24.907 INFO [stderr]      |             help: remove this `mut`
Dec 01 00:37:24.907 INFO [stderr]      |
Dec 01 00:37:24.907 INFO [stderr]      = note: #[warn(unused_mut)] on by default
Dec 01 00:37:24.907 INFO [stderr] 
Dec 01 00:37:25.126 INFO [stderr] warning: method is never used: `peek`
Dec 01 00:37:25.127 INFO [stderr]   --> src/lexer.rs:38:5
Dec 01 00:37:25.127 INFO [stderr]    |
Dec 01 00:37:25.128 INFO [stderr] 38 |     pub fn peek(&mut self, is_pass_nl: bool) -> Option<&Token>
Dec 01 00:37:25.128 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 01 00:37:25.129 INFO [stderr]    |
Dec 01 00:37:25.129 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 01 00:37:25.130 INFO [stderr] 
Dec 01 00:37:25.130 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 01 00:37:25.131 INFO [stderr]  --> src/parser.rs:7:5
Dec 01 00:37:25.131 INFO [stderr]   |
Dec 01 00:37:25.132 INFO [stderr] 7 |     number_of_nest: usize,
Dec 01 00:37:25.132 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 01 00:37:25.133 INFO [stderr] 
Dec 01 00:37:29.667 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.24s
Dec 01 00:37:29.687 INFO [stderr] su: No module specific data is present
Dec 01 00:37:30.435 INFO running `"docker" "inspect" "af80b89aff8e2b68548d573d1ceafbae4c107d332128367976abfd6840133376"`
Dec 01 00:37:30.877 INFO running `"docker" "rm" "-f" "af80b89aff8e2b68548d573d1ceafbae4c107d332128367976abfd6840133376"`
Dec 01 00:37:31.187 INFO [stdout] af80b89aff8e2b68548d573d1ceafbae4c107d332128367976abfd6840133376
Dec 01 00:37:31.201 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 00:37:31.687 INFO [stdout] 3cbe61541b78ae4c0edeab39540967c28bb66782d180dd4554730083342ac02e
Dec 01 00:37:31.687 INFO running `"docker" "start" "-a" "3cbe61541b78ae4c0edeab39540967c28bb66782d180dd4554730083342ac02e"`
Dec 01 00:37:33.014 INFO [stderr] usermod: no changes
Dec 01 00:37:33.067 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 01 00:37:33.083 INFO [stderr]      Running /target/debug/deps/nslfmt-3a6f3d5189bfe188
Dec 01 00:37:33.087 INFO [stderr]      Running /target/debug/deps/nslfmt-b1957847865f63c9
Dec 01 00:37:33.087 INFO [stdout] 
Dec 01 00:37:33.087 INFO [stdout] running 0 tests
Dec 01 00:37:33.087 INFO [stdout] 
Dec 01 00:37:33.087 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:37:33.087 INFO [stdout] 
Dec 01 00:37:33.091 INFO [stdout] 
Dec 01 00:37:33.091 INFO [stderr]      Running /target/debug/deps/generator_test-0532145b71ff56fa
Dec 01 00:37:33.091 INFO [stdout] running 0 tests
Dec 01 00:37:33.091 INFO [stdout] 
Dec 01 00:37:33.091 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:37:33.091 INFO [stdout] 
Dec 01 00:37:33.091 INFO [stdout] 
Dec 01 00:37:33.091 INFO [stdout] running 20 tests
Dec 01 00:37:33.108 INFO [stdout] test assign_wire_00 ... ok
Dec 01 00:37:33.115 INFO [stdout] test any_00 ... ok
Dec 01 00:37:33.115 INFO [stdout] test aware_indent_02 ... ok
Dec 01 00:37:33.115 INFO [stdout] test comment_00 ... ok
Dec 01 00:37:33.115 INFO [stdout] test comment_01 ... ok
Dec 01 00:37:33.120 INFO [stdout] test define_path ... ok
Dec 01 00:37:33.120 INFO [stdout] test aware_indent_01 ... ok
Dec 01 00:37:33.120 INFO [stdout] test func_call_00 ... ok
Dec 01 00:37:33.120 INFO [stdout] test aware_indent_03 ... ok
Dec 01 00:37:33.120 INFO [stdout] test func_self_00 ... ok
Dec 01 00:37:33.120 INFO [stdout] test new_by_file ... ok
Dec 01 00:37:33.120 INFO [stdout] test func_00 ... ok
Dec 01 00:37:33.120 INFO [stdout] test return_00 ... ok
Dec 01 00:37:33.120 INFO [stdout] test reg_00 ... ok
Dec 01 00:37:33.120 INFO [stdout] test wire_01 ... ok
Dec 01 00:37:33.123 INFO [stdout] test wire_00 ... ok
Dec 01 00:37:33.123 INFO [stdout] test two_arguments ... ok
Dec 01 00:37:33.135 INFO [stdout] test output_declare_to_file ... ok
Dec 01 00:37:33.135 INFO [stderr]      Running /target/debug/deps/lexer_test-7130001028371fa5
Dec 01 00:37:33.135 INFO [stdout] test parences ... ok
Dec 01 00:37:33.136 INFO [stdout] test new_by_stdout ... ok
Dec 01 00:37:33.136 INFO [stdout] 
Dec 01 00:37:33.136 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:37:33.136 INFO [stdout] 
Dec 01 00:37:33.136 INFO [stdout] 
Dec 01 00:37:33.136 INFO [stdout] running 52 tests
Dec 01 00:37:33.143 INFO [stdout] test declare_func_in ... ok
Dec 01 00:37:33.143 INFO [stdout] test comment_00 ... ok
Dec 01 00:37:33.143 INFO [stdout] test braces_and_newline ... ok
Dec 01 00:37:33.143 INFO [stdout] test declare_func_out ... ok
Dec 01 00:37:33.144 INFO [stdout] test any_else_00 ... ok
Dec 01 00:37:33.144 INFO [stdout] test define_path ... ok
Dec 01 00:37:33.144 INFO [stdout] test func_block_00 ... ok
Dec 01 00:37:33.144 INFO [stdout] test any_block_00 ... ok
Dec 01 00:37:33.144 INFO [stdout] test func_block_return ... ok
Dec 01 00:37:33.144 INFO [stdout] test create_instance_with_file ... ok
Dec 01 00:37:33.144 INFO [stdout] test create_instance_with_string ... ok
Dec 01 00:37:33.145 INFO [stdout] test func_self_00 ... ok
Dec 01 00:37:33.145 INFO [stdout] test get_token_eop ... ok
Dec 01 00:37:33.152 INFO [stdout] test get_token_file ... ok
Dec 01 00:37:33.152 INFO [stderr]      Running /target/debug/deps/parser_test-75762384c0202dcc
Dec 01 00:37:33.152 INFO [stdout] test declare_with_input ... ok
Dec 01 00:37:33.153 INFO [stdout] test declare_04 ... ok
Dec 01 00:37:33.153 INFO [stdout] test macro_else ... ok
Dec 01 00:37:33.153 INFO [stdout] test get_token_new_line ... ok
Dec 01 00:37:33.153 INFO [stdout] test macro_define ... ok
Dec 01 00:37:33.154 INFO [stdout] test get_token_str ... ok
Dec 01 00:37:33.154 INFO [stdout] test gt_lt_00 ... ok
Dec 01 00:37:33.154 INFO [stdout] test macro_include ... ok
Dec 01 00:37:33.155 INFO [stdout] test macro_endif ... ok
Dec 01 00:37:33.156 INFO [stdout] test macro_ifdef ... ok
Dec 01 00:37:33.157 INFO [stdout] test macro_ifndef ... ok
Dec 01 00:37:33.157 INFO [stdout] test module_wire_01 ... ok
Dec 01 00:37:33.157 INFO [stdout] test mutiline_comment_02 ... ok
Dec 01 00:37:33.158 INFO [stdout] test mutiline_comment_01 ... ok
Dec 01 00:37:33.158 INFO [stdout] test mutiline_comment_00 ... ok
Dec 01 00:37:33.158 INFO [stdout] test mutiline_comment_03 ... ok
Dec 01 00:37:33.159 INFO [stdout] test newline_in_declare_block ... ok
Dec 01 00:37:33.159 INFO [stdout] test next_nl ... ok
Dec 01 00:37:33.159 INFO [stdout] test number ... ok
Dec 01 00:37:33.160 INFO [stdout] test number_00 ... ok
Dec 01 00:37:33.160 INFO [stdout] test number_01 ... ok
Dec 01 00:37:33.160 INFO [stdout] test number_02 ... ok
Dec 01 00:37:33.161 INFO [stdout] test number_03 ... ok
Dec 01 00:37:33.161 INFO [stdout] test or_00 ... ok
Dec 01 00:37:33.161 INFO [stdout] test pass_00 ... ok
Dec 01 00:37:33.161 INFO [stdout] test pass_newlines ... ok
Dec 01 00:37:33.162 INFO [stdout] test peek_00 ... ok
Dec 01 00:37:33.162 INFO [stdout] test plus_00 ... ok
Dec 01 00:37:33.162 INFO [stdout] test macro_undef ... ok
Dec 01 00:37:33.162 INFO [stdout] test proc_00 ... ok
Dec 01 00:37:33.163 INFO [stdout] test reg_00 ... ok
Dec 01 00:37:33.164 INFO [stdout] test reg_assignment_00 ... ok
Dec 01 00:37:33.164 INFO [stdout] test wire_assign_00 ... ok
Dec 01 00:37:33.165 INFO [stdout] test state_name_00 ... ok
Dec 01 00:37:33.165 INFO [stdout] test state_00 ... ok
Dec 01 00:37:33.165 INFO [stdout] test module_wire_00 ... ok
Dec 01 00:37:33.166 INFO [stdout] test module_00 ... ok
Dec 01 00:37:33.166 INFO [stdout] test mem_00 ... ok
Dec 01 00:37:33.167 INFO [stdout] 
Dec 01 00:37:33.167 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:37:33.167 INFO [stdout] 
Dec 01 00:37:33.168 INFO [stdout] 
Dec 01 00:37:33.168 INFO [stdout] running 77 tests
Dec 01 00:37:33.168 INFO [stdout] test declare::declare_03 ... ok
Dec 01 00:37:33.168 INFO [stdout] test declare::expression_in_width_block_00 ... ok
Dec 01 00:37:33.169 INFO [stdout] test declare::declare_only ... ok
Dec 01 00:37:33.169 INFO [stdout] test comment::multi_line_comment ... ok
Dec 01 00:37:33.169 INFO [stdout] test declare::macro_in_declare_00 ... ok
Dec 01 00:37:33.169 INFO [stdout] test declare::func_out_return ... ok
Dec 01 00:37:33.170 INFO [stdout] test declare::func_in_return ... ok
Dec 01 00:37:33.170 INFO [stdout] test declare::func_in ... ok
Dec 01 00:37:33.170 INFO [stdout] test declare::newline_in_declare_block ... ok
Dec 01 00:37:33.170 INFO [stdout] test declare::expression_in_width_block_02 ... ok
Dec 01 00:37:33.175 INFO [stdout] test declare::expression_in_width_block_01 ... ok
Dec 01 00:37:33.175 INFO [stdout] test declare::macro_in_declare_01 ... ok
Dec 01 00:37:33.175 INFO [stdout] test macros::define_macro_nl ... ok
Dec 01 00:37:33.176 INFO [stdout] test declare::multi_bit_input ... ok
Dec 01 00:37:33.176 INFO [stdout] test macros::if_else_end ... ok
Dec 01 00:37:33.176 INFO [stdout] test macros::define_macro2 ... ok
Dec 01 00:37:33.176 INFO [stdout] test macros::ifndef_macro ... ok
Dec 01 00:37:33.177 INFO [stdout] test macros::include_macro ... ok
Dec 01 00:37:33.177 INFO [stdout] test macros::ifdef_macro ... ok
Dec 01 00:37:33.177 INFO [stdout] test module::any_00 ... ok
Dec 01 00:37:33.177 INFO [stdout] test macros::undef_macro ... ok
Dec 01 00:37:33.178 INFO [stdout] test module::any_01 ... ok
Dec 01 00:37:33.178 INFO [stdout] test module::any_02 ... ok
Dec 01 00:37:33.178 INFO [stdout] test macros::define_macro_eof ... ok
Dec 01 00:37:33.179 INFO [stdout] test macros::define_macro3 ... ok
Dec 01 00:37:33.179 INFO [stdout] test declare::output_inout ... ok
Dec 01 00:37:33.179 INFO [stdout] test declare::one_bit_input ... ok
Dec 01 00:37:33.180 INFO [stdout] test module::any_else_00 ... ok
Dec 01 00:37:33.180 INFO [stdout] test macros::endif_macro ... ok
Dec 01 00:37:33.180 INFO [stdout] test module::func_call_00 ... ok
Dec 01 00:37:33.180 INFO [stdout] test module::func_self_03 ... ok
Dec 01 00:37:33.180 INFO [stdout] test module::func_self_02 ... ok
Dec 01 00:37:33.181 INFO [stdout] test module::function_call_00 ... ok
Dec 01 00:37:33.181 INFO [stdout] test module::func_in_module_01 ... ok
Dec 01 00:37:33.181 INFO [stdout] test module::function_call_01 ... ok
Dec 01 00:37:33.182 INFO [stdout] test module::func_self_00 ... ok
Dec 01 00:37:33.182 INFO [stdout] test module::if_01 ... ok
Dec 01 00:37:33.182 INFO [stdout] test module::func_self_01 ... ok
Dec 01 00:37:33.182 INFO [stdout] test module::func_in_module_00 ... ok
Dec 01 00:37:33.186 INFO [stdout] test module::func_in_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::if_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::if_02 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::mem_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::mem_04 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::module_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::proc_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::proc_01 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_02 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_03 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_04 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_05 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_06 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_assign_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_func_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::reg_func_01 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::return_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::state_name_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::state_name_01 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::state_procedure_00 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::state_procedure_01 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::state_procedure_02 ... ok
Dec 01 00:37:33.187 INFO [stdout] test module::mem_03 ... ok
Dec 01 00:37:33.190 INFO [stdout] test module::wire_01 ... ok
Dec 01 00:37:33.191 INFO [stdout] test module::wire_02 ... ok
Dec 01 00:37:33.203 INFO [stdout] test module::wire_04 ... ok
Dec 01 00:37:33.203 INFO [stdout] test module::wire_03 ... ok
Dec 01 00:37:33.203 INFO [stdout] test module::mem_01 ... ok
Dec 01 00:37:33.203 INFO [stdout] test module::mem_02 ... ok
Dec 01 00:37:33.203 INFO [stdout] test module::reg_01 ... ok
Dec 01 00:37:33.206 INFO [stdout] test module::wire_assign_00 ... ok
Dec 01 00:37:33.219 INFO [stdout] test module::wire_assign_02 ... ok
Dec 01 00:37:33.219 INFO [stdout] test module::wire_05 ... ok
Dec 01 00:37:33.219 INFO [stdout] test module::wire_assign_01 ... ok
Dec 01 00:37:33.219 INFO [stdout] test simple_tests::end_of_program ... ok
Dec 01 00:37:33.219 INFO [stdout] test module::wire_assign_03 ... ok
Dec 01 00:37:33.283 INFO [stdout] test module::if_03 ... FAILED
Dec 01 00:37:33.283 INFO [stdout] 
Dec 01 00:37:33.283 INFO [stdout] failures:
Dec 01 00:37:33.283 INFO [stdout] 
Dec 01 00:37:33.283 INFO [stdout] ---- module::if_03 stdout ----
Dec 01 00:37:33.283 INFO [stdout] thread 'module::if_03' panicked at 'explicit panic', tests/parser_test.rs:1752:9
Dec 01 00:37:33.283 INFO [stdout] stack backtrace:
Dec 01 00:37:33.283 INFO [stdout]    0:     0x55814f12c35e - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h15749a98198ba25f
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 01 00:37:33.283 INFO [stdout]    1:     0x55814f11f6b6 - std::sys_common::backtrace::print::h0ba65c811294dbf0
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Dec 01 00:37:33.283 INFO [stdout]    2:     0x55814f11dadd - std::panicking::default_hook::{{closure}}::h42bb31757f0fee64
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panicking.rs:211
Dec 01 00:37:33.283 INFO [stdout]    3:     0x55814f11d7eb - std::panicking::default_hook::hebc8848d7aa7dbd9
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panicking.rs:221
Dec 01 00:37:33.283 INFO [stdout]    4:     0x55814f11e18c - std::panicking::rust_panic_with_hook::h86e619a638415243
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panicking.rs:477
Dec 01 00:37:33.283 INFO [stdout]    5:     0x55814f0f930f - std::panicking::begin_panic::had517984e7e02c94
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panicking.rs:411
Dec 01 00:37:33.283 INFO [stdout]    6:     0x55814f08db83 - parser_test::module::if_03::h3793ae82563c32d9
Dec 01 00:37:33.283 INFO [stdout]                                at tests/parser_test.rs:1752
Dec 01 00:37:33.283 INFO [stdout]    7:     0x55814f08daa9 - parser_test::module::if_03::{{closure}}::h355bf011d3aca03c
Dec 01 00:37:33.283 INFO [stdout]                                at tests/parser_test.rs:1748
Dec 01 00:37:33.283 INFO [stdout]    8:     0x55814f0998ad - core::ops::function::FnOnce::call_once::h4f9e28c6c6755145
Dec 01 00:37:33.283 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 01 00:37:33.283 INFO [stdout]    9:     0x55814f0a965e - <F as alloc::boxed::FnBox<A>>::call_box::hbea525814fa423cc
Dec 01 00:37:33.283 INFO [stdout]                                at libtest/lib.rs:1461
Dec 01 00:37:33.283 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 01 00:37:33.283 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 01 00:37:33.283 INFO [stdout]   10:     0x55814f13b1c9 - __rust_maybe_catch_panic
Dec 01 00:37:33.283 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 01 00:37:33.283 INFO [stdout]   11:     0x55814f0b4fbd - std::sys_common::backtrace::__rust_begin_short_backtrace::h0ff507d7422944d3
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panicking.rs:289
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panic.rs:392
Dec 01 00:37:33.283 INFO [stdout]                                at libtest/lib.rs:1416
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/sys_common/backtrace.rs:136
Dec 01 00:37:33.283 INFO [stdout]   12:     0x55814f0cd5f4 - std::panicking::try::do_call::hba0bdcc3670471cc
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/thread/mod.rs:409
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panic.rs:313
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panicking.rs:310
Dec 01 00:37:33.283 INFO [stdout]   13:     0x55814f13b1c9 - __rust_maybe_catch_panic
Dec 01 00:37:33.283 INFO [stdout]                                at libpanic_unwind/lib.rs:103
Dec 01 00:37:33.283 INFO [stdout]   14:     0x55814f0bdec6 - <F as alloc::boxed::FnBox<A>>::call_box::hdac52587b00591af
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panicking.rs:289
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/panic.rs:392
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/thread/mod.rs:408
Dec 01 00:37:33.283 INFO [stdout]                                at liballoc/boxed.rs:646
Dec 01 00:37:33.283 INFO [stdout]   15:     0x55814f12dc6a - std::sys_common::thread::start_thread::h75d887c7d2cc4479
Dec 01 00:37:33.283 INFO [stdout]                                at liballoc/boxed.rs:656
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Dec 01 00:37:33.283 INFO [stdout]   16:     0x55814f11e8f5 - std::sys::unix::thread::Thread::new::thread_start::h8414caee632bf9ed
Dec 01 00:37:33.283 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Dec 01 00:37:33.283 INFO [stdout]   17:     0x7f2ff51c76b9 - start_thread
Dec 01 00:37:33.283 INFO [stdout]   18:     0x7f2ff4ce741c - clone
Dec 01 00:37:33.283 INFO [stdout]   19:                0x0 - <unknown>
Dec 01 00:37:33.283 INFO [stdout] 
Dec 01 00:37:33.283 INFO [stdout] 
Dec 01 00:37:33.283 INFO [stdout] failures:
Dec 01 00:37:33.283 INFO [stdout]     module::if_03
Dec 01 00:37:33.283 INFO [stdout] 
Dec 01 00:37:33.283 INFO [stdout] test result: FAILED. 76 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:37:33.283 INFO [stdout] 
Dec 01 00:37:33.291 INFO [stderr] error: test failed, to rerun pass '--test parser_test'
Dec 01 00:37:33.293 INFO [stderr] su: No module specific data is present
Dec 01 00:37:33.857 INFO running `"docker" "inspect" "3cbe61541b78ae4c0edeab39540967c28bb66782d180dd4554730083342ac02e"`
Dec 01 00:37:34.131 INFO running `"docker" "rm" "-f" "3cbe61541b78ae4c0edeab39540967c28bb66782d180dd4554730083342ac02e"`
Dec 01 00:37:34.399 INFO [stdout] 3cbe61541b78ae4c0edeab39540967c28bb66782d180dd4554730083342ac02e
