Dec 05 05:42:27.675 INFO testing sux2mfgj/nslfmt against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 05 05:42:27.675 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:28.115 INFO [stdout] 1aed73937f9982fecf9b5082d3157397fb296a6f8f921e07793c684357241628
Dec 05 05:42:28.118 INFO running `"docker" "start" "-a" "1aed73937f9982fecf9b5082d3157397fb296a6f8f921e07793c684357241628"`
Dec 05 05:42:29.309 INFO [stderr] usermod: no changes
Dec 05 05:42:29.384 INFO [stderr]    Compiling nslfmt v0.0.1 (/source)
Dec 05 05:42:30.868 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 05 05:42:30.868 INFO [stderr]    --> src/lexer.rs:423:21
Dec 05 05:42:30.868 INFO [stderr]     |
Dec 05 05:42:30.868 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 05 05:42:30.868 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 05 05:42:30.868 INFO [stderr]     |
Dec 05 05:42:30.868 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 05 05:42:30.868 INFO [stderr] 
Dec 05 05:42:31.104 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 05 05:42:31.104 INFO [stderr]  --> src/parser.rs:7:5
Dec 05 05:42:31.104 INFO [stderr]   |
Dec 05 05:42:31.104 INFO [stderr] 7 |     number_of_nest: usize,
Dec 05 05:42:31.104 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:31.104 INFO [stderr]   |
Dec 05 05:42:31.104 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 05 05:42:31.104 INFO [stderr] 
Dec 05 05:42:33.637 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 05 05:42:33.637 INFO [stderr]    --> src/lexer.rs:423:21
Dec 05 05:42:33.637 INFO [stderr]     |
Dec 05 05:42:33.637 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 05 05:42:33.637 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 05 05:42:33.637 INFO [stderr]     |
Dec 05 05:42:33.637 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 05 05:42:33.637 INFO [stderr] 
Dec 05 05:42:33.814 INFO [stderr] warning: method is never used: `peek`
Dec 05 05:42:33.814 INFO [stderr]   --> src/lexer.rs:38:5
Dec 05 05:42:33.814 INFO [stderr]    |
Dec 05 05:42:33.814 INFO [stderr] 38 |     pub fn peek(&mut self, is_pass_nl: bool) -> Option<&Token>
Dec 05 05:42:33.814 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:33.814 INFO [stderr]    |
Dec 05 05:42:33.814 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 05 05:42:33.814 INFO [stderr] 
Dec 05 05:42:33.820 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 05 05:42:33.820 INFO [stderr]  --> src/parser.rs:7:5
Dec 05 05:42:33.820 INFO [stderr]   |
Dec 05 05:42:33.820 INFO [stderr] 7 |     number_of_nest: usize,
Dec 05 05:42:33.820 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:33.820 INFO [stderr] 
Dec 05 05:42:36.204 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.85s
Dec 05 05:42:36.204 INFO [stderr] su: No module specific data is present
Dec 05 05:42:36.919 INFO running `"docker" "inspect" "1aed73937f9982fecf9b5082d3157397fb296a6f8f921e07793c684357241628"`
Dec 05 05:42:37.204 INFO running `"docker" "rm" "-f" "1aed73937f9982fecf9b5082d3157397fb296a6f8f921e07793c684357241628"`
Dec 05 05:42:37.591 INFO [stdout] 1aed73937f9982fecf9b5082d3157397fb296a6f8f921e07793c684357241628
Dec 05 05:42:37.594 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:38.082 INFO [stdout] fd1622cda046599c74bd205c4b0a455238a84d2cb72c26af264ed8f9eb794f01
Dec 05 05:42:38.084 INFO running `"docker" "start" "-a" "fd1622cda046599c74bd205c4b0a455238a84d2cb72c26af264ed8f9eb794f01"`
Dec 05 05:42:39.609 INFO [stderr] usermod: no changes
Dec 05 05:42:39.680 INFO [stderr]    Compiling nslfmt v0.0.1 (/source)
Dec 05 05:42:41.232 INFO [stderr] warning: static variable `call_count` should have an upper case name such as `CALL_COUNT`
Dec 05 05:42:41.232 INFO [stderr]   --> tests/generator_test.rs:11:1
Dec 05 05:42:41.232 INFO [stderr]    |
Dec 05 05:42:41.232 INFO [stderr] 11 | static call_count: AtomicUsize = AtomicUsize::new(0);
Dec 05 05:42:41.232 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:41.244 INFO [stderr]    |
Dec 05 05:42:41.244 INFO [stderr]    = note: #[warn(non_upper_case_globals)] on by default
Dec 05 05:42:41.244 INFO [stderr] 
Dec 05 05:42:41.977 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 05 05:42:41.977 INFO [stderr]    --> src/lexer.rs:423:21
Dec 05 05:42:41.977 INFO [stderr]     |
Dec 05 05:42:41.977 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 05 05:42:41.977 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 05 05:42:41.992 INFO [stderr]     |
Dec 05 05:42:41.992 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 05 05:42:41.992 INFO [stderr] 
Dec 05 05:42:42.464 INFO [stderr] warning: value assigned to `astarisc_flag` is never read
Dec 05 05:42:42.465 INFO [stderr]    --> src/lexer.rs:423:21
Dec 05 05:42:42.465 INFO [stderr]     |
Dec 05 05:42:42.465 INFO [stderr] 423 |                     astarisc_flag = false;
Dec 05 05:42:42.466 INFO [stderr]     |                     ^^^^^^^^^^^^^
Dec 05 05:42:42.466 INFO [stderr]     |
Dec 05 05:42:42.466 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 05 05:42:42.466 INFO [stderr] 
Dec 05 05:42:42.988 INFO [stderr] warning: unused variable: `p`
Dec 05 05:42:42.989 INFO [stderr]     --> tests/parser_test.rs:1186:13
Dec 05 05:42:42.989 INFO [stderr]      |
Dec 05 05:42:42.989 INFO [stderr] 1186 |         let p = Parser::new(&mut l);
Dec 05 05:42:42.990 INFO [stderr]      |             ^ help: consider using `_p` instead
Dec 05 05:42:42.990 INFO [stderr]      |
Dec 05 05:42:42.990 INFO [stderr]      = note: #[warn(unused_variables)] on by default
Dec 05 05:42:42.990 INFO [stderr] 
Dec 05 05:42:42.990 INFO [stderr] warning: unused variable: `module`
Dec 05 05:42:42.991 INFO [stderr]     --> tests/parser_test.rs:1206:13
Dec 05 05:42:42.991 INFO [stderr]      |
Dec 05 05:42:42.991 INFO [stderr] 1206 |         let module = create_node!(ASTClass::Module(
Dec 05 05:42:42.991 INFO [stderr]      |             ^^^^^^ help: consider using `_module` instead
Dec 05 05:42:42.992 INFO [stderr] 
Dec 05 05:42:43.005 INFO [stderr] warning: unused variable: `p`
Dec 05 05:42:43.005 INFO [stderr]     --> tests/parser_test.rs:1751:17
Dec 05 05:42:43.005 INFO [stderr]      |
Dec 05 05:42:43.005 INFO [stderr] 1751 |         let mut p = Parser::new(&mut l);
Dec 05 05:42:43.005 INFO [stderr]      |                 ^ help: consider using `_p` instead
Dec 05 05:42:43.005 INFO [stderr] 
Dec 05 05:42:43.020 INFO [stderr] warning: method is never used: `peek`
Dec 05 05:42:43.020 INFO [stderr]   --> src/lexer.rs:38:5
Dec 05 05:42:43.020 INFO [stderr]    |
Dec 05 05:42:43.020 INFO [stderr] 38 |     pub fn peek(&mut self, is_pass_nl: bool) -> Option<&Token>
Dec 05 05:42:43.020 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:43.020 INFO [stderr]    |
Dec 05 05:42:43.020 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 05 05:42:43.020 INFO [stderr] 
Dec 05 05:42:43.020 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 05 05:42:43.020 INFO [stderr]  --> src/parser.rs:7:5
Dec 05 05:42:43.020 INFO [stderr]   |
Dec 05 05:42:43.020 INFO [stderr] 7 |     number_of_nest: usize,
Dec 05 05:42:43.020 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:43.020 INFO [stderr] 
Dec 05 05:42:43.344 INFO [stderr] warning: field is never used: `number_of_nest`
Dec 05 05:42:43.345 INFO [stderr]  --> src/parser.rs:7:5
Dec 05 05:42:43.345 INFO [stderr]   |
Dec 05 05:42:43.345 INFO [stderr] 7 |     number_of_nest: usize,
Dec 05 05:42:43.345 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
Dec 05 05:42:43.346 INFO [stderr]   |
Dec 05 05:42:43.346 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 05 05:42:43.346 INFO [stderr] 
Dec 05 05:42:44.128 INFO [stderr] warning: variable does not need to be mutable
Dec 05 05:42:44.128 INFO [stderr]     --> tests/parser_test.rs:1751:13
Dec 05 05:42:44.128 INFO [stderr]      |
Dec 05 05:42:44.128 INFO [stderr] 1751 |         let mut p = Parser::new(&mut l);
Dec 05 05:42:44.128 INFO [stderr]      |             ----^
Dec 05 05:42:44.128 INFO [stderr]      |             |
Dec 05 05:42:44.128 INFO [stderr]      |             help: remove this `mut`
Dec 05 05:42:44.128 INFO [stderr]      |
Dec 05 05:42:44.128 INFO [stderr]      = note: #[warn(unused_mut)] on by default
Dec 05 05:42:44.128 INFO [stderr] 
Dec 05 05:42:48.312 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.66s
Dec 05 05:42:48.316 INFO [stderr] su: No module specific data is present
Dec 05 05:42:49.394 INFO running `"docker" "inspect" "fd1622cda046599c74bd205c4b0a455238a84d2cb72c26af264ed8f9eb794f01"`
Dec 05 05:42:49.662 INFO running `"docker" "rm" "-f" "fd1622cda046599c74bd205c4b0a455238a84d2cb72c26af264ed8f9eb794f01"`
Dec 05 05:42:50.019 INFO [stdout] fd1622cda046599c74bd205c4b0a455238a84d2cb72c26af264ed8f9eb794f01
Dec 05 05:42:50.022 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:50.566 INFO [stdout] 81d1cc9aa91b06a496d447b9420d4d6e9400f9ee19ecb291b48c5caff31392f0
Dec 05 05:42:50.568 INFO running `"docker" "start" "-a" "81d1cc9aa91b06a496d447b9420d4d6e9400f9ee19ecb291b48c5caff31392f0"`
Dec 05 05:42:52.238 INFO [stderr] usermod: no changes
Dec 05 05:42:52.312 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 05 05:42:52.312 INFO [stderr]      Running /target/debug/deps/nslfmt-dd72d88f9df7fb92
Dec 05 05:42:52.316 INFO [stdout] 
Dec 05 05:42:52.316 INFO [stdout] running 0 tests
Dec 05 05:42:52.316 INFO [stdout] 
Dec 05 05:42:52.316 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:52.316 INFO [stdout] 
Dec 05 05:42:52.316 INFO [stderr]      Running /target/debug/deps/nslfmt-363e5c8de61e592e
Dec 05 05:42:52.320 INFO [stdout] 
Dec 05 05:42:52.320 INFO [stdout] running 0 tests
Dec 05 05:42:52.320 INFO [stdout] 
Dec 05 05:42:52.320 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:52.320 INFO [stdout] 
Dec 05 05:42:52.320 INFO [stdout] 
Dec 05 05:42:52.320 INFO [stdout] running 20 tests
Dec 05 05:42:52.320 INFO [stdout] test comment_01 ... ok
Dec 05 05:42:52.320 INFO [stdout] test define_path ... ok
Dec 05 05:42:52.320 INFO [stderr]      Running /target/debug/deps/generator_test-03563ae342964916
Dec 05 05:42:52.320 INFO [stdout] test comment_00 ... ok
Dec 05 05:42:52.321 INFO [stdout] test aware_indent_03 ... ok
Dec 05 05:42:52.321 INFO [stdout] test aware_indent_02 ... ok
Dec 05 05:42:52.321 INFO [stdout] test aware_indent_01 ... ok
Dec 05 05:42:52.321 INFO [stdout] test assign_wire_00 ... ok
Dec 05 05:42:52.321 INFO [stdout] test func_00 ... ok
Dec 05 05:42:52.321 INFO [stdout] test any_00 ... ok
Dec 05 05:42:52.321 INFO [stdout] test new_by_stdout ... ok
Dec 05 05:42:52.328 INFO [stdout] test output_declare_to_file ... ok
Dec 05 05:42:52.328 INFO [stdout] test parences ... ok
Dec 05 05:42:52.328 INFO [stdout] test reg_00 ... ok
Dec 05 05:42:52.328 INFO [stdout] test return_00 ... ok
Dec 05 05:42:52.328 INFO [stdout] test func_self_00 ... ok
Dec 05 05:42:52.328 INFO [stdout] test func_call_00 ... ok
Dec 05 05:42:52.328 INFO [stdout] test new_by_file ... ok
Dec 05 05:42:52.328 INFO [stdout] test two_arguments ... ok
Dec 05 05:42:52.328 INFO [stdout] test wire_00 ... ok
Dec 05 05:42:52.329 INFO [stdout] test wire_01 ... ok
Dec 05 05:42:52.329 INFO [stdout] 
Dec 05 05:42:52.329 INFO [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:52.329 INFO [stdout] 
Dec 05 05:42:52.332 INFO [stderr]      Running /target/debug/deps/lexer_test-9a19e43869644991
Dec 05 05:42:52.332 INFO [stdout] 
Dec 05 05:42:52.332 INFO [stdout] running 52 tests
Dec 05 05:42:52.332 INFO [stdout] test braces_and_newline ... ok
Dec 05 05:42:52.332 INFO [stdout] test create_instance_with_file ... ok
Dec 05 05:42:52.332 INFO [stdout] test any_else_00 ... ok
Dec 05 05:42:52.332 INFO [stdout] test any_block_00 ... ok
Dec 05 05:42:52.332 INFO [stdout] test comment_00 ... ok
Dec 05 05:42:52.332 INFO [stdout] test create_instance_with_string ... ok
Dec 05 05:42:52.332 INFO [stdout] test declare_04 ... ok
Dec 05 05:42:52.332 INFO [stdout] test declare_func_in ... ok
Dec 05 05:42:52.332 INFO [stdout] test get_token_eop ... ok
Dec 05 05:42:52.332 INFO [stdout] test func_block_return ... ok
Dec 05 05:42:52.332 INFO [stdout] test func_self_00 ... ok
Dec 05 05:42:52.332 INFO [stdout] test get_token_file ... ok
Dec 05 05:42:52.332 INFO [stdout] test func_block_00 ... ok
Dec 05 05:42:52.333 INFO [stdout] test gt_lt_00 ... ok
Dec 05 05:42:52.333 INFO [stdout] test get_token_str ... ok
Dec 05 05:42:52.333 INFO [stdout] test get_token_new_line ... ok
Dec 05 05:42:52.333 INFO [stdout] test macro_define ... ok
Dec 05 05:42:52.333 INFO [stdout] test macro_else ... ok
Dec 05 05:42:52.333 INFO [stdout] test macro_endif ... ok
Dec 05 05:42:52.333 INFO [stdout] test macro_ifdef ... ok
Dec 05 05:42:52.333 INFO [stdout] test macro_ifndef ... ok
Dec 05 05:42:52.333 INFO [stdout] test macro_include ... ok
Dec 05 05:42:52.333 INFO [stdout] test macro_undef ... ok
Dec 05 05:42:52.333 INFO [stdout] test module_wire_00 ... ok
Dec 05 05:42:52.333 INFO [stdout] test mem_00 ... ok
Dec 05 05:42:52.334 INFO [stdout] test module_00 ... ok
Dec 05 05:42:52.334 INFO [stdout] test module_wire_01 ... ok
Dec 05 05:42:52.334 INFO [stdout] test mutiline_comment_00 ... ok
Dec 05 05:42:52.334 INFO [stdout] test mutiline_comment_01 ... ok
Dec 05 05:42:52.334 INFO [stdout] test mutiline_comment_02 ... ok
Dec 05 05:42:52.334 INFO [stdout] test mutiline_comment_03 ... ok
Dec 05 05:42:52.334 INFO [stdout] test next_nl ... ok
Dec 05 05:42:52.334 INFO [stdout] test newline_in_declare_block ... ok
Dec 05 05:42:52.334 INFO [stdout] test number ... ok
Dec 05 05:42:52.334 INFO [stdout] test number_00 ... ok
Dec 05 05:42:52.334 INFO [stdout] test number_01 ... ok
Dec 05 05:42:52.335 INFO [stdout] test number_02 ... ok
Dec 05 05:42:52.335 INFO [stdout] test number_03 ... ok
Dec 05 05:42:52.335 INFO [stdout] test pass_newlines ... ok
Dec 05 05:42:52.335 INFO [stdout] test or_00 ... ok
Dec 05 05:42:52.335 INFO [stdout] test pass_00 ... ok
Dec 05 05:42:52.335 INFO [stdout] test peek_00 ... ok
Dec 05 05:42:52.335 INFO [stdout] test plus_00 ... ok
Dec 05 05:42:52.335 INFO [stdout] test proc_00 ... ok
Dec 05 05:42:52.335 INFO [stdout] test reg_00 ... ok
Dec 05 05:42:52.335 INFO [stdout] test reg_assignment_00 ... ok
Dec 05 05:42:52.344 INFO [stdout] test declare_func_out ... ok
Dec 05 05:42:52.344 INFO [stdout] test declare_with_input ... ok
Dec 05 05:42:52.344 INFO [stdout] test define_path ... ok
Dec 05 05:42:52.344 INFO [stdout] test state_00 ... ok
Dec 05 05:42:52.344 INFO [stdout] test state_name_00 ... ok
Dec 05 05:42:52.344 INFO [stdout] test wire_assign_00 ... ok
Dec 05 05:42:52.344 INFO [stdout] 
Dec 05 05:42:52.344 INFO [stdout] test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:52.344 INFO [stdout] 
Dec 05 05:42:52.344 INFO [stderr]      Running /target/debug/deps/parser_test-e42bbbf7c1a0be89
Dec 05 05:42:52.348 INFO [stdout] 
Dec 05 05:42:52.348 INFO [stdout] running 77 tests
Dec 05 05:42:52.404 INFO [stdout] test declare::declare_only ... ok
Dec 05 05:42:52.404 INFO [stdout] test comment::multi_line_comment ... ok
Dec 05 05:42:52.408 INFO [stdout] test declare::expression_in_width_block_00 ... ok
Dec 05 05:42:52.408 INFO [stdout] test declare::expression_in_width_block_02 ... ok
Dec 05 05:42:52.408 INFO [stdout] test declare::declare_03 ... ok
Dec 05 05:42:52.428 INFO [stdout] test declare::func_in ... ok
Dec 05 05:42:52.448 INFO [stdout] test declare::func_out_return ... ok
Dec 05 05:42:52.448 INFO [stdout] test declare::expression_in_width_block_01 ... ok
Dec 05 05:42:52.449 INFO [stdout] test declare::macro_in_declare_01 ... ok
Dec 05 05:42:52.449 INFO [stdout] test declare::multi_bit_input ... ok
Dec 05 05:42:52.449 INFO [stdout] test declare::func_in_return ... ok
Dec 05 05:42:52.449 INFO [stdout] test declare::newline_in_declare_block ... ok
Dec 05 05:42:52.449 INFO [stdout] test declare::macro_in_declare_00 ... ok
Dec 05 05:42:52.464 INFO [stdout] test macros::define_macro_nl ... ok
Dec 05 05:42:52.464 INFO [stdout] test macros::define_macro_eof ... ok
Dec 05 05:42:52.464 INFO [stdout] test macros::define_macro3 ... ok
Dec 05 05:42:52.465 INFO [stdout] test macros::endif_macro ... ok
Dec 05 05:42:52.465 INFO [stdout] test declare::output_inout ... ok
Dec 05 05:42:52.472 INFO [stdout] test macros::include_macro ... ok
Dec 05 05:42:52.473 INFO [stdout] test macros::undef_macro ... ok
Dec 05 05:42:52.473 INFO [stdout] test macros::ifndef_macro ... ok
Dec 05 05:42:52.473 INFO [stdout] test macros::ifdef_macro ... ok
Dec 05 05:42:52.473 INFO [stdout] test macros::define_macro2 ... ok
Dec 05 05:42:52.473 INFO [stdout] test declare::one_bit_input ... ok
Dec 05 05:42:52.473 INFO [stdout] test module::any_00 ... ok
Dec 05 05:42:52.474 INFO [stdout] test macros::if_else_end ... ok
Dec 05 05:42:52.474 INFO [stdout] test module::func_self_00 ... ok
Dec 05 05:42:52.474 INFO [stdout] test module::func_self_01 ... ok
Dec 05 05:42:52.475 INFO [stdout] test module::func_in_module_00 ... ok
Dec 05 05:42:52.475 INFO [stdout] test module::func_self_02 ... ok
Dec 05 05:42:52.476 INFO [stdout] test module::any_01 ... ok
Dec 05 05:42:52.476 INFO [stdout] test module::any_else_00 ... ok
Dec 05 05:42:52.476 INFO [stdout] test module::any_02 ... ok
Dec 05 05:42:52.476 INFO [stdout] test module::func_call_00 ... ok
Dec 05 05:42:52.477 INFO [stdout] test module::func_in_00 ... ok
Dec 05 05:42:52.477 INFO [stdout] test module::func_in_module_01 ... ok
Dec 05 05:42:52.477 INFO [stdout] test module::if_00 ... ok
Dec 05 05:42:52.477 INFO [stdout] test module::if_01 ... ok
Dec 05 05:42:52.477 INFO [stdout] test module::function_call_01 ... ok
Dec 05 05:42:52.477 INFO [stdout] test module::mem_01 ... ok
Dec 05 05:42:52.478 INFO [stdout] test module::mem_04 ... ok
Dec 05 05:42:52.478 INFO [stdout] test module::mem_00 ... ok
Dec 05 05:42:52.478 INFO [stdout] test module::if_02 ... ok
Dec 05 05:42:52.480 INFO [stdout] test module::module_00 ... ok
Dec 05 05:42:52.480 INFO [stdout] test module::function_call_00 ... ok
Dec 05 05:42:52.480 INFO [stdout] test module::proc_00 ... ok
Dec 05 05:42:52.480 INFO [stdout] test module::proc_01 ... ok
Dec 05 05:42:52.481 INFO [stdout] test module::mem_03 ... ok
Dec 05 05:42:52.481 INFO [stdout] test module::mem_02 ... ok
Dec 05 05:42:52.492 INFO [stdout] test module::reg_00 ... ok
Dec 05 05:42:52.493 INFO [stdout] test module::reg_04 ... ok
Dec 05 05:42:52.493 INFO [stdout] test module::reg_01 ... ok
Dec 05 05:42:52.493 INFO [stdout] test module::reg_02 ... ok
Dec 05 05:42:52.493 INFO [stdout] test module::reg_03 ... ok
Dec 05 05:42:52.493 INFO [stdout] test module::func_self_03 ... ok
Dec 05 05:42:52.493 INFO [stdout] test module::reg_func_01 ... ok
Dec 05 05:42:52.493 INFO [stdout] test module::reg_06 ... ok
Dec 05 05:42:52.494 INFO [stdout] test module::state_name_00 ... ok
Dec 05 05:42:52.494 INFO [stdout] test module::reg_func_00 ... ok
Dec 05 05:42:52.497 INFO [stdout] test module::reg_assign_00 ... ok
Dec 05 05:42:52.497 INFO [stdout] test module::reg_05 ... ok
Dec 05 05:42:52.498 INFO [stdout] test module::state_procedure_00 ... ok
Dec 05 05:42:52.498 INFO [stdout] test module::state_name_01 ... ok
Dec 05 05:42:52.499 INFO [stdout] test module::state_procedure_02 ... ok
Dec 05 05:42:52.503 INFO [stdout] test module::return_00 ... ok
Dec 05 05:42:52.503 INFO [stdout] test module::state_procedure_01 ... ok
Dec 05 05:42:52.504 INFO [stdout] test module::wire_03 ... ok
Dec 05 05:42:52.504 INFO [stdout] test module::wire_02 ... ok
Dec 05 05:42:52.504 INFO [stdout] test module::wire_01 ... ok
Dec 05 05:42:52.504 INFO [stdout] test module::wire_assign_00 ... ok
Dec 05 05:42:52.504 INFO [stdout] test module::wire_assign_02 ... ok
Dec 05 05:42:52.504 INFO [stdout] test module::wire_assign_01 ... ok
Dec 05 05:42:52.505 INFO [stdout] test module::wire_04 ... ok
Dec 05 05:42:52.508 INFO [stdout] test module::wire_05 ... ok
Dec 05 05:42:52.516 INFO [stdout] test module::wire_assign_03 ... ok
Dec 05 05:42:52.516 INFO [stdout] test simple_tests::end_of_program ... ok
Dec 05 05:42:52.631 INFO [stdout] test module::if_03 ... FAILED
Dec 05 05:42:52.631 INFO [stdout] 
Dec 05 05:42:52.631 INFO [stdout] failures:
Dec 05 05:42:52.631 INFO [stdout] 
Dec 05 05:42:52.631 INFO [stdout] ---- module::if_03 stdout ----
Dec 05 05:42:52.631 INFO [stdout] thread 'module::if_03' panicked at 'explicit panic', tests/parser_test.rs:1752:9
Dec 05 05:42:52.631 INFO [stdout] stack backtrace:
Dec 05 05:42:52.631 INFO [stdout]    0:     0x55e8a7375f63 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h82c998a0e635a5c4
Dec 05 05:42:52.631 INFO [stdout]                                at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 05 05:42:52.631 INFO [stdout]    1:     0x55e8a7370618 - std::sys_common::backtrace::_print::h5fbc0bc3cf12d9bf
Dec 05 05:42:52.631 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:71
Dec 05 05:42:52.631 INFO [stdout]    2:     0x55e8a7374ed2 - std::panicking::default_hook::{{closure}}::h42b81c3dd1a50e32
Dec 05 05:42:52.631 INFO [stdout]                                at src/libstd/sys_common/backtrace.rs:59
Dec 05 05:42:52.631 INFO [stdout]                                at src/libstd/panicking.rs:211
Dec 05 05:42:52.631 INFO [stdout]    3:     0x55e8a7374bbc - std::panicking::default_hook::h6c8d8e1c12a669e5
Dec 05 05:42:52.631 INFO [stdout]                                at src/libstd/panicking.rs:221
Dec 05 05:42:52.632 INFO [stdout]    4:     0x55e8a73755e0 - std::panicking::rust_panic_with_hook::hce93a56e38c2b0aa
Dec 05 05:42:52.632 INFO [stdout]                                at src/libstd/panicking.rs:491
Dec 05 05:42:52.632 INFO [stdout]    5:     0x55e8a7347537 - std::panicking::begin_panic::hde1bc3a6c9594feb
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:425
Dec 05 05:42:52.632 INFO [stdout]    6:     0x55e8a72d96b8 - parser_test::module::if_03::h7156b9c938091e78
Dec 05 05:42:52.632 INFO [stdout]                                at tests/parser_test.rs:1752
Dec 05 05:42:52.632 INFO [stdout]    7:     0x55e8a72d95c9 - parser_test::module::if_03::{{closure}}::h94865619d595184e
Dec 05 05:42:52.632 INFO [stdout]                                at tests/parser_test.rs:1748
Dec 05 05:42:52.632 INFO [stdout]    8:     0x55e8a72e5fdd - core::ops::function::FnOnce::call_once::ha36a1ea1ea248a3b
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libcore/ops/function.rs:238
Dec 05 05:42:52.632 INFO [stdout]    9:     0x55e8a72fc73e - <F as alloc::boxed::FnBox<A>>::call_box::h9ed1658cdce7f33f
Dec 05 05:42:52.632 INFO [stdout]                                at src/libtest/lib.rs:1471
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libcore/ops/function.rs:238
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:673
Dec 05 05:42:52.632 INFO [stdout]   10:     0x55e8a7383bd9 - __rust_maybe_catch_panic
Dec 05 05:42:52.632 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 05 05:42:52.632 INFO [stdout]   11:     0x55e8a72f4613 - std::sys_common::backtrace::__rust_begin_short_backtrace::h018d03d6681412f5
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:289
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:398
Dec 05 05:42:52.632 INFO [stdout]                                at src/libtest/lib.rs:1426
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/sys_common/backtrace.rs:136
Dec 05 05:42:52.632 INFO [stdout]   12:     0x55e8a72f55a4 - std::panicking::try::do_call::hf8ab3f21dcfaa7a6
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/thread/mod.rs:477
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:319
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:310
Dec 05 05:42:52.632 INFO [stdout]   13:     0x55e8a7383bd9 - __rust_maybe_catch_panic
Dec 05 05:42:52.632 INFO [stdout]                                at src/libpanic_unwind/lib.rs:102
Dec 05 05:42:52.632 INFO [stdout]   14:     0x55e8a72fc61c - <F as alloc::boxed::FnBox<A>>::call_box::h6465cc998309e287
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:289
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:398
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/thread/mod.rs:476
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:673
Dec 05 05:42:52.632 INFO [stdout]   15:     0x55e8a7377b9d - std::sys::unix::thread::Thread::new::thread_start::h0fe9c527147fd5f5
Dec 05 05:42:52.632 INFO [stdout]                                at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:683
Dec 05 05:42:52.632 INFO [stdout]                                at src/libstd/sys_common/thread.rs:24
Dec 05 05:42:52.632 INFO [stdout]                                at src/libstd/sys/unix/thread.rs:90
Dec 05 05:42:52.632 INFO [stdout]   16:     0x7f1e18f5f6b9 - start_thread
Dec 05 05:42:52.632 INFO [stdout]   17:     0x7f1e18a7f41c - clone
Dec 05 05:42:52.632 INFO [stdout]   18:                0x0 - <unknown>
Dec 05 05:42:52.632 INFO [stdout] 
Dec 05 05:42:52.632 INFO [stdout] 
Dec 05 05:42:52.632 INFO [stdout] failures:
Dec 05 05:42:52.632 INFO [stdout]     module::if_03
Dec 05 05:42:52.632 INFO [stdout] 
Dec 05 05:42:52.632 INFO [stdout] test result: FAILED. 76 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 05:42:52.632 INFO [stdout] 
Dec 05 05:42:52.640 INFO [stderr] error: test failed, to rerun pass '--test parser_test'
Dec 05 05:42:52.640 INFO [stderr] su: No module specific data is present
Dec 05 05:42:53.735 INFO running `"docker" "inspect" "81d1cc9aa91b06a496d447b9420d4d6e9400f9ee19ecb291b48c5caff31392f0"`
Dec 05 05:42:53.984 INFO running `"docker" "rm" "-f" "81d1cc9aa91b06a496d447b9420d4d6e9400f9ee19ecb291b48c5caff31392f0"`
Dec 05 05:42:54.231 INFO [stdout] 81d1cc9aa91b06a496d447b9420d4d6e9400f9ee19ecb291b48c5caff31392f0