103-26 16:21:42 I/ModuleRepo: chromeos2-row8-rack4-host19:22 running 1 modules, expected to complete in 6m 38s 203-26 16:21:42 I/CompatibilityTest: Starting 1 module on chromeos2-row8-rack4-host19:22 303-26 16:21:42 D/ConfigurationFactory: Loading configuration 'system-status-checkers' 403-26 16:21:42 D/ModuleDef: Preparer: LocationCheck 503-26 16:21:42 I/PreconditionPreparer: Value true for option skip-media-download not applicable for class com.android.compatibility.common.tradefed.targetprep.LocationCheck 603-26 16:21:42 I/PreconditionPreparer: Value true for option skip-media-download not applicable for class com.android.compatibility.common.tradefed.targetprep.LocationCheck 703-26 16:21:43 I/CompatibilityTest: Running system status checker before module execution: CtsAppTestCases 803-26 16:21:43 D/ModuleDef: Preparer: ApkInstaller 903-26 16:21:43 D/TestAppInstallSetup: Installing apk from /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/testcases/CtsSimpleApp.apk ... 1003-26 16:21:43 D/CtsSimpleApp.apk: Uploading CtsSimpleApp.apk onto device 'chromeos2-row8-rack4-host19:22' 1103-26 16:21:43 D/Device: Uploading file onto device 'chromeos2-row8-rack4-host19:22' 1203-26 16:21:44 D/RunUtil: Running command with timeout: 60000ms 1303-26 16:21:44 D/RunUtil: Running [aapt, dump, badging, /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/testcases/CtsSimpleApp.apk] 1403-26 16:21:44 D/TestAppInstallSetup: Installing apk from /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/testcases/CtsAppTestStubs.apk ... 1503-26 16:21:44 D/CtsAppTestStubs.apk: Uploading CtsAppTestStubs.apk onto device 'chromeos2-row8-rack4-host19:22' 1603-26 16:21:44 D/Device: Uploading file onto device 'chromeos2-row8-rack4-host19:22' 1703-26 16:21:47 D/RunUtil: Running command with timeout: 60000ms 1803-26 16:21:47 D/RunUtil: Running [aapt, dump, badging, /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/testcases/CtsAppTestStubs.apk] 1903-26 16:21:47 D/TestAppInstallSetup: Installing apk from /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/testcases/CtsAppTestCases.apk ... 2003-26 16:21:47 D/CtsAppTestCases.apk: Uploading CtsAppTestCases.apk onto device 'chromeos2-row8-rack4-host19:22' 2103-26 16:21:47 D/Device: Uploading file onto device 'chromeos2-row8-rack4-host19:22' 2203-26 16:21:49 D/RunUtil: Running command with timeout: 60000ms 2303-26 16:21:49 D/RunUtil: Running [aapt, dump, badging, /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/testcases/CtsAppTestCases.apk] 2403-26 16:21:49 D/ModuleDef: Test: AndroidJUnitTest 2503-26 16:21:49 D/InstrumentationTest: Collecting test info for android.app.cts on device chromeos2-row8-rack4-host19:22 2603-26 16:21:49 I/RemoteAndroidTest: Running am instrument -w -r --abi x86 -e testFile /data/local/tmp/ajur/includes.txt -e debug false -e log true -e timeout_msec 300000 android.app.cts/android.support.test.runner.AndroidJUnitRunner on google-chromebook_11_model_3180-chromeos2-row8-rack4-host19:22 2703-26 16:21:50 I/RemoteAndroidTest: Running am instrument -w -r --abi x86 -e testFile /data/local/tmp/ajur/includes.txt -e debug false -e log false -e timeout_msec 300000 android.app.cts/android.support.test.runner.AndroidJUnitRunner on google-chromebook_11_model_3180-chromeos2-row8-rack4-host19:22 2803-26 16:21:51 D/ModuleListener: ModuleListener.testRunStarted(android.app.cts, 5) 2903-26 16:21:51 I/ConsoleReporter: [chromeos2-row8-rack4-host19:22] Starting x86 CtsAppTestCases with 5 tests 3003-26 16:21:51 D/ModuleListener: ModuleListener.testStarted(android.app.cts.LifecycleTest#testTabBasic) 3103-26 16:21:51 D/ModuleListener: ModuleListener.testEnded(android.app.cts.LifecycleTest#testTabBasic, {}) 3203-26 16:21:51 I/ConsoleReporter: [1/5 x86 CtsAppTestCases chromeos2-row8-rack4-host19:22] android.app.cts.LifecycleTest#testTabBasic pass 3303-26 16:21:51 D/ModuleListener: ModuleListener.testStarted(android.app.cts.SystemFeaturesTest#testCameraFeatures) 3403-26 16:21:51 D/ModuleListener: ModuleListener.testFailed(android.app.cts.SystemFeaturesTest#testCameraFeatures, junit.framework.AssertionFailedError: PackageManager#hasSystemFeature should NOT return true for android.hardware.camera.front 35at junit.framework.Assert.fail(Assert.java:50) 36at junit.framework.Assert.assertTrue(Assert.java:20) 37at junit.framework.Assert.assertFalse(Assert.java:34) 38at android.app.cts.SystemFeaturesTest.assertNotAvailable(SystemFeaturesTest.java:508) 39at android.app.cts.SystemFeaturesTest.testCameraFeatures(SystemFeaturesTest.java:122) 40at java.lang.reflect.Method.invoke(Native Method) 41at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:220) 42at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:205) 43at junit.framework.TestCase.runBare(TestCase.java:134) 44at junit.framework.TestResult$1.protect(TestResult.java:115) 45at android.support.test.internal.runner.junit3.AndroidTestResult.runProtected(AndroidTestResult.java:77) 46at junit.framework.TestResult.run(TestResult.java:118) 47at android.support.test.internal.runner.junit3.AndroidTestResult.run(AndroidTestResult.java:55) 48at junit.framework.TestCase.run(TestCase.java:124) 49at android.support.test.internal.runner.junit3.NonLeakyTestSuite$NonLeakyTest.run(NonLeakyTestSuite.java:63) 50at android.support.test.internal.runner.junit3.AndroidTestSuite$1.run(AndroidTestSuite.java:97) 51at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428) 52at java.util.concurrent.FutureTask.run(FutureTask.java:237) 53at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 54at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 55at java.lang.Thread.run(Thread.java:761) 56) 5703-26 16:21:51 I/ConsoleReporter: [2/5 x86 CtsAppTestCases chromeos2-row8-rack4-host19:22] android.app.cts.SystemFeaturesTest#testCameraFeatures fail: junit.framework.AssertionFailedError: PackageManager#hasSystemFeature should NOT return true for android.hardware.camera.front 58at junit.framework.Assert.fail(Assert.java:50) 59at junit.framework.Assert.assertTrue(Assert.java:20) 60at junit.framework.Assert.assertFalse(Assert.java:34) 61at android.app.cts.SystemFeaturesTest.assertNotAvailable(SystemFeaturesTest.java:508) 62at android.app.cts.SystemFeaturesTest.testCameraFeatures(SystemFeaturesTest.java:122) 63at java.lang.reflect.Method.invoke(Native Method) 64at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:220) 65at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:205) 66at junit.framework.TestCase.runBare(TestCase.java:134) 67at junit.framework.TestResult$1.protect(TestResult.java:115) 68at android.support.test.internal.runner.junit3.AndroidTestResult.runProtected(AndroidTestResult.java:77) 69at junit.framework.TestResult.run(TestResult.java:118) 70at android.support.test.internal.runner.junit3.AndroidTestResult.run(AndroidTestResult.java:55) 71at junit.framework.TestCase.run(TestCase.java:124) 72at android.support.test.internal.runner.junit3.NonLeakyTestSuite$NonLeakyTest.run(NonLeakyTestSuite.java:63) 73at android.support.test.internal.runner.junit3.AndroidTestSuite$1.run(AndroidTestSuite.java:97) 74at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428) 75at java.util.concurrent.FutureTask.run(FutureTask.java:237) 76at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 77at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 78at java.lang.Thread.run(Thread.java:761) 79 8003-26 16:21:51 I/FailureListener: FailureListener.testFailed android.app.cts.SystemFeaturesTest#testCameraFeatures false true false 8103-26 16:21:53 D/FileUtil: Creating temp file at /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05 with prefix "android.app.cts.SystemFeaturesTest#testCameraFeatures-logcat_" suffix ".zip" 8203-26 16:21:53 I/LogFileSaver: Saved log file /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05/android.app.cts.SystemFeaturesTest#testCameraFeatures-logcat_8762735968762869316.zip 8303-26 16:21:53 I/ResultReporter: Saved logs for android.app.cts.SystemFeaturesTest#testCameraFeatures-logcat in /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05/android.app.cts.SystemFeaturesTest#testCameraFeatures-logcat_8762735968762869316.zip 8403-26 16:21:53 D/FileUtil: Creating temp file at /tmp/3764431/cts/inv_4137984894364964943 with prefix "android.app.cts.SystemFeaturesTest#testCameraFeatures-logcat_" suffix ".zip" 8503-26 16:21:53 D/RunUtil: Running command with timeout: 10000ms 8603-26 16:21:53 D/RunUtil: Running [chmod] 8703-26 16:21:53 D/RunUtil: [chmod] command failed. return code 1 8803-26 16:21:53 D/FileUtil: Attempting to chmod /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.SystemFeaturesTest#testCameraFeatures-logcat_6209762295598580632.zip to ug+rwx 8903-26 16:21:53 D/RunUtil: Running command with timeout: 10000ms 9003-26 16:21:53 D/RunUtil: Running [chmod, ug+rwx, /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.SystemFeaturesTest#testCameraFeatures-logcat_6209762295598580632.zip] 9103-26 16:21:54 I/FileSystemLogSaver: Saved log file /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.SystemFeaturesTest#testCameraFeatures-logcat_6209762295598580632.zip 9203-26 16:21:54 D/ModuleListener: ModuleListener.testEnded(android.app.cts.SystemFeaturesTest#testCameraFeatures, {}) 9303-26 16:21:54 D/ModuleListener: ModuleListener.testStarted(android.app.cts.SystemFeaturesTest#testUsbAccessory) 9403-26 16:21:54 D/ModuleListener: ModuleListener.testFailed(android.app.cts.SystemFeaturesTest#testUsbAccessory, junit.framework.AssertionFailedError: PackageManager#hasSystemFeature should return true for android.hardware.usb.accessory 95at junit.framework.Assert.fail(Assert.java:50) 96at junit.framework.Assert.assertTrue(Assert.java:20) 97at android.app.cts.SystemFeaturesTest.assertAvailable(SystemFeaturesTest.java:501) 98at android.app.cts.SystemFeaturesTest.testUsbAccessory(SystemFeaturesTest.java:481) 99at java.lang.reflect.Method.invoke(Native Method) 100at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:220) 101at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:205) 102at junit.framework.TestCase.runBare(TestCase.java:134) 103at junit.framework.TestResult$1.protect(TestResult.java:115) 104at android.support.test.internal.runner.junit3.AndroidTestResult.runProtected(AndroidTestResult.java:77) 105at junit.framework.TestResult.run(TestResult.java:118) 106at android.support.test.internal.runner.junit3.AndroidTestResult.run(AndroidTestResult.java:55) 107at junit.framework.TestCase.run(TestCase.java:124) 108at android.support.test.internal.runner.junit3.NonLeakyTestSuite$NonLeakyTest.run(NonLeakyTestSuite.java:63) 109at android.support.test.internal.runner.junit3.AndroidTestSuite$1.run(AndroidTestSuite.java:97) 110at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428) 111at java.util.concurrent.FutureTask.run(FutureTask.java:237) 112at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 113at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 114at java.lang.Thread.run(Thread.java:761) 115) 11603-26 16:21:54 I/ConsoleReporter: [3/5 x86 CtsAppTestCases chromeos2-row8-rack4-host19:22] android.app.cts.SystemFeaturesTest#testUsbAccessory fail: junit.framework.AssertionFailedError: PackageManager#hasSystemFeature should return true for android.hardware.usb.accessory 117at junit.framework.Assert.fail(Assert.java:50) 118at junit.framework.Assert.assertTrue(Assert.java:20) 119at android.app.cts.SystemFeaturesTest.assertAvailable(SystemFeaturesTest.java:501) 120at android.app.cts.SystemFeaturesTest.testUsbAccessory(SystemFeaturesTest.java:481) 121at java.lang.reflect.Method.invoke(Native Method) 122at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:220) 123at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:205) 124at junit.framework.TestCase.runBare(TestCase.java:134) 125at junit.framework.TestResult$1.protect(TestResult.java:115) 126at android.support.test.internal.runner.junit3.AndroidTestResult.runProtected(AndroidTestResult.java:77) 127at junit.framework.TestResult.run(TestResult.java:118) 128at android.support.test.internal.runner.junit3.AndroidTestResult.run(AndroidTestResult.java:55) 129at junit.framework.TestCase.run(TestCase.java:124) 130at android.support.test.internal.runner.junit3.NonLeakyTestSuite$NonLeakyTest.run(NonLeakyTestSuite.java:63) 131at android.support.test.internal.runner.junit3.AndroidTestSuite$1.run(AndroidTestSuite.java:97) 132at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428) 133at java.util.concurrent.FutureTask.run(FutureTask.java:237) 134at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 135at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 136at java.lang.Thread.run(Thread.java:761) 137 13803-26 16:21:54 I/FailureListener: FailureListener.testFailed android.app.cts.SystemFeaturesTest#testUsbAccessory false true false 13903-26 16:21:56 D/FileUtil: Creating temp file at /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05 with prefix "android.app.cts.SystemFeaturesTest#testUsbAccessory-logcat_" suffix ".zip" 14003-26 16:21:56 I/LogFileSaver: Saved log file /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05/android.app.cts.SystemFeaturesTest#testUsbAccessory-logcat_8167304123051235943.zip 14103-26 16:21:56 I/ResultReporter: Saved logs for android.app.cts.SystemFeaturesTest#testUsbAccessory-logcat in /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05/android.app.cts.SystemFeaturesTest#testUsbAccessory-logcat_8167304123051235943.zip 14203-26 16:21:56 D/FileUtil: Creating temp file at /tmp/3764431/cts/inv_4137984894364964943 with prefix "android.app.cts.SystemFeaturesTest#testUsbAccessory-logcat_" suffix ".zip" 14303-26 16:21:56 D/RunUtil: Running command with timeout: 10000ms 14403-26 16:21:56 D/RunUtil: Running [chmod] 14503-26 16:21:56 D/RunUtil: [chmod] command failed. return code 1 14603-26 16:21:56 D/FileUtil: Attempting to chmod /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.SystemFeaturesTest#testUsbAccessory-logcat_6713767646175932035.zip to ug+rwx 14703-26 16:21:56 D/RunUtil: Running command with timeout: 10000ms 14803-26 16:21:56 D/RunUtil: Running [chmod, ug+rwx, /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.SystemFeaturesTest#testUsbAccessory-logcat_6713767646175932035.zip] 14903-26 16:21:56 I/FileSystemLogSaver: Saved log file /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.SystemFeaturesTest#testUsbAccessory-logcat_6713767646175932035.zip 15003-26 16:21:56 D/ModuleListener: ModuleListener.testEnded(android.app.cts.SystemFeaturesTest#testUsbAccessory, {}) 15103-26 16:21:56 D/ModuleListener: ModuleListener.testStarted(android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit) 15203-26 16:21:56 D/ModuleListener: ModuleListener.testFailed(android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit, junit.framework.AssertionFailedError: expected:<3> but was:<1> 153at junit.framework.Assert.fail(Assert.java:50) 154at junit.framework.Assert.failNotEquals(Assert.java:287) 155at junit.framework.Assert.assertEquals(Assert.java:67) 156at junit.framework.Assert.assertEquals(Assert.java:199) 157at junit.framework.Assert.assertEquals(Assert.java:205) 158at android.app.cts.ActivityManagerTest.testTimeTrackingAPI_ChainedActivityExit(ActivityManagerTest.java:526) 159at java.lang.reflect.Method.invoke(Native Method) 160at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:220) 161at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:205) 162at junit.framework.TestCase.runBare(TestCase.java:134) 163at junit.framework.TestResult$1.protect(TestResult.java:115) 164at android.support.test.internal.runner.junit3.AndroidTestResult.runProtected(AndroidTestResult.java:77) 165at junit.framework.TestResult.run(TestResult.java:118) 166at android.support.test.internal.runner.junit3.AndroidTestResult.run(AndroidTestResult.java:55) 167at junit.framework.TestCase.run(TestCase.java:124) 168at android.support.test.internal.runner.junit3.NonLeakyTestSuite$NonLeakyTest.run(NonLeakyTestSuite.java:63) 169at android.support.test.internal.runner.junit3.AndroidTestSuite$1.run(AndroidTestSuite.java:97) 170at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428) 171at java.util.concurrent.FutureTask.run(FutureTask.java:237) 172at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 173at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 174at java.lang.Thread.run(Thread.java:761) 175) 17603-26 16:21:56 I/ConsoleReporter: [4/5 x86 CtsAppTestCases chromeos2-row8-rack4-host19:22] android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit fail: junit.framework.AssertionFailedError: expected:<3> but was:<1> 177at junit.framework.Assert.fail(Assert.java:50) 178at junit.framework.Assert.failNotEquals(Assert.java:287) 179at junit.framework.Assert.assertEquals(Assert.java:67) 180at junit.framework.Assert.assertEquals(Assert.java:199) 181at junit.framework.Assert.assertEquals(Assert.java:205) 182at android.app.cts.ActivityManagerTest.testTimeTrackingAPI_ChainedActivityExit(ActivityManagerTest.java:526) 183at java.lang.reflect.Method.invoke(Native Method) 184at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:220) 185at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:205) 186at junit.framework.TestCase.runBare(TestCase.java:134) 187at junit.framework.TestResult$1.protect(TestResult.java:115) 188at android.support.test.internal.runner.junit3.AndroidTestResult.runProtected(AndroidTestResult.java:77) 189at junit.framework.TestResult.run(TestResult.java:118) 190at android.support.test.internal.runner.junit3.AndroidTestResult.run(AndroidTestResult.java:55) 191at junit.framework.TestCase.run(TestCase.java:124) 192at android.support.test.internal.runner.junit3.NonLeakyTestSuite$NonLeakyTest.run(NonLeakyTestSuite.java:63) 193at android.support.test.internal.runner.junit3.AndroidTestSuite$1.run(AndroidTestSuite.java:97) 194at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428) 195at java.util.concurrent.FutureTask.run(FutureTask.java:237) 196at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 197at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 198at java.lang.Thread.run(Thread.java:761) 199 20003-26 16:21:56 I/FailureListener: FailureListener.testFailed android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit false true false 20103-26 16:21:58 D/FileUtil: Creating temp file at /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05 with prefix "android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit-logcat_" suffix ".zip" 20203-26 16:21:58 I/LogFileSaver: Saved log file /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit-logcat_6972528964795429366.zip 20303-26 16:21:58 I/ResultReporter: Saved logs for android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit-logcat in /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit-logcat_6972528964795429366.zip 20403-26 16:21:58 D/FileUtil: Creating temp file at /tmp/3764431/cts/inv_4137984894364964943 with prefix "android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit-logcat_" suffix ".zip" 20503-26 16:21:58 D/RunUtil: Running command with timeout: 10000ms 20603-26 16:21:58 D/RunUtil: Running [chmod] 20703-26 16:21:58 D/RunUtil: [chmod] command failed. return code 1 20803-26 16:21:58 D/FileUtil: Attempting to chmod /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit-logcat_969828295802539563.zip to ug+rwx 20903-26 16:21:58 D/RunUtil: Running command with timeout: 10000ms 21003-26 16:21:58 D/RunUtil: Running [chmod, ug+rwx, /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit-logcat_969828295802539563.zip] 21103-26 16:21:58 I/FileSystemLogSaver: Saved log file /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit-logcat_969828295802539563.zip 21203-26 16:21:58 D/ModuleListener: ModuleListener.testEnded(android.app.cts.ActivityManagerTest#testTimeTrackingAPI_ChainedActivityExit, {}) 21303-26 16:21:58 D/ModuleListener: ModuleListener.testStarted(android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit) 21403-26 16:21:58 D/ModuleListener: ModuleListener.testFailed(android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit, junit.framework.AssertionFailedError: expected:<3> but was:<1> 215at junit.framework.Assert.fail(Assert.java:50) 216at junit.framework.Assert.failNotEquals(Assert.java:287) 217at junit.framework.Assert.assertEquals(Assert.java:67) 218at junit.framework.Assert.assertEquals(Assert.java:199) 219at junit.framework.Assert.assertEquals(Assert.java:205) 220at android.app.cts.ActivityManagerTest.testTimeTrackingAPI_SimpleStartExit(ActivityManagerTest.java:431) 221at java.lang.reflect.Method.invoke(Native Method) 222at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:220) 223at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:205) 224at junit.framework.TestCase.runBare(TestCase.java:134) 225at junit.framework.TestResult$1.protect(TestResult.java:115) 226at android.support.test.internal.runner.junit3.AndroidTestResult.runProtected(AndroidTestResult.java:77) 227at junit.framework.TestResult.run(TestResult.java:118) 228at android.support.test.internal.runner.junit3.AndroidTestResult.run(AndroidTestResult.java:55) 229at junit.framework.TestCase.run(TestCase.java:124) 230at android.support.test.internal.runner.junit3.NonLeakyTestSuite$NonLeakyTest.run(NonLeakyTestSuite.java:63) 231at android.support.test.internal.runner.junit3.AndroidTestSuite$1.run(AndroidTestSuite.java:97) 232at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428) 233at java.util.concurrent.FutureTask.run(FutureTask.java:237) 234at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 235at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 236at java.lang.Thread.run(Thread.java:761) 237) 23803-26 16:21:58 I/ConsoleReporter: [5/5 x86 CtsAppTestCases chromeos2-row8-rack4-host19:22] android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit fail: junit.framework.AssertionFailedError: expected:<3> but was:<1> 239at junit.framework.Assert.fail(Assert.java:50) 240at junit.framework.Assert.failNotEquals(Assert.java:287) 241at junit.framework.Assert.assertEquals(Assert.java:67) 242at junit.framework.Assert.assertEquals(Assert.java:199) 243at junit.framework.Assert.assertEquals(Assert.java:205) 244at android.app.cts.ActivityManagerTest.testTimeTrackingAPI_SimpleStartExit(ActivityManagerTest.java:431) 245at java.lang.reflect.Method.invoke(Native Method) 246at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:220) 247at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:205) 248at junit.framework.TestCase.runBare(TestCase.java:134) 249at junit.framework.TestResult$1.protect(TestResult.java:115) 250at android.support.test.internal.runner.junit3.AndroidTestResult.runProtected(AndroidTestResult.java:77) 251at junit.framework.TestResult.run(TestResult.java:118) 252at android.support.test.internal.runner.junit3.AndroidTestResult.run(AndroidTestResult.java:55) 253at junit.framework.TestCase.run(TestCase.java:124) 254at android.support.test.internal.runner.junit3.NonLeakyTestSuite$NonLeakyTest.run(NonLeakyTestSuite.java:63) 255at android.support.test.internal.runner.junit3.AndroidTestSuite$1.run(AndroidTestSuite.java:97) 256at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:428) 257at java.util.concurrent.FutureTask.run(FutureTask.java:237) 258at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1133) 259at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:607) 260at java.lang.Thread.run(Thread.java:761) 261 26203-26 16:21:58 I/FailureListener: FailureListener.testFailed android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit false true false 26303-26 16:22:00 D/FileUtil: Creating temp file at /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05 with prefix "android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit-logcat_" suffix ".zip" 26403-26 16:22:00 I/LogFileSaver: Saved log file /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit-logcat_6981612307094436497.zip 26503-26 16:22:00 I/ResultReporter: Saved logs for android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit-logcat in /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/tools/../../android-cts/logs/2017.03.26_16.21.05/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit-logcat_6981612307094436497.zip 26603-26 16:22:00 D/FileUtil: Creating temp file at /tmp/3764431/cts/inv_4137984894364964943 with prefix "android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit-logcat_" suffix ".zip" 26703-26 16:22:00 D/RunUtil: Running command with timeout: 10000ms 26803-26 16:22:00 D/RunUtil: Running [chmod] 26903-26 16:22:00 D/RunUtil: [chmod] command failed. return code 1 27003-26 16:22:00 D/FileUtil: Attempting to chmod /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit-logcat_4933333784378096516.zip to ug+rwx 27103-26 16:22:00 D/RunUtil: Running command with timeout: 10000ms 27203-26 16:22:00 D/RunUtil: Running [chmod, ug+rwx, /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit-logcat_4933333784378096516.zip] 27303-26 16:22:00 I/FileSystemLogSaver: Saved log file /tmp/3764431/cts/inv_4137984894364964943/android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit-logcat_4933333784378096516.zip 27403-26 16:22:00 D/ModuleListener: ModuleListener.testEnded(android.app.cts.ActivityManagerTest#testTimeTrackingAPI_SimpleStartExit, {}) 27503-26 16:22:00 D/ModuleListener: ModuleListener.testRunEnded(7317, {}) 27603-26 16:22:00 I/ConsoleReporter: [chromeos2-row8-rack4-host19:22] x86 CtsAppTestCases completed in 7s. 1 passed, 4 failed, 0 not executed 27703-26 16:22:00 D/ModuleDef: Cleaner: ApkInstaller 27803-26 16:22:00 D/TestDevice: Uninstalling com.android.cts.launcherapps.simpleapp 27903-26 16:22:01 D/TestDevice: Uninstalling android.app.stubs 28003-26 16:22:03 D/TestDevice: Uninstalling android.app.cts 28103-26 16:22:04 W/CompatibilityTest: Inaccurate runtime hint for x86 CtsAppTestCases, expected 6m 38s was 20s 28203-26 16:22:04 I/CompatibilityTest: Running system status checker after module execution: CtsAppTestCases 28303-26 16:22:05 I/MonitoringUtils: Connectivity: passed check. 28403-26 16:22:05 D/RunUtil: run interrupt allowed: false 28503-26 16:22:05 I/ResultReporter: Invocation finished in 1m 0s. PASSED: 317, FAILED: 4, NOT EXECUTED: 0, MODULES: 1 of 1 28603-26 16:22:06 I/ResultReporter: Test Result: /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/results/2017.03.26_16.21.05/test_result_failures.html 28703-26 16:22:06 I/ResultReporter: Full Result: /tmp/autotest-tradefed-install_e5FdR6/8d01e7b907e6e63a12b197e2ce3529c0/android-cts-7.1_r3-linux_x86-x86/android-cts/results/2017.03.26_16.21.05.zip 288