Test passed in 25 seconds on Nexus 4
| Timestamp | Level | Tag | Message |
|---|---|---|---|
| 02-12 10:27:59.112 | info | TestRunner | started: testMakeASandwich_ItTastesGood(com.example.spoon.ordering.tests.OrderActivityTest) |
| 02-12 10:28:00.514 | debug | dalvikvm | GC_FOR_ALLOC freed 232K, 4% free 9492K/9804K, paused 14ms, total 15ms |
| 02-12 10:28:00.524 | info | dalvikvm-heap | Grow heap (frag case) to 12.761MB for 3637264-byte allocation |
| 02-12 10:28:00.544 | debug | dalvikvm | GC_FOR_ALLOC freed 1K, 3% free 13043K/13360K, paused 20ms, total 20ms |
| 02-12 10:28:00.564 | debug | dalvikvm | GC_CONCURRENT freed 6K, 3% free 13037K/13360K, paused 3ms+1ms, total 22ms |
| 02-12 10:28:02.226 | debug | dalvikvm | GC_FOR_ALLOC freed 3639K, 3% free 9525K/9804K, paused 20ms, total 20ms |
| 02-12 10:28:02.236 | info | dalvikvm-heap | Grow heap (frag case) to 12.794MB for 3637264-byte allocation |
| 02-12 10:28:02.256 | debug | dalvikvm | GC_CONCURRENT freed <1K, 3% free 13077K/13360K, paused 3ms+3ms, total 22ms |
| 02-12 10:28:02.256 | debug | dalvikvm | WAIT_FOR_CONCURRENT_GC blocked 20ms |
| 02-12 10:28:02.256 | debug | dalvikvm | WAIT_FOR_CONCURRENT_GC blocked 20ms |
| 02-12 10:28:03.367 | debug | dalvikvm | GC_FOR_ALLOC freed 3614K, 3% free 9524K/9804K, paused 19ms, total 19ms |
| 02-12 10:28:03.377 | info | dalvikvm-heap | Grow heap (frag case) to 12.792MB for 3637264-byte allocation |
| 02-12 10:28:03.397 | debug | dalvikvm | GC_FOR_ALLOC freed <1K, 3% free 13076K/13360K, paused 19ms, total 19ms |
| 02-12 10:28:03.417 | debug | dalvikvm | GC_CONCURRENT freed 0K, 3% free 13076K/13360K, paused 3ms+1ms, total 17ms |
| 02-12 10:28:05.028 | debug | dalvikvm | GC_FOR_ALLOC freed 3664K, 3% free 9565K/9804K, paused 21ms, total 21ms |
| 02-12 10:28:05.039 | info | dalvikvm-heap | Grow heap (frag case) to 12.833MB for 3637264-byte allocation |
| 02-12 10:28:05.059 | debug | dalvikvm | GC_FOR_ALLOC freed 3K, 2% free 13113K/13360K, paused 20ms, total 20ms |
| 02-12 10:28:05.079 | debug | dalvikvm | GC_CONCURRENT freed 7K, 2% free 13114K/13360K, paused 3ms+3ms, total 22ms |
| 02-12 10:28:06.210 | debug | dalvikvm | GC_FOR_ALLOC freed 3617K, 3% free 9604K/9804K, paused 16ms, total 16ms |
| 02-12 10:28:06.220 | info | dalvikvm-heap | Grow heap (frag case) to 12.871MB for 3637264-byte allocation |
| 02-12 10:28:06.230 | debug | dalvikvm | GC_FOR_ALLOC freed 16K, 2% free 13139K/13360K, paused 17ms, total 17ms |
| 02-12 10:28:06.250 | debug | dalvikvm | GC_CONCURRENT freed 7K, 2% free 13132K/13360K, paused 2ms+2ms, total 18ms |
| 02-12 10:28:09.033 | debug | dalvikvm | GC_FOR_ALLOC freed 3729K, 3% free 9594K/9804K, paused 23ms, total 23ms |
| 02-12 10:28:09.043 | info | dalvikvm-heap | Grow heap (frag case) to 12.861MB for 3637264-byte allocation |
| 02-12 10:28:09.063 | debug | dalvikvm | GC_FOR_ALLOC freed <1K, 2% free 13146K/13360K, paused 19ms, total 19ms |
| 02-12 10:28:09.103 | debug | dalvikvm | GC_CONCURRENT freed 10K, 2% free 13148K/13360K, paused 3ms+2ms, total 37ms |
| 02-12 10:28:10.204 | debug | dalvikvm | GC_FOR_ALLOC freed 3642K, 3% free 9607K/9804K, paused 21ms, total 21ms |
| 02-12 10:28:10.224 | info | dalvikvm-heap | Grow heap (frag case) to 12.874MB for 3637264-byte allocation |
| 02-12 10:28:10.244 | debug | dalvikvm | GC_FOR_ALLOC freed 7K, 2% free 13151K/13360K, paused 20ms, total 20ms |
| 02-12 10:28:10.284 | debug | dalvikvm | GC_CONCURRENT freed 5K, 2% free 13159K/13360K, paused 3ms+25ms, total 45ms |
| 02-12 10:28:14.168 | debug | dalvikvm | GC_FOR_ALLOC freed 3808K, 29% free 9614K/13452K, paused 20ms, total 20ms |
| 02-12 10:28:14.178 | info | dalvikvm-heap | Grow heap (frag case) to 12.881MB for 3637264-byte allocation |
| 02-12 10:28:14.198 | debug | dalvikvm | GC_FOR_ALLOC freed <1K, 3% free 13166K/13452K, paused 19ms, total 19ms |
| 02-12 10:28:14.208 | debug | dalvikvm | GC_CONCURRENT freed 14K, 3% free 13152K/13452K, paused 1ms+2ms, total 15ms |
| 02-12 10:28:15.340 | debug | dalvikvm | GC_FOR_ALLOC freed 3647K, 29% free 9589K/13452K, paused 20ms, total 21ms |
| 02-12 10:28:15.340 | info | dalvikvm-heap | Grow heap (frag case) to 12.856MB for 3637264-byte allocation |
| 02-12 10:28:15.360 | debug | dalvikvm | GC_FOR_ALLOC freed 9K, 3% free 13132K/13452K, paused 24ms, total 24ms |
| 02-12 10:28:15.400 | debug | dalvikvm | GC_CONCURRENT freed 2K, 3% free 13143K/13452K, paused 5ms+3ms, total 38ms |
| 02-12 10:28:17.011 | debug | dalvikvm | GC_FOR_ALLOC freed 3653K, 29% free 9586K/13452K, paused 18ms, total 19ms |
| 02-12 10:28:17.011 | info | dalvikvm-heap | Grow heap (frag case) to 12.853MB for 3637264-byte allocation |
| 02-12 10:28:17.031 | debug | dalvikvm | GC_FOR_ALLOC freed <1K, 3% free 13138K/13452K, paused 20ms, total 20ms |
| 02-12 10:28:17.061 | debug | dalvikvm | GC_CONCURRENT freed 5K, 3% free 13146K/13452K, paused 3ms+8ms, total 31ms |
| 02-12 10:28:18.153 | debug | dalvikvm | GC_FOR_ALLOC freed 3657K, 29% free 9584K/13452K, paused 16ms, total 16ms |
| 02-12 10:28:18.153 | info | dalvikvm-heap | Grow heap (frag case) to 12.851MB for 3637264-byte allocation |
| 02-12 10:28:18.173 | debug | dalvikvm | GC_FOR_ALLOC freed 7K, 3% free 13128K/13452K, paused 15ms, total 15ms |
| 02-12 10:28:18.193 | debug | dalvikvm | GC_CONCURRENT freed 2K, 3% free 13139K/13452K, paused 2ms+6ms, total 24ms |
| 02-12 10:28:20.285 | debug | dalvikvm | GC_FOR_ALLOC freed 3729K, 30% free 9542K/13452K, paused 27ms, total 27ms |
| 02-12 10:28:20.295 | info | dalvikvm-heap | Grow heap (frag case) to 12.811MB for 3637264-byte allocation |
| 02-12 10:28:20.315 | debug | dalvikvm | GC_FOR_ALLOC freed 5K, 3% free 13089K/13452K, paused 20ms, total 20ms |
| 02-12 10:28:20.335 | debug | dalvikvm | GC_CONCURRENT freed 7K, 3% free 13082K/13452K, paused 2ms+3ms, total 27ms |
| 02-12 10:28:22.767 | debug | dalvikvm | GC_FOR_ALLOC freed 4142K, 31% free 9715K/13884K, paused 16ms, total 16ms |
| 02-12 10:28:22.767 | info | dalvikvm-heap | Grow heap (frag case) to 12.979MB for 3637264-byte allocation |
| 02-12 10:28:22.787 | debug | dalvikvm | GC_CONCURRENT freed 24K, 5% free 13242K/13884K, paused 3ms+2ms, total 19ms |
| 02-12 10:28:22.787 | debug | dalvikvm | WAIT_FOR_CONCURRENT_GC blocked 14ms |
| 02-12 10:28:22.787 | debug | dalvikvm | WAIT_FOR_CONCURRENT_GC blocked 12ms |
| 02-12 10:28:22.787 | debug | dalvikvm | WAIT_FOR_CONCURRENT_GC blocked 11ms |
| 02-12 10:28:23.919 | debug | dalvikvm | GC_FOR_ALLOC freed 3727K, 31% free 9608K/13884K, paused 15ms, total 15ms |
| 02-12 10:28:23.919 | info | dalvikvm-heap | Grow heap (frag case) to 12.875MB for 3637264-byte allocation |
| 02-12 10:28:23.929 | debug | dalvikvm | GC_FOR_ALLOC freed 2K, 6% free 13158K/13884K, paused 15ms, total 15ms |
| 02-12 10:28:23.949 | debug | dalvikvm | GC_CONCURRENT freed 8K, 6% free 13150K/13884K, paused 3ms+1ms, total 19ms |
| 02-12 10:28:24.499 | debug | dalvikvm | GC_EXPLICIT freed 3585K, 32% free 9577K/13884K, paused 2ms+3ms, total 24ms |
| 02-12 10:28:24.529 | debug | dalvikvm | GC_EXPLICIT freed 6K, 32% free 9572K/13884K, paused 1ms+5ms, total 25ms |
| 02-12 10:28:24.529 | info | TestRunner | finished: testMakeASandwich_ItTastesGood(com.example.spoon.ordering.tests.OrderActivityTest) |