Dec 05 05:42:36.113 INFO testing sux2mfgj/nslfmt against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 05:42:36.113 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 05:42:36.535 INFO [stdout] b1bc382e1b2dd7e2641f1616ecec8d4094ae9bf56897606aeafbb300c03d5b23
Dec 05 05:42:36.537 INFO running `"docker" "start" "-a" "b1bc382e1b2dd7e2641f1616ecec8d4094ae9bf56897606aeafbb300c03d5b23"`
Dec 05 05:42:38.092 INFO [stderr] usermod: no changes
Dec 05 05:42:38.184 INFO [stderr]    Compiling nslfmt v0.0.1 (/source)
Dec 05 05:42:39.824 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 05 05:42:39.824 INFO [stderr]    --> src/lexer.rs:423:21
Dec 05 05:42:39.824 INFO [stderr]     |
Dec 05 05:42:39.824 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 05 05:42:39.824 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 05 05:42:39.824 INFO [stderr]     |
Dec 05 05:42:39.836 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 05 05:42:39.836 INFO [stderr] 
Dec 05 05:42:40.052 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 05 05:42:40.052 INFO [stderr]  --> src/parser.rs:7:5
Dec 05 05:42:40.052 INFO [stderr]   |
Dec 05 05:42:40.052 INFO [stderr] 7 |     number_of_nest: usize,
Dec 05 05:42:40.052 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:40.052 INFO [stderr]   |
Dec 05 05:42:40.052 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 05 05:42:40.052 INFO [stderr] 
Dec 05 05:42:42.540 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 05 05:42:42.540 INFO [stderr]    --> src/lexer.rs:423:21
Dec 05 05:42:42.540 INFO [stderr]     |
Dec 05 05:42:42.541 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 05 05:42:42.541 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 05 05:42:42.541 INFO [stderr]     |
Dec 05 05:42:42.542 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 05 05:42:42.542 INFO [stderr] 
Dec 05 05:42:42.711 INFO [stderr] warning: method is never used: `peek`
Dec 05 05:42:42.711 INFO [stderr]   --> src/lexer.rs:38:5
Dec 05 05:42:42.712 INFO [stderr]    |
Dec 05 05:42:42.712 INFO [stderr] 38 |     pub fn peek(&mut self, is_pass_nl: bool) -> Option<&Token>
Dec 05 05:42:42.712 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:42.712 INFO [stderr]    |
Dec 05 05:42:42.713 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 05 05:42:42.713 INFO [stderr] 
Dec 05 05:42:42.713 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 05 05:42:42.713 INFO [stderr]  --> src/parser.rs:7:5
Dec 05 05:42:42.713 INFO [stderr]   |
Dec 05 05:42:42.713 INFO [stderr] 7 |     number_of_nest: usize,
Dec 05 05:42:42.713 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:42.713 INFO [stderr] 
Dec 05 05:42:45.064 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.95s
Dec 05 05:42:45.067 INFO [stderr] su: No module specific data is present
Dec 05 05:42:46.268 INFO running `"docker" "inspect" "b1bc382e1b2dd7e2641f1616ecec8d4094ae9bf56897606aeafbb300c03d5b23"`
Dec 05 05:42:46.580 INFO running `"docker" "rm" "-f" "b1bc382e1b2dd7e2641f1616ecec8d4094ae9bf56897606aeafbb300c03d5b23"`
Dec 05 05:42:46.916 INFO [stdout] b1bc382e1b2dd7e2641f1616ecec8d4094ae9bf56897606aeafbb300c03d5b23
Dec 05 05:42:46.924 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 05:42:47.333 INFO [stdout] 6c5870d05727714c21c8264dc5a76ef1a5dd66eae6c0d332532dcc94d641b734
Dec 05 05:42:47.335 INFO running `"docker" "start" "-a" "6c5870d05727714c21c8264dc5a76ef1a5dd66eae6c0d332532dcc94d641b734"`
Dec 05 05:42:48.751 INFO [stderr] usermod: no changes
Dec 05 05:42:48.820 INFO [stderr]    Compiling nslfmt v0.0.1 (/source)
Dec 05 05:42:50.348 INFO [stderr] warning: static variable `call_count` should have an upper case name such as `CALL_COUNT`
Dec 05 05:42:50.348 INFO [stderr]   --> tests/generator_test.rs:11:1
Dec 05 05:42:50.348 INFO [stderr]    |
Dec 05 05:42:50.348 INFO [stderr] 11 | static call_count: AtomicUsize = AtomicUsize::new(0);
Dec 05 05:42:50.348 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:50.364 INFO [stderr]    |
Dec 05 05:42:50.364 INFO [stderr]    = note: #[warn(non_upper_case_globals)] on by default
Dec 05 05:42:50.364 INFO [stderr] 
Dec 05 05:42:50.920 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 05 05:42:50.920 INFO [stderr]    --> src/lexer.rs:423:21
Dec 05 05:42:50.920 INFO [stderr]     |
Dec 05 05:42:50.920 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 05 05:42:50.920 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 05 05:42:50.920 INFO [stderr]     |
Dec 05 05:42:50.920 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 05 05:42:50.920 INFO [stderr] 
Dec 05 05:42:50.952 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 05 05:42:50.952 INFO [stderr]    --> src/lexer.rs:423:21
Dec 05 05:42:50.952 INFO [stderr]     |
Dec 05 05:42:50.952 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 05 05:42:50.952 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 05 05:42:50.957 INFO [stderr]     |
Dec 05 05:42:50.957 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 05 05:42:50.957 INFO [stderr] 
Dec 05 05:42:51.468 INFO [stderr] warning: unused variable: `p`
Dec 05 05:42:51.468 INFO [stderr]     --> tests/parser_test.rs:1186:13
Dec 05 05:42:51.468 INFO [stderr]      |
Dec 05 05:42:51.468 INFO [stderr] 1186 |         let p = Parser::new(&mut l);
Dec 05 05:42:51.468 INFO [stderr]      |             ^ help: consider using `_p` instead
Dec 05 05:42:51.468 INFO [stderr]      |
Dec 05 05:42:51.468 INFO [stderr]      = note: #[warn(unused_variables)] on by default
Dec 05 05:42:51.468 INFO [stderr] 
Dec 05 05:42:51.468 INFO [stderr] warning: unused variable: `module`
Dec 05 05:42:51.468 INFO [stderr]     --> tests/parser_test.rs:1206:13
Dec 05 05:42:51.468 INFO [stderr]      |
Dec 05 05:42:51.468 INFO [stderr] 1206 |         let module = create_node!(ASTClass::Module(
Dec 05 05:42:51.468 INFO [stderr]      |             ^^^^^^ help: consider using `_module` instead
Dec 05 05:42:51.488 INFO [stderr] 
Dec 05 05:42:51.488 INFO [stderr] warning: unused variable: `p`
Dec 05 05:42:51.488 INFO [stderr]     --> tests/parser_test.rs:1751:17
Dec 05 05:42:51.488 INFO [stderr]      |
Dec 05 05:42:51.488 INFO [stderr] 1751 |         let mut p = Parser::new(&mut l);
Dec 05 05:42:51.488 INFO [stderr]      |                 ^ help: consider using `_p` instead
Dec 05 05:42:51.496 INFO [stderr] 
Dec 05 05:42:51.884 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 05 05:42:51.884 INFO [stderr]  --> src/parser.rs:7:5
Dec 05 05:42:51.884 INFO [stderr]   |
Dec 05 05:42:51.884 INFO [stderr] 7 |     number_of_nest: usize,
Dec 05 05:42:51.884 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:51.892 INFO [stderr] warning: method is never used: `peek`
Dec 05 05:42:51.892 INFO [stderr]   --> src/lexer.rs:38:5
Dec 05 05:42:51.892 INFO [stderr]    |
Dec 05 05:42:51.892 INFO [stderr] 38 |     pub fn peek(&mut self, is_pass_nl: bool) -> Option<&Token>
Dec 05 05:42:51.892 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:51.892 INFO [stderr]    |
Dec 05 05:42:51.892 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 05 05:42:51.892 INFO [stderr] 
Dec 05 05:42:51.893 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 05 05:42:51.893 INFO [stderr]  --> src/parser.rs:7:5
Dec 05 05:42:51.893 INFO [stderr]   |
Dec 05 05:42:51.893 INFO [stderr] 7 |     number_of_nest: usize,
Dec 05 05:42:51.893 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:51.893 INFO [stderr]   |
Dec 05 05:42:51.896 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 05 05:42:51.896 INFO [stderr] 
Dec 05 05:42:51.908 INFO [stderr] 
Dec 05 05:42:52.092 INFO [stderr] warning: variable does not need to be mutable
Dec 05 05:42:52.092 INFO [stderr]     --> tests/parser_test.rs:1751:13
Dec 05 05:42:52.092 INFO [stderr]      |
Dec 05 05:42:52.092 INFO [stderr] 1751 |         let mut p = Parser::new(&mut l);
Dec 05 05:42:52.092 INFO [stderr]      |             ----^
Dec 05 05:42:52.092 INFO [stderr]      |             |
Dec 05 05:42:52.092 INFO [stderr]      |             help: remove this `mut`
Dec 05 05:42:52.092 INFO [stderr]      |
Dec 05 05:42:52.092 INFO [stderr]      = note: #[warn(unused_mut)] on by default
Dec 05 05:42:52.092 INFO [stderr] 
Dec 05 05:42:56.167 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.38s
Dec 05 05:42:56.176 INFO [stderr] su: No module specific data is present
Dec 05 05:42:57.048 INFO running `"docker" "inspect" "6c5870d05727714c21c8264dc5a76ef1a5dd66eae6c0d332532dcc94d641b734"`
Dec 05 05:42:57.468 INFO running `"docker" "rm" "-f" "6c5870d05727714c21c8264dc5a76ef1a5dd66eae6c0d332532dcc94d641b734"`
Dec 05 05:42:57.724 INFO [stdout] 6c5870d05727714c21c8264dc5a76ef1a5dd66eae6c0d332532dcc94d641b734
Dec 05 05:42:57.726 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 05 05:42:58.325 INFO [stdout] bcfb4eda4b2b603fc918995b3259b531dd89bdec8357a908ee7a89396b4e4db1
Dec 05 05:42:58.328 INFO running `"docker" "start" "-a" "bcfb4eda4b2b603fc918995b3259b531dd89bdec8357a908ee7a89396b4e4db1"`
Dec 05 05:42:59.572 INFO [stderr] usermod: no changes
Dec 05 05:42:59.637 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 05 05:42:59.637 INFO [stdout] 
Dec 05 05:42:59.637 INFO [stderr]      Running /target/debug/deps/nslfmt-5370ebea005dc3a5
Dec 05 05:42:59.637 INFO [stdout] running 0 tests
Dec 05 05:42:59.637 INFO [stderr]      Running /target/debug/deps/nslfmt-d8cff8f1ae054db6
Dec 05 05:42:59.637 INFO [stdout] 
Dec 05 05:42:59.637 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:59.637 INFO [stdout] 
Dec 05 05:42:59.642 INFO [stdout] 
Dec 05 05:42:59.642 INFO [stdout] running 0 tests
Dec 05 05:42:59.642 INFO [stdout] 
Dec 05 05:42:59.642 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:59.642 INFO [stdout] 
Dec 05 05:42:59.645 INFO [stderr]      Running /target/debug/deps/generator_test-5e8a087176c842a2
Dec 05 05:42:59.656 INFO [stdout] 
Dec 05 05:42:59.656 INFO [stdout] running 20 tests
Dec 05 05:42:59.656 INFO [stdout] test aware_indent_02 ... ok
Dec 05 05:42:59.656 INFO [stdout] test aware_indent_01 ... ok
Dec 05 05:42:59.656 INFO [stdout] test assign_wire_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test any_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test define_path ... ok
Dec 05 05:42:59.656 INFO [stdout] test comment_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test comment_01 ... ok
Dec 05 05:42:59.656 INFO [stdout] test func_self_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test aware_indent_03 ... ok
Dec 05 05:42:59.656 INFO [stdout] test func_call_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test new_by_stdout ... ok
Dec 05 05:42:59.656 INFO [stdout] test new_by_file ... ok
Dec 05 05:42:59.656 INFO [stdout] test parences ... ok
Dec 05 05:42:59.656 INFO [stdout] test output_declare_to_file ... ok
Dec 05 05:42:59.656 INFO [stdout] test func_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test reg_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test return_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test two_arguments ... ok
Dec 05 05:42:59.656 INFO [stdout] test wire_00 ... ok
Dec 05 05:42:59.656 INFO [stdout] test wire_01 ... ok
Dec 05 05:42:59.656 INFO [stdout] 
Dec 05 05:42:59.656 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:59.656 INFO [stdout] 
Dec 05 05:42:59.656 INFO [stderr]      Running /target/debug/deps/lexer_test-4c78c075f13e90c7
Dec 05 05:42:59.664 INFO [stdout] 
Dec 05 05:42:59.664 INFO [stdout] running 52 tests
Dec 05 05:42:59.664 INFO [stdout] test create_instance_with_file ... ok
Dec 05 05:42:59.664 INFO [stdout] test comment_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test braces_and_newline ... ok
Dec 05 05:42:59.664 INFO [stdout] test any_else_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test declare_func_out ... ok
Dec 05 05:42:59.664 INFO [stdout] test any_block_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test declare_with_input ... ok
Dec 05 05:42:59.664 INFO [stdout] test define_path ... ok
Dec 05 05:42:59.664 INFO [stdout] test func_block_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test func_block_return ... ok
Dec 05 05:42:59.664 INFO [stdout] test func_self_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test get_token_eop ... ok
Dec 05 05:42:59.664 INFO [stdout] test get_token_file ... ok
Dec 05 05:42:59.664 INFO [stdout] test get_token_new_line ... ok
Dec 05 05:42:59.664 INFO [stdout] test get_token_str ... ok
Dec 05 05:42:59.664 INFO [stdout] test gt_lt_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test macro_define ... ok
Dec 05 05:42:59.664 INFO [stdout] test macro_else ... ok
Dec 05 05:42:59.664 INFO [stdout] test macro_endif ... ok
Dec 05 05:42:59.664 INFO [stdout] test macro_ifdef ... ok
Dec 05 05:42:59.664 INFO [stdout] test macro_ifndef ... ok
Dec 05 05:42:59.664 INFO [stdout] test macro_include ... ok
Dec 05 05:42:59.664 INFO [stdout] test macro_undef ... ok
Dec 05 05:42:59.664 INFO [stdout] test mutiline_comment_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test module_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test module_wire_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test mem_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test module_wire_01 ... ok
Dec 05 05:42:59.664 INFO [stdout] test create_instance_with_string ... ok
Dec 05 05:42:59.664 INFO [stdout] test declare_04 ... ok
Dec 05 05:42:59.664 INFO [stdout] test declare_func_in ... ok
Dec 05 05:42:59.664 INFO [stdout] test number_01 ... ok
Dec 05 05:42:59.664 INFO [stdout] test number_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test number_02 ... ok
Dec 05 05:42:59.664 INFO [stdout] test number_03 ... ok
Dec 05 05:42:59.664 INFO [stdout] test or_00 ... ok
Dec 05 05:42:59.664 INFO [stdout] test pass_00 ... ok
Dec 05 05:42:59.665 INFO [stdout] test peek_00 ... ok
Dec 05 05:42:59.665 INFO [stdout] test pass_newlines ... ok
Dec 05 05:42:59.665 INFO [stdout] test proc_00 ... ok
Dec 05 05:42:59.665 INFO [stdout] test plus_00 ... ok
Dec 05 05:42:59.665 INFO [stdout] test reg_00 ... ok
Dec 05 05:42:59.665 INFO [stdout] test reg_assignment_00 ... ok
Dec 05 05:42:59.665 INFO [stdout] test state_name_00 ... ok
Dec 05 05:42:59.665 INFO [stdout] test state_00 ... ok
Dec 05 05:42:59.680 INFO [stdout] test mutiline_comment_03 ... ok
Dec 05 05:42:59.680 INFO [stdout] test next_nl ... ok
Dec 05 05:42:59.680 INFO [stdout] test newline_in_declare_block ... ok
Dec 05 05:42:59.680 INFO [stdout] test mutiline_comment_01 ... ok
Dec 05 05:42:59.680 INFO [stdout] test number ... ok
Dec 05 05:42:59.680 INFO [stdout] test mutiline_comment_02 ... ok
Dec 05 05:42:59.680 INFO [stdout] test wire_assign_00 ... ok
Dec 05 05:42:59.680 INFO [stderr]      Running /target/debug/deps/parser_test-ebec1d4e6a376a73
Dec 05 05:42:59.680 INFO [stdout] 
Dec 05 05:42:59.680 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:59.680 INFO [stdout] 
Dec 05 05:42:59.684 INFO [stdout] 
Dec 05 05:42:59.684 INFO [stdout] running 77 tests
Dec 05 05:42:59.684 INFO [stdout] test declare::func_in_return ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::expression_in_width_block_01 ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::expression_in_width_block_00 ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::func_out_return ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::macro_in_declare_00 ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::declare_only ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::macro_in_declare_01 ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::multi_bit_input ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::newline_in_declare_block ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::one_bit_input ... ok
Dec 05 05:42:59.684 INFO [stdout] test declare::output_inout ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::define_macro3 ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::define_macro_nl ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::define_macro2 ... ok
Dec 05 05:42:59.690 INFO [stdout] test comment::multi_line_comment ... ok
Dec 05 05:42:59.690 INFO [stdout] test declare::expression_in_width_block_02 ... ok
Dec 05 05:42:59.690 INFO [stdout] test declare::func_in ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::define_macro_eof ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::ifdef_macro ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::ifndef_macro ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::undef_macro ... ok
Dec 05 05:42:59.690 INFO [stdout] test module::any_00 ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::include_macro ... ok
Dec 05 05:42:59.690 INFO [stdout] test declare::declare_03 ... ok
Dec 05 05:42:59.690 INFO [stdout] test module::any_02 ... ok
Dec 05 05:42:59.690 INFO [stdout] test macros::if_else_end ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::any_else_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::func_self_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::func_call_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::func_in_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::func_in_module_01 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::func_self_01 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::any_01 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::func_in_module_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::if_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::function_call_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::if_01 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::function_call_01 ... ok
Dec 05 05:42:59.700 INFO [stdout] test macros::endif_macro ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::mem_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::mem_01 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::mem_02 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::if_02 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::mem_03 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::module_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::proc_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::proc_01 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::func_self_02 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::reg_00 ... ok
Dec 05 05:42:59.700 INFO [stdout] test module::func_self_03 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::mem_04 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::reg_01 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::reg_02 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::reg_03 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::reg_06 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::state_name_00 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::state_name_01 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::state_procedure_00 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::state_procedure_01 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::state_procedure_02 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_01 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_02 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_03 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_04 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_05 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_assign_00 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_assign_01 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_assign_02 ... ok
Dec 05 05:42:59.708 INFO [stdout] test module::wire_assign_03 ... ok
Dec 05 05:42:59.708 INFO [stdout] test simple_tests::end_of_program ... ok
Dec 05 05:42:59.716 INFO [stdout] test module::reg_05 ... ok
Dec 05 05:42:59.716 INFO [stdout] test module::reg_func_01 ... ok
Dec 05 05:42:59.716 INFO [stdout] test module::reg_04 ... ok
Dec 05 05:42:59.716 INFO [stdout] test module::reg_assign_00 ... ok
Dec 05 05:42:59.716 INFO [stdout] test module::reg_func_00 ... ok
Dec 05 05:42:59.716 INFO [stdout] test module::return_00 ... ok
Dec 05 05:42:59.756 INFO [stdout] test module::if_03 ... FAILED
Dec 05 05:42:59.756 INFO [stdout] 
Dec 05 05:42:59.756 INFO [stdout] failures:
Dec 05 05:42:59.756 INFO [stdout] 
Dec 05 05:42:59.756 INFO [stdout] ---- module::if_03 stdout ----
Dec 05 05:42:59.756 INFO [stdout] thread 'module::if_03' panicked at 'explicit panic', tests/parser_test.rs:1752:9
Dec 05 05:42:59.756 INFO [stdout] stack backtrace:
Dec 05 05:42:59.756 INFO [stdout]    0:     0x559f965f7f63 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3c2ada0a2db8c5e7
Dec 05 05:42:59.756 INFO [stdout]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 05 05:42:59.756 INFO [stdout]    1:     0x559f965f2618 - std::sys_common::backtrace::_print::h95865c77318e98b7
Dec 05 05:42:59.756 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:71
Dec 05 05:42:59.756 INFO [stdout]    2:     0x559f965f6ed2 - std::panicking::default_hook::{{closure}}::hb3d1f299fcea42e5
Dec 05 05:42:59.756 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:59
Dec 05 05:42:59.756 INFO [stdout]                                at src/libstd/panicking.rs:211
Dec 05 05:42:59.756 INFO [stdout]    3:     0x559f965f6bbc - std::panicking::default_hook::h4eae6f26f73244c8
Dec 05 05:42:59.756 INFO [stdout]                                at src/libstd/panicking.rs:221
Dec 05 05:42:59.756 INFO [stdout]    4:     0x559f965f75e0 - std::panicking::rust_panic_with_hook::h368d37fd53b59464
Dec 05 05:42:59.756 INFO [stdout]                                at src/libstd/panicking.rs:491
Dec 05 05:42:59.756 INFO [stdout]    5:     0x559f965c9537 - std::panicking::begin_panic::h465e7a36a8708940
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:425
Dec 05 05:42:59.756 INFO [stdout]    6:     0x559f9655b6b8 - parser_test::module::if_03::ha49e683a93c64b0f
Dec 05 05:42:59.756 INFO [stdout]                                at tests/parser_test.rs:1752
Dec 05 05:42:59.756 INFO [stdout]    7:     0x559f9655b5c9 - parser_test::module::if_03::{{closure}}::h92b6c53a2e3098f3
Dec 05 05:42:59.756 INFO [stdout]                                at tests/parser_test.rs:1748
Dec 05 05:42:59.756 INFO [stdout]    8:     0x559f9656769d - core::ops::function::FnOnce::call_once::h3fe55ad0981e1f7c
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238
Dec 05 05:42:59.756 INFO [stdout]    9:     0x559f9657e70e - <F as alloc::boxed::FnBox<A>>::call_box::h994167e0fc25f327
Dec 05 05:42:59.756 INFO [stdout]                                at src/libtest/lib.rs:1471
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libcore/ops/function.rs:238
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673
Dec 05 05:42:59.756 INFO [stdout]   10:     0x559f96605bd9 - __rust_maybe_catch_panic
Dec 05 05:42:59.756 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 05 05:42:59.756 INFO [stdout]   11:     0x559f96576613 - std::sys_common::backtrace::__rust_begin_short_backtrace::h5d34cfb78512c8c3
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398
Dec 05 05:42:59.756 INFO [stdout]                                at src/libtest/lib.rs:1426
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/sys_common/backtrace.rs:136
Dec 05 05:42:59.756 INFO [stdout]   12:     0x559f96577534 - std::panicking::try::do_call::h7a86b6211ebb5e72
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:477
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:319
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:310
Dec 05 05:42:59.756 INFO [stdout]   13:     0x559f96605bd9 - __rust_maybe_catch_panic
Dec 05 05:42:59.756 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 05 05:42:59.756 INFO [stdout]   14:     0x559f9657e5ec - <F as alloc::boxed::FnBox<A>>::call_box::h877dbe22cb3997f4
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panicking.rs:289
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/panic.rs:398
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/libstd/thread/mod.rs:476
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:673
Dec 05 05:42:59.756 INFO [stdout]   15:     0x559f965f9b9d - std::sys::unix::thread::Thread::new::thread_start::hea5f7f9c570dc4cd
Dec 05 05:42:59.756 INFO [stdout]                                at /rustc/906deae0790bd18681b937fe9a141a3c26cf1855/src/liballoc/boxed.rs:683
Dec 05 05:42:59.756 INFO [stdout]                                at src/libstd/sys_common/thread.rs:24
Dec 05 05:42:59.756 INFO [stdout]                                at src/libstd/sys/unix/thread.rs:90
Dec 05 05:42:59.756 INFO [stdout]   16:     0x7f60de4cc6b9 - start_thread
Dec 05 05:42:59.756 INFO [stdout]   17:     0x7f60ddfec41c - clone
Dec 05 05:42:59.756 INFO [stdout]   18:                0x0 - <unknown>
Dec 05 05:42:59.756 INFO [stdout] 
Dec 05 05:42:59.756 INFO [stdout] 
Dec 05 05:42:59.756 INFO [stdout] failures:
Dec 05 05:42:59.756 INFO [stdout]     module::if_03
Dec 05 05:42:59.756 INFO [stdout] 
Dec 05 05:42:59.756 INFO [stdout] test result: FAILED. 76 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:59.756 INFO [stdout] 
Dec 05 05:42:59.764 INFO [stderr] error: test failed, to rerun pass '--test parser_test'
Dec 05 05:42:59.772 INFO [stderr] su: No module specific data is present
Dec 05 05:43:00.554 INFO running `"docker" "inspect" "bcfb4eda4b2b603fc918995b3259b531dd89bdec8357a908ee7a89396b4e4db1"`
Dec 05 05:43:00.896 INFO running `"docker" "rm" "-f" "bcfb4eda4b2b603fc918995b3259b531dd89bdec8357a908ee7a89396b4e4db1"`
Dec 05 05:43:01.220 INFO [stdout] bcfb4eda4b2b603fc918995b3259b531dd89bdec8357a908ee7a89396b4e4db1