Sep 20 06:19:48.914 INFO checking axpy-0.3.0 against master#1e21c9a297a9fe668d62887a3a6a4add8e717b17 for pr-54352
Sep 20 06:19:48.914 INFO running: cargo +1e21c9a297a9fe668d62887a3a6a4add8e717b17-alt check --frozen --all --all-targets
Sep 20 06:19:48.914 INFO running `"docker" "create" "-v" "/home/ec2-user/crater/./work/local/test-source/worker-4/pr-54352/master#1e21c9a297a9fe668d62887a3a6a4add8e717b17:/source:ro,Z" "-v" "/home/ec2-user/crater/./work/local/target-dirs/pr-54352/worker-4/master#1e21c9a297a9fe668d62887a3a6a4add8e717b17:/target:rw,Z" "-v" "/home/ec2-user/crater/./work/local/cargo-home:/cargo-home:ro,Z" "-v" "/home/ec2-user/crater/./work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "CMD=cargo +1e21c9a297a9fe668d62887a3a6a4add8e717b17-alt check --frozen --all --all-targets" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "crater"`
Sep 20 06:19:49.134 INFO blam! 4b9be6212aab89a154060ba6fce39748070c7aac7c250bf5dc81cb31299d6f07
Sep 20 06:19:49.135 INFO running `"docker" "start" "-a" "4b9be6212aab89a154060ba6fce39748070c7aac7c250bf5dc81cb31299d6f07"`
Sep 20 06:19:50.897 INFO kablam! usermod: no changes
Sep 20 06:19:50.974 INFO kablam!     Checking axpy v0.3.0 (/source)
Sep 20 06:19:51.925 INFO kablam! note: trace_macro
Sep 20 06:19:51.925 INFO kablam!   --> tests/trace.rs:20:5
Sep 20 06:19:51.925 INFO kablam!    |
Sep 20 06:19:51.925 INFO kablam! 20 |     axpy![z = 2.*z - x + 3. * y];
Sep 20 06:19:51.925 INFO kablam!    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Sep 20 06:19:51.925 INFO kablam!    |
Sep 20 06:19:51.926 INFO kablam!    = note: expanding `axpy! { z = 2. * z - x + 3. * y }`
Sep 20 06:19:51.926 INFO kablam!    = note: to `axpy ! [ ! z = (  ) 2. * z - x + 3. * y + . ]`
Sep 20 06:19:51.926 INFO kablam!    = note: expanding `axpy! { ! z = (  ) 2. * z - x + 3. * y + . }`
Sep 20 06:19:51.926 INFO kablam!    = note: to `axpy ! [ ! z = ( 2. * z ) - x + 3. * y + . ]`
Sep 20 06:19:51.926 INFO kablam!    = note: expanding `axpy! { ! z = ( 2. * z ) - x + 3. * y + . }`
Sep 20 06:19:51.926 INFO kablam!    = note: to `axpy ! [ ! z = ( 2. * z 0 - x ) + 3. * y + . ]`
Sep 20 06:19:51.926 INFO kablam!    = note: expanding `axpy! { ! z = ( 2. * z 0 - x ) + 3. * y + . }`
Sep 20 06:19:51.927 INFO kablam!    = note: to `axpy ! [ ! z = ( 2. * z 0 - x 3. * y ) + . ]`
Sep 20 06:19:51.927 INFO kablam!    = note: expanding `axpy! { ! z = ( 2. * z 0 - x 3. * y ) + . }`
Sep 20 06:19:51.927 INFO kablam!    = note: to `for ( car , cdr ) in axpy ! [ @ z ; z . iter_mut (  ) ; 2. * z 0 - x 3. * y ]
Sep 20 06:19:51.927 INFO kablam!            { * car = axpy ! [ # z ; car ; cdr ; (  ) 2. * z 0 - x 3. * y ] ; }`
Sep 20 06:19:51.927 INFO kablam!    = note: expanding `axpy! { @ z ; z . iter_mut (  ) ; 2. * z 0 - x 3. * y }`
Sep 20 06:19:51.927 INFO kablam!    = note: to `{
Sep 20 06:19:51.927 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.928 INFO kablam!            ( z z ) => { axpy ! [ @ z ; z.iter_mut() ; 0 - x 3. * y ] } ; ( z z ) => {
Sep 20 06:19:51.928 INFO kablam!            z.iter_mut() . zip ( axpy ! [ @ z ; z . iter (  ) ; 0 - x 3. * y ] ) } ; }
Sep 20 06:19:51.928 INFO kablam!            eval ! ( z z ) }`
Sep 20 06:19:51.928 INFO kablam!    = note: expanding `eval! { z z }`
Sep 20 06:19:51.929 INFO kablam!    = note: to `axpy ! [ @ z ; z.iter_mut() ; 0 - x 3. * y ]`
Sep 20 06:19:51.929 INFO kablam!    = note: expanding `axpy! { @ z ; z.iter_mut() ; 0 - x 3. * y }`
Sep 20 06:19:51.929 INFO kablam!    = note: to `{
Sep 20 06:19:51.929 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.929 INFO kablam!            ( z z ) => { axpy ! [ @ z ; z.iter_mut() ; 3. * y ] } ; ( x z ) => {
Sep 20 06:19:51.929 INFO kablam!            z.iter_mut() . zip ( axpy ! [ @ z ; x . iter (  ) ; 3. * y ] ) } ; } eval ! (
Sep 20 06:19:51.929 INFO kablam!            x z ) }`
Sep 20 06:19:51.929 INFO kablam!    = note: expanding `eval! { x z }`
Sep 20 06:19:51.929 INFO kablam!    = note: to `z.iter_mut() . zip ( axpy ! [ @ z ; x . iter (  ) ; 3. * y ] )`
Sep 20 06:19:51.929 INFO kablam!    = note: expanding `axpy! { @ z ; x . iter (  ) ; 3. * y }`
Sep 20 06:19:51.930 INFO kablam!    = note: to `{
Sep 20 06:19:51.930 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.930 INFO kablam!            ( z z ) => { axpy ! [ @ z ; x.iter() ; ] } ; ( y z ) => {
Sep 20 06:19:51.930 INFO kablam!            x.iter() . zip ( axpy ! [ @ z ; y . iter (  ) ; ] ) } ; } eval ! ( y z ) }`
Sep 20 06:19:51.930 INFO kablam!    = note: expanding `eval! { y z }`
Sep 20 06:19:51.930 INFO kablam!    = note: to `x.iter() . zip ( axpy ! [ @ z ; y . iter (  ) ; ] )`
Sep 20 06:19:51.931 INFO kablam!    = note: expanding `axpy! { @ z ; y . iter (  ) ; }`
Sep 20 06:19:51.931 INFO kablam!    = note: to `y.iter() . map ( | x | ( x , ) )`
Sep 20 06:19:51.931 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr ; (  ) 2. * z 0 - x 3. * y }`
Sep 20 06:19:51.931 INFO kablam!    = note: to `{
Sep 20 06:19:51.931 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.932 INFO kablam!            ( z z ) => { axpy ! [ # z ; car ; cdr ; ( + 2. * * car ) 0 - x 3. * y ] } ; (
Sep 20 06:19:51.932 INFO kablam!            z z ) => { axpy ! [ # z ; car ; cdr . 1 ; ( + 2. * * cdr . 0 ) 0 - x 3. * y ]
Sep 20 06:19:51.932 INFO kablam!            } ; } eval ! ( z z ) }`
Sep 20 06:19:51.932 INFO kablam!    = note: expanding `eval! { z z }`
Sep 20 06:19:51.932 INFO kablam!    = note: to `axpy ! [ # z ; car ; cdr ; ( + 2. * * car ) 0 - x 3. * y ]`
Sep 20 06:19:51.932 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr ; ( + 2. * * car ) 0 - x 3. * y }`
Sep 20 06:19:51.933 INFO kablam!    = note: to `{
Sep 20 06:19:51.933 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.933 INFO kablam!            ( z z ) => { axpy ! [ # z ; car ; cdr ; ( + 2. * * car + - * car ) 3. * y ] }
Sep 20 06:19:51.933 INFO kablam!            ; ( x z ) => {
Sep 20 06:19:51.933 INFO kablam!            axpy ! [ # z ; car ; cdr . 1 ; ( + 2. * * car + - * cdr . 0 ) 3. * y ] } ; }
Sep 20 06:19:51.934 INFO kablam!            eval ! ( x z ) }`
Sep 20 06:19:51.934 INFO kablam!    = note: expanding `eval! { x z }`
Sep 20 06:19:51.934 INFO kablam!    = note: to `axpy ! [ # z ; car ; cdr . 1 ; ( + 2. * * car + - * cdr . 0 ) 3. * y ]`
Sep 20 06:19:51.934 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr . 1 ; ( + 2. * * car + - * cdr . 0 ) 3. * y }`
Sep 20 06:19:51.934 INFO kablam!    = note: to `{
Sep 20 06:19:51.934 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.934 INFO kablam!            ( z z ) => {
Sep 20 06:19:51.935 INFO kablam!            axpy ! [ # z ; car ; cdr.1 ; ( + 2. * * car + - * cdr . 0 + 3. * * car ) ] } ;
Sep 20 06:19:51.935 INFO kablam!            ( y z ) => {
Sep 20 06:19:51.935 INFO kablam!            axpy ! [
Sep 20 06:19:51.935 INFO kablam!            # z ; car ; cdr.1 . 1 ; ( + 2. * * car + - * cdr . 0 + 3. * * cdr.1 . 0 ) ] }
Sep 20 06:19:51.935 INFO kablam!            ; } eval ! ( y z ) }`
Sep 20 06:19:51.935 INFO kablam!    = note: expanding `eval! { y z }`
Sep 20 06:19:51.935 INFO kablam!    = note: to `axpy ! [
Sep 20 06:19:51.936 INFO kablam!            # z ; car ; cdr.1 . 1 ; ( + 2. * * car + - * cdr . 0 + 3. * * cdr.1 . 0 ) ]`
Sep 20 06:19:51.936 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr.1 . 1 ; ( + 2. * * car + - * cdr . 0 + 3. * * cdr.1 . 0 ) }`
Sep 20 06:19:51.936 INFO kablam!    = note: to `2. * * car + - * cdr . 0 + 3. * * cdr.1 . 0`
Sep 20 06:19:51.936 INFO kablam! 
Sep 20 06:19:51.936 INFO kablam! note: trace_macro
Sep 20 06:19:51.936 INFO kablam!   --> tests/trace.rs:11:5
Sep 20 06:19:51.936 INFO kablam!    |
Sep 20 06:19:51.936 INFO kablam! 11 |     axpy![z = x + y];
Sep 20 06:19:51.937 INFO kablam!    |     ^^^^^^^^^^^^^^^^^
Sep 20 06:19:51.937 INFO kablam!    |
Sep 20 06:19:51.937 INFO kablam!    = note: expanding `axpy! { z = x + y }`
Sep 20 06:19:51.937 INFO kablam!    = note: to `axpy ! [ ! z = (  ) x + y + . ]`
Sep 20 06:19:51.937 INFO kablam!    = note: expanding `axpy! { ! z = (  ) x + y + . }`
Sep 20 06:19:51.937 INFO kablam!    = note: to `axpy ! [ ! z = ( 0 + x ) + y + . ]`
Sep 20 06:19:51.937 INFO kablam!    = note: expanding `axpy! { ! z = ( 0 + x ) + y + . }`
Sep 20 06:19:51.938 INFO kablam!    = note: to `axpy ! [ ! z = ( 0 + x 0 + y ) + . ]`
Sep 20 06:19:51.938 INFO kablam!    = note: expanding `axpy! { ! z = ( 0 + x 0 + y ) + . }`
Sep 20 06:19:51.938 INFO kablam!    = note: to `for ( car , cdr ) in axpy ! [ @ z ; z . iter_mut (  ) ; 0 + x 0 + y ] {
Sep 20 06:19:51.938 INFO kablam!            * car = axpy ! [ # z ; car ; cdr ; (  ) 0 + x 0 + y ] ; }`
Sep 20 06:19:51.938 INFO kablam!    = note: expanding `axpy! { @ z ; z . iter_mut (  ) ; 0 + x 0 + y }`
Sep 20 06:19:51.938 INFO kablam!    = note: to `{
Sep 20 06:19:51.938 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.939 INFO kablam!            ( z z ) => { axpy ! [ @ z ; z.iter_mut() ; 0 + y ] } ; ( x z ) => {
Sep 20 06:19:51.939 INFO kablam!            z.iter_mut() . zip ( axpy ! [ @ z ; x . iter (  ) ; 0 + y ] ) } ; } eval ! (
Sep 20 06:19:51.939 INFO kablam!            x z ) }`
Sep 20 06:19:51.939 INFO kablam!    = note: expanding `eval! { x z }`
Sep 20 06:19:51.939 INFO kablam!    = note: to `z.iter_mut() . zip ( axpy ! [ @ z ; x . iter (  ) ; 0 + y ] )`
Sep 20 06:19:51.939 INFO kablam!    = note: expanding `axpy! { @ z ; x . iter (  ) ; 0 + y }`
Sep 20 06:19:51.939 INFO kablam!    = note: to `{
Sep 20 06:19:51.940 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.940 INFO kablam!            ( z z ) => { axpy ! [ @ z ; x.iter() ; ] } ; ( y z ) => {
Sep 20 06:19:51.940 INFO kablam!            x.iter() . zip ( axpy ! [ @ z ; y . iter (  ) ; ] ) } ; } eval ! ( y z ) }`
Sep 20 06:19:51.940 INFO kablam!    = note: expanding `eval! { y z }`
Sep 20 06:19:51.940 INFO kablam!    = note: to `x.iter() . zip ( axpy ! [ @ z ; y . iter (  ) ; ] )`
Sep 20 06:19:51.940 INFO kablam!    = note: expanding `axpy! { @ z ; y . iter (  ) ; }`
Sep 20 06:19:51.940 INFO kablam!    = note: to `y.iter() . map ( | x | ( x , ) )`
Sep 20 06:19:51.941 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr ; (  ) 0 + x 0 + y }`
Sep 20 06:19:51.941 INFO kablam!    = note: to `{
Sep 20 06:19:51.941 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.941 INFO kablam!            ( z z ) => { axpy ! [ # z ; car ; cdr ; ( + * car ) 0 + y ] } ; ( x z ) => {
Sep 20 06:19:51.941 INFO kablam!            axpy ! [ # z ; car ; cdr . 1 ; ( + * cdr . 0 ) 0 + y ] } ; } eval ! ( x z ) }`
Sep 20 06:19:51.941 INFO kablam!    = note: expanding `eval! { x z }`
Sep 20 06:19:51.942 INFO kablam!    = note: to `axpy ! [ # z ; car ; cdr . 1 ; ( + * cdr . 0 ) 0 + y ]`
Sep 20 06:19:51.942 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr . 1 ; ( + * cdr . 0 ) 0 + y }`
Sep 20 06:19:51.942 INFO kablam!    = note: to `{
Sep 20 06:19:51.942 INFO kablam!            macro_rules ! eval {
Sep 20 06:19:51.942 INFO kablam!            ( z z ) => { axpy ! [ # z ; car ; cdr.1 ; ( + * cdr . 0 + * car ) ] } ; ( y z
Sep 20 06:19:51.942 INFO kablam!            ) => { axpy ! [ # z ; car ; cdr.1 . 1 ; ( + * cdr . 0 + * cdr.1 . 0 ) ] } ; }
Sep 20 06:19:51.942 INFO kablam!            eval ! ( y z ) }`
Sep 20 06:19:51.943 INFO kablam!    = note: expanding `eval! { y z }`
Sep 20 06:19:51.943 INFO kablam!    = note: to `axpy ! [ # z ; car ; cdr.1 . 1 ; ( + * cdr . 0 + * cdr.1 . 0 ) ]`
Sep 20 06:19:51.943 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr.1 . 1 ; ( + * cdr . 0 + * cdr.1 . 0 ) }`
Sep 20 06:19:51.943 INFO kablam!    = note: to `* cdr . 0 + * cdr.1 . 0`
Sep 20 06:19:51.943 INFO kablam! 
Sep 20 06:19:51.943 INFO kablam! note: trace_macro
Sep 20 06:19:51.943 INFO kablam!   --> tests/trace.rs:12:5
Sep 20 06:19:51.944 INFO kablam!    |
Sep 20 06:19:51.944 INFO kablam! 12 |     assert_eq!(z, [5, 5, 5, 5]);
Sep 20 06:19:51.944 INFO kablam!    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Sep 20 06:19:51.944 INFO kablam!    |
Sep 20 06:19:51.944 INFO kablam!    = note: expanding `assert_eq! { z , [ 5 , 5 , 5 , 5 ] }`
Sep 20 06:19:51.944 INFO kablam!    = note: to `{
Sep 20 06:19:51.945 INFO kablam!            match ( & z , & [5, 5, 5, 5] ) {
Sep 20 06:19:51.945 INFO kablam!            ( left_val , right_val ) => {
Sep 20 06:19:51.945 INFO kablam!            if ! ( * left_val == * right_val ) {
Sep 20 06:19:51.945 INFO kablam!            panic ! (
Sep 20 06:19:51.945 INFO kablam!            r#"assertion failed: `(left == right)`
Sep 20 06:19:51.945 INFO kablam!              left: `{:?}`,
Sep 20 06:19:51.945 INFO kablam!             right: `{:?}`"# ,
Sep 20 06:19:51.946 INFO kablam!            left_val , right_val ) } } } }`
Sep 20 06:19:51.946 INFO kablam!    = note: expanding `panic! { r#"assertion failed: `(left == right)`
Sep 20 06:19:51.946 INFO kablam!              left: `{:?}`,
Sep 20 06:19:51.946 INFO kablam!             right: `{:?}`"# ,
Sep 20 06:19:51.946 INFO kablam!            left_val , right_val }`
Sep 20 06:19:51.946 INFO kablam!    = note: to `{
Sep 20 06:19:51.947 INFO kablam!            $crate :: rt :: begin_panic_fmt (
Sep 20 06:19:51.947 INFO kablam!            & format_args ! (
Sep 20 06:19:51.947 INFO kablam!            r#"assertion failed: `(left == right)`
Sep 20 06:19:51.947 INFO kablam!              left: `{:?}`,
Sep 20 06:19:51.947 INFO kablam!             right: `{:?}`"# ,
Sep 20 06:19:51.947 INFO kablam!            left_val , right_val ) , & (
Sep 20 06:19:51.947 INFO kablam!            file ! (  ) , line ! (  ) , __rust_unstable_column ! (  ) ) ) }`
Sep 20 06:19:51.947 INFO kablam! 
Sep 20 06:19:51.948 INFO kablam! note: trace_macro
Sep 20 06:19:51.948 INFO kablam!   --> tests/trace.rs:21:5
Sep 20 06:19:51.948 INFO kablam!    |
Sep 20 06:19:51.948 INFO kablam! 21 |     assert_eq!(z, [31f64, 207., 2003., 19999.]);
Sep 20 06:19:51.948 INFO kablam!    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Sep 20 06:19:51.948 INFO kablam!    |
Sep 20 06:19:51.949 INFO kablam!    = note: expanding `assert_eq! { z , [ 31f64 , 207. , 2003. , 19999. ] }`
Sep 20 06:19:51.949 INFO kablam!    = note: to `{
Sep 20 06:19:51.949 INFO kablam!            match ( & z , & [31f64, 207., 2003., 19999.] ) {
Sep 20 06:19:51.949 INFO kablam!            ( left_val , right_val ) => {
Sep 20 06:19:51.949 INFO kablam!            if ! ( * left_val == * right_val ) {
Sep 20 06:19:51.949 INFO kablam!            panic ! (
Sep 20 06:19:51.950 INFO kablam!            r#"assertion failed: `(left == right)`
Sep 20 06:19:51.950 INFO kablam!              left: `{:?}`,
Sep 20 06:19:51.950 INFO kablam!             right: `{:?}`"# ,
Sep 20 06:19:51.950 INFO kablam!            left_val , right_val ) } } } }`
Sep 20 06:19:51.950 INFO kablam!    = note: expanding `panic! { r#"assertion failed: `(left == right)`
Sep 20 06:19:51.950 INFO kablam!              left: `{:?}`,
Sep 20 06:19:51.950 INFO kablam!             right: `{:?}`"# ,
Sep 20 06:19:51.951 INFO kablam!            left_val , right_val }`
Sep 20 06:19:51.951 INFO kablam!    = note: to `{
Sep 20 06:19:51.951 INFO kablam!            $crate :: rt :: begin_panic_fmt (
Sep 20 06:19:51.951 INFO kablam!            & format_args ! (
Sep 20 06:19:51.951 INFO kablam!            r#"assertion failed: `(left == right)`
Sep 20 06:19:51.951 INFO kablam!              left: `{:?}`,
Sep 20 06:19:51.951 INFO kablam!             right: `{:?}`"# ,
Sep 20 06:19:51.952 INFO kablam!            left_val , right_val ) , & (
Sep 20 06:19:51.952 INFO kablam!            file ! (  ) , line ! (  ) , __rust_unstable_column ! (  ) ) ) }`
Sep 20 06:19:51.952 INFO kablam! 
Sep 20 06:19:52.083 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 1.15s
Sep 20 06:19:52.086 INFO kablam! su: No module specific data is present
Sep 20 06:19:53.216 INFO running `"docker" "rm" "-f" "4b9be6212aab89a154060ba6fce39748070c7aac7c250bf5dc81cb31299d6f07"`
Sep 20 06:19:53.334 INFO blam! 4b9be6212aab89a154060ba6fce39748070c7aac7c250bf5dc81cb31299d6f07