Back to build
Raw log | Switch to full mode | Login

python -u /b/swarming/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/swarming/w/ir/tmp/t/tmpTdGGOT.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpBeyjPS --merge-script /b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py --merge-script-stdout-file /b/swarming/w/ir/tmp/t/tmpweFAkTmerge_script_log --merge-additional-args '["--bucket", "chromium-result-details", "--test-name", "sql_unittests"]' --build-properties '{"bot_id": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556183953350327, "id": "8915216570890049072", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/16846", "builder:android-kitkat-arm-rel", "buildset:commit/git/a6231905d0cc80365722216f88050cf3334579cc", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6231905d0cc80365722216f88050cf3334579cc", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080646632862402864", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 16846, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "a6231905d0cc80365722216f88050cf3334579cc", "got_revision_cp": "refs/heads/master@{#653955}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "906b883133e43401ba8bbc490e003481ca366368", "got_v8_revision_cp": "refs/heads/7.6.28@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "a6231905d0cc80365722216f88050cf3334579cc"}' --summary-json-file /b/swarming/w/ir/tmp/t/tmpO33aso.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/swarming/w/ir/tmp/t/tmpk1xdx7.json in dir /b/swarming/w/ir/k: allow_subannotations: True cmd: ['python', '-u', '/b/swarming/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/swarming/w/ir/tmp/t/tmpTdGGOT.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpBeyjPS', '--merge-script', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--merge-script-stdout-file', '/b/swarming/w/ir/tmp/t/tmpweFAkTmerge_script_log', '--merge-additional-args', '["--bucket", "chromium-result-details", "--test-name", "sql_unittests"]', '--build-properties', '{"bot_id": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556183953350327, "id": "8915216570890049072", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/16846", "builder:android-kitkat-arm-rel", "buildset:commit/git/a6231905d0cc80365722216f88050cf3334579cc", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6231905d0cc80365722216f88050cf3334579cc", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080646632862402864", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 16846, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "a6231905d0cc80365722216f88050cf3334579cc", "got_revision_cp": "refs/heads/master@{#653955}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "906b883133e43401ba8bbc490e003481ca366368", "got_v8_revision_cp": "refs/heads/7.6.28@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "a6231905d0cc80365722216f88050cf3334579cc"}', '--summary-json-file', '/b/swarming/w/ir/tmp/t/tmpO33aso.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/swarming/w/ir/tmp/t/tmpk1xdx7.json'] env: FrozenDict([('PATH', '/b/swarming/w/ir/cache/builder/src/third_party/android_tools/sdk/platform-tools:/b/swarming/w/ir/cache/builder/src/build/android:%(PATH)s'), ('CHROME_HEADLESS', '1')]) env_prefixes: {'mapping': FrozenDict([('PATH', ('/b/swarming/w/ir/cache/swarming_client',))]), 'pathsep': ':'} env_suffixes: {'mapping': FrozenDict([]), 'pathsep': ':'} infra_step: False name_tokens: ['sql_unittests on Android device Nexus 5'] ok_ret: ALL_OK step_test_data: gen_default_step_test_data(...) trigger_specs: [] full environment: ADDRFAM: inet BOTO_CONFIG: /b/swarming/w/ir/tmp/gsutil-task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CHROME_HEADLESS: 1 CIPD_CACHE_DIR: /b/swarming/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 46529 DOCKER_CONFIG: /b/swarming/w/ir/tmp/docker-cfg-task DOCKER_TMPDIR: /b/swarming/w/ir/tmp/docker-tmp-task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /home/chrome-bot IFACE: eth0 INFRA_GIT_WRAPPER_HOME: /b/swarming/w/ir/tmp/git-home-task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8915216570890049072 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/swarming/w/ir/tmp/ld.sock LOGICAL: eth0 LUCI_CONTEXT: /b/swarming/w/ir/tmp/luci_context.699186376 MAC_CHROMIUM_TMPDIR: /b/swarming/w/ir/tmp/t METHOD: dhcp NO_GCE_CHECK: False PATH: /b/swarming/w/ir/cache/swarming_client:/b/swarming/w/ir/cache/builder/src/third_party/android_tools/sdk/platform-tools:/b/swarming/w/ir/cache/builder/src/build/android:/b/swarming/w/ir/cipd_bin_packages:/b/swarming/w/ir/cipd_bin_packages/bin:/b/swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/swarming/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 ROOT_SETUP_LOG: /var/log/messages/chromebuild/root-setup.log SHLVL: 1 STARTUP_LOG: /var/log/messages/chromebuild/startup.log SWARMING_BOT_ID: swarm265-c4 SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 446c9c3c1c219811 TEMP: /b/swarming/w/ir/tmp/t TEMPDIR: /b/swarming/w/ir/tmp/t TERM: linux TMP: /b/swarming/w/ir/tmp/t TMPDIR: /b/swarming/w/ir/tmp/t UPSTART_EVENTS: net-device-up UPSTART_INSTANCE: UPSTART_JOB: chromebuild-startup USER: chrome-bot USERNAME: chrome-bot VPYTHON_VIRTUALENV_ROOT: /b/swarming/w/ir/cache/vpython _: /b/swarming/w/ir/cipd_bin_packages/vpython Set PYTHONPATH: /b/swarming/w/ir/kitchen-checkout/build/scripts:/b/swarming/w/ir/kitchen-checkout/build/site_config:/b/swarming/w/ir/kitchen-checkout/build/third_party:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/swarming/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/swarming/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/swarming/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/swarming/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/swarming/w/ir/kitchen-checkout/build/third_party/jinja2:/b/swarming/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/swarming/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/swarming/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/swarming/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/swarming/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/swarming/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/swarming/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/swarming/w/ir/kitchen-checkout/build/third_party/site-packages 2019-04-25 02:45:23,248 - root: [DEBUG] Using task_output_dir: '/b/swarming/w/ir/tmp/t/tmpBeyjPS' 2019-04-25 02:45:23,248 - root: [WARNING] task_output_dir '/b/swarming/w/ir/tmp/t/tmpBeyjPS' already exists! 2019-04-25 02:45:23,248 - root: [WARNING] task_output_dir existing content: [] 2019-04-25 02:45:23,248 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/swarming/w/ir/tmp/t/tmpk1xdx7.json -output-dir /b/swarming/w/ir/tmp/t/tmpBeyjPS -task-summary-json /b/swarming/w/ir/tmp/t/tmpO33aso.json [D2019-04-25T02:45:23.255771-07:00 10501 0 auth.go:1265] Minting a new token {"key":"luci_ctx/6d6c46044a781449d610e65f4aa913ce304dc79da0db5fc3fc0fee4df311c266", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-25T02:45:23.255950-07:00 10501 0 luci_ctx.go:138] POST http://127.0.0.1:33290/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/6d6c46044a781449d610e65f4aa913ce304dc79da0db5fc3fc0fee4df311c266", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-25T02:45:23.258021-07:00 10501 0 auth.go:1222] Token expires in 26m1.742007193s {"key":"luci_ctx/6d6c46044a781449d610e65f4aa913ce304dc79da0db5fc3fc0fee4df311c266", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 446ca5ef7acf1510: exit 0 /b/swarming/swarming_bot.1.zip/third_party/requests/__init__.py:83: RequestsDependencyWarning: Old version of cryptography ([1, 2, 3]) may cause slowdown. Additional test environment: CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox CHROME_HEADLESS=1 LANG=en_US.UTF-8 Command: /b/swarming/w/ir/.swarming_module_cache/vpython/3bcbb9/bin/python ../../build/android/test_wrapper/logdog_wrapper.py --target sql_unittests --logdog-bin-cmd ../../bin/logdog_butler --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/ioL88PFr/output.json I 0.000s Main command: bin/../../../build/android/test_runner.py gtest --output-directory bin/../. --runtime-deps-path bin/../gen.runtime/sql/sql_unittests__test_runner_script.runtime_deps --suite sql_unittests -v --store-tombstones --gs-results-bucket=chromium-result-details --recover-devices --test-launcher-summary-output=/b/swarming/w/ioL88PFr/output.json I 0.007s Main condition '<lambda>' met I 0.009s Main condition '<lambda>' met I 3.155s TimeoutThread-1-for-prepare_device(04980fddf0d7bae7) condition 'sd_card_ready' met (0.0s) I 3.714s TimeoutThread-1-for-prepare_device(04980fddf0d7bae7) condition 'pm_ready' met (0.6s) I 3.727s TimeoutThread-1-for-prepare_device(04980fddf0d7bae7) condition 'boot_completed' met (0.6s) I 7.105s calculate_device_checksums condition '<lambda>' met (0.1s) I 8.940s list_tests(04980fddf0d7bae7) flags: I 8.940s list_tests(04980fddf0d7bae7) --gtest_list_tests I 10.141s list_tests(04980fddf0d7bae7) /storage/emulated/legacy/temp_file-f184f713d016.gtest_out size on device: 1763 I 10.246s Main Using external sharding settings. This is shard 0/1 I 10.246s Main STARTING TRY #1/3 I 10.247s Main Will run 88 tests on 1 devices: 04980fddf0d7bae7 I 12.443s run_tests_on_device(04980fddf0d7bae7) flags: I 12.443s run_tests_on_device(04980fddf0d7bae7) Getting logdog client. I 19.451s run_tests_on_device(04980fddf0d7bae7) /storage/emulated/legacy/temp_file-3c681135d042a.gtest_out size on device: 18905 I 19.584s run_tests_on_device(04980fddf0d7bae7) Logcat saved to https://luci-logdog.appspot.com/v/?s=chromium%2Fandroid%2Fswarming%2Flogcats%2F446b602a8ebf3d11%2F%2B%2Flogcat_logcat_524000743273096691_20190425T033427-UTC_04980fddf0d7bae7 I 19.585s archive Writing text to logdog stream, logcat_logcat_524000743273096691_20190425T033427-UTC_04980fddf0d7bae7 I 20.219s run_tests_on_device(04980fddf0d7bae7) >>ScopedMainEntryLogger I 20.219s run_tests_on_device(04980fddf0d7bae7) Note: Google Test filter = SQLDatabaseTest.AttachDatabase:SQLDatabaseTest.AttachDatabaseWithOpenTransaction:SQLDatabaseTest.Basic_FullIntegrityCheck:SQLDatabaseTest.Basic_QuickIntegrityCheck:SQLDatabaseTest.CachedStatement:SQLDatabaseTest.CollectDiagnosticInfo:SQLDatabaseTest.CompileError:SQLDatabaseTest.DeleteNonWal:SQLDatabaseTest.DoesColumnExist:SQLDatabaseTest.DoesIndexExist:SQLDatabaseTest.DoesTableExist:SQLDatabaseTest.DoesViewExist:SQLDatabaseTest.ErrorCallback:SQLDatabaseTest.Execute:SQLDatabaseTest.ExecuteWithErrorCode:SQLDatabaseTest.GetAppropriateMmapSize:SQLDatabaseTest.GetAppropriateMmapSizeAltStatus:SQLDatabaseTest.GetLastInsertRowId:SQLDatabaseTest.IsSQLValidTest:SQLDatabaseTest.MmapInitiallyEnabled:SQLDatabaseTest.MmapInitiallyEnabledAltStatus:SQLDatabaseTest.OnMemoryDump:SQLDatabaseTest.Poison:SQLDatabaseTest.PosixFilePermissions:SQLDatabaseTest.Raze:SQLDatabaseTest.RazeAndClose:SQLDatabaseTest.RazeAndCloseDiagnostics:SQLDatabaseTest.RazeCallbackReopen:SQLDatabaseTest.RazeEmptyDB:SQLDatabaseTest.RazeLocked:SQLDatabaseTest.RazeMultiple:SQLDatabaseTest.RazeNOTADB:SQLDatabaseTest.RazeNOTADB2:SQLDatabaseTest.RazePageSize:SQLDatabaseTest.RazeTruncate:SQLDatabaseTest.Rollback:SQLDatabaseTest.ScopedErrorExpecter:SQLDatabaseTest.ScopedIgnoreUntracked:SQLDatabaseTest.SetTempDirForSQL:SQLDatabaseTest.SqlTempMemoryFeatureFlagDefault:SQLDatabaseTest.SqlTempMemoryFeatureFlagEnabled:SQLMemoryDumpProviderTest.OnMemoryDump:SQLMetaTableTest.DeleteKey:SQLMetaTableTest.DoesTableExist:SQLMetaTableTest.Int64Value:SQLMetaTableTest.IntValue:SQLMetaTableTest.RazeIfDeprecated:SQLMetaTableTest.StringValue:SQLMetaTableTest.VersionNumber:SQLRecoveryTest.AttachFailure:SQLRecoveryTest.AutoRecoverTable:SQLRecoveryTest.AutoRecoverTableMissingColumns:SQLRecoveryTest.AutoRecoverTableNullFilter:SQLRecoveryTest.AutoRecoverTableWithCompoundKey:SQLRecoveryTest.AutoRecoverTableWithDefault:SQLRecoveryTest.AutoRecoverTableWithRowid:SQLRecoveryTest.BeginRecoverDatabase:SQLRecoveryTest.Bug387868:SQLRecoveryTest.Meta:SQLRecoveryTest.NoMmap:SQLRecoveryTest.PageSize:SQLRecoveryTest.RecoverBasic:SQLRecoveryTest.RecoverCorruptIndex:SQLRecoveryTest.RecoverCorruptTable:SQLRecoveryTest.RecoverDatabase:SQLRecoveryTest.RecoverDatabaseDelete:SQLRecoveryTest.VirtualTable:SQLStatementTest.Assign:SQLStatementTest.ErrorCallback:SQLStatementTest.Reset:SQLStatementTest.Run:SQLStatementTest.ScopedIgnoreError:SQLTransactionTest.Commit:SQLTransactionTest.NestedRollback:SQLTransactionTest.Rollback:SQLiteFeaturesTest.BooleanSupport:SQLiteFeaturesTest.CachedRegexp:SQLiteFeaturesTest.FTS3:SQLiteFeaturesTest.FTS3_Prefix:SQLiteFeaturesTest.ForeignKeySupport:SQLiteFeaturesTest.Mmap:SQLiteFeaturesTest.NoFTS1:SQLiteFeaturesTest.NoFTS2:SQLiteFeaturesTest.UsesUsleep:SQLiteFeaturesTest.WALNoClose:SqlStatementIdTest.CopyAssignment:SqlStatementIdTest.CopyConstructor:SqlStatementIdTest.LessThan I 20.219s run_tests_on_device(04980fddf0d7bae7) [==========] Running 88 tests from 8 test suites. I 20.220s run_tests_on_device(04980fddf0d7bae7) [----------] Global test environment set-up. I 20.220s run_tests_on_device(04980fddf0d7bae7) [----------] 41 tests from SQLDatabaseTest I 20.220s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.Execute I 20.220s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.Execute (244 ms) I 20.220s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.ExecuteWithErrorCode I 20.220s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.ExecuteWithErrorCode (20 ms) I 20.220s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.CachedStatement I 20.220s run_tests_on_device(04980fddf0d7bae7) I 20.220s run_tests_on_device(04980fddf0d7bae7) [WARNING] ../../sql/database_unittest.cc:193:: Death tests are not supported on this platform. I 20.220s run_tests_on_device(04980fddf0d7bae7) Statement 'db().GetCachedStatement(id1, kId2Sql)' cannot be verified. I 20.220s run_tests_on_device(04980fddf0d7bae7) I 20.220s run_tests_on_device(04980fddf0d7bae7) [WARNING] ../../sql/database_unittest.cc:195:: Death tests are not supported on this platform. I 20.220s run_tests_on_device(04980fddf0d7bae7) Statement 'db().GetCachedStatement(id2, kId1Sql)' cannot be verified. I 20.220s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.CachedStatement (31 ms) I 20.220s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.IsSQLValidTest I 20.221s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.IsSQLValidTest (18 ms) I 20.221s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.DoesTableExist I 20.221s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.DoesTableExist (39 ms) I 20.221s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.DoesIndexExist I 20.221s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.DoesIndexExist (49 ms) I 20.221s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.DoesViewExist I 20.221s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.DoesViewExist (29 ms) I 20.221s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.DoesColumnExist I 20.221s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.DoesColumnExist (24 ms) I 20.221s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.GetLastInsertRowId I 20.221s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.GetLastInsertRowId (40 ms) I 20.221s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.Rollback I 20.221s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.Rollback (6 ms) I 20.221s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.ScopedErrorExpecter I 20.221s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 2067, errno 0: UNIQUE constraint failed: foo.id, sql: INSERT INTO foo (id) VALUES (12) I 20.222s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.ScopedErrorExpecter (40 ms) I 20.222s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.ScopedIgnoreUntracked I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA auto_vacuum I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA journal_mode=TRUNCATE I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.222s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.ScopedIgnoreUntracked (33 ms) I 20.222s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.ErrorCallback I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 2067, errno 0: UNIQUE constraint failed: foo.id, sql: INSERT INTO foo (id) VALUES (12) I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 2067, errno 0: UNIQUE constraint failed: foo.id, sql: INSERT INTO foo (id) VALUES (12) I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 2067, errno 0: UNIQUE constraint failed: foo.id, sql: INSERT INTO foo (id) VALUES (12) I 20.222s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 2067, errno 0: UNIQUE constraint failed: foo.id, sql: INSERT INTO foo (id) VALUES (12) I 20.222s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.ErrorCallback (36 ms) I 20.222s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.Raze I 20.222s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.Raze (35 ms) I 20.223s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazePageSize I 20.223s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazePageSize (328 ms) I 20.223s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeMultiple I 20.223s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeMultiple (28 ms) I 20.223s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeLocked I 20.223s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeLocked (81 ms) I 20.223s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeEmptyDB I 20.223s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeEmptyDB (28 ms) I 20.223s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeNOTADB I 20.223s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: PRAGMA auto_vacuum I 20.223s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: PRAGMA journal_mode=TRUNCATE I 20.223s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.223s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeNOTADB (17 ms) I 20.223s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeNOTADB2 I 20.223s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: PRAGMA auto_vacuum I 20.223s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: PRAGMA journal_mode=TRUNCATE I 20.224s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.224s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeNOTADB2 (36 ms) I 20.224s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeCallbackReopen I 20.224s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA auto_vacuum I 20.224s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA journal_mode=TRUNCATE I 20.224s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.224s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA auto_vacuum I 20.224s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA auto_vacuum I 20.224s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeCallbackReopen (45 ms) I 20.224s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeAndClose I 20.224s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeAndClose (82 ms) I 20.224s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeAndCloseDiagnostics I 20.224s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeAndCloseDiagnostics (41 ms) I 20.224s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.RazeTruncate I 20.224s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.RazeTruncate (499 ms) I 20.225s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.SetTempDirForSQL I 20.225s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.SetTempDirForSQL (23 ms) I 20.225s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.DeleteNonWal I 20.225s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.DeleteNonWal (14 ms) I 20.225s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.PosixFilePermissions I 20.225s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.PosixFilePermissions (58 ms) I 20.225s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.Poison I 20.225s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 1, errno 0: cannot commit - no transaction is active, sql: COMMIT I 20.225s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.Poison (62 ms) I 20.225s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.AttachDatabase I 20.225s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.AttachDatabase (89 ms) I 20.225s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.AttachDatabaseWithOpenTransaction I 20.225s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 1, errno 0: database other is locked, sql: DETACH DATABASE ? I 20.225s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.AttachDatabaseWithOpenTransaction (52 ms) I 20.225s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.Basic_QuickIntegrityCheck I 20.225s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA auto_vacuum I 20.226s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA journal_mode=TRUNCATE I 20.226s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.226s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.Basic_QuickIntegrityCheck (27 ms) I 20.226s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.Basic_FullIntegrityCheck I 20.226s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA auto_vacuum I 20.226s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: PRAGMA journal_mode=TRUNCATE I 20.226s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.226s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.Basic_FullIntegrityCheck (30 ms) I 20.226s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.OnMemoryDump I 20.226s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.OnMemoryDump (1 ms) I 20.226s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.CollectDiagnosticInfo I 20.226s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.CollectDiagnosticInfo (26 ms) I 20.226s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.MmapInitiallyEnabled I 20.226s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.MmapInitiallyEnabled (2 ms) I 20.226s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.MmapInitiallyEnabledAltStatus I 20.226s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.MmapInitiallyEnabledAltStatus (17 ms) I 20.226s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.GetAppropriateMmapSize I 20.227s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.GetAppropriateMmapSize (144 ms) I 20.227s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.GetAppropriateMmapSizeAltStatus I 20.227s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.GetAppropriateMmapSizeAltStatus (53 ms) I 20.227s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.CompileError I 20.227s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.CompileError (4 ms) I 20.227s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.SqlTempMemoryFeatureFlagDefault I 20.227s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.SqlTempMemoryFeatureFlagDefault (7 ms) I 20.227s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLDatabaseTest.SqlTempMemoryFeatureFlagEnabled I 20.227s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLDatabaseTest.SqlTempMemoryFeatureFlagEnabled (2 ms) I 20.227s run_tests_on_device(04980fddf0d7bae7) [----------] 41 tests from SQLDatabaseTest (2456 ms total) I 20.227s run_tests_on_device(04980fddf0d7bae7) I 20.227s run_tests_on_device(04980fddf0d7bae7) [----------] 7 tests from SQLMetaTableTest I 20.227s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLMetaTableTest.DoesTableExist I 20.227s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLMetaTableTest.DoesTableExist (22 ms) I 20.227s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLMetaTableTest.RazeIfDeprecated I 20.227s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLMetaTableTest.RazeIfDeprecated (103 ms) I 20.227s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLMetaTableTest.VersionNumber I 20.228s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLMetaTableTest.VersionNumber (51 ms) I 20.228s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLMetaTableTest.StringValue I 20.228s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLMetaTableTest.StringValue (48 ms) I 20.228s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLMetaTableTest.IntValue I 20.228s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLMetaTableTest.IntValue (53 ms) I 20.228s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLMetaTableTest.Int64Value I 20.228s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLMetaTableTest.Int64Value (45 ms) I 20.228s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLMetaTableTest.DeleteKey I 20.228s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLMetaTableTest.DeleteKey (61 ms) I 20.228s run_tests_on_device(04980fddf0d7bae7) [----------] 7 tests from SQLMetaTableTest (388 ms total) I 20.228s run_tests_on_device(04980fddf0d7bae7) I 20.228s run_tests_on_device(04980fddf0d7bae7) [----------] 18 tests from SQLRecoveryTest I 20.228s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.RecoverBasic I 20.228s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.RecoverBasic (197 ms) I 20.228s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.VirtualTable I 20.228s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.VirtualTable (71 ms) I 20.228s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.RecoverCorruptIndex I 20.229s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 11, errno 0: database disk image is malformed, sql: SELECT v FROM x WHERE id = 0 I 20.229s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.RecoverCorruptIndex (92 ms) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.RecoverCorruptTable I 20.229s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 2067, errno 0: UNIQUE constraint failed: x.id, sql: INSERT INTO x (id, v) VALUES (0, 101) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.RecoverCorruptTable (147 ms) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.Meta I 20.229s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] sqlite error 11, errno -2: unable to find backing table, sql: CREATE VIRTUAL TABLE temp.recover_meta USING recover(corrupt.meta,key TEXT NOT NULL,value ANY) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.Meta (63 ms) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.AutoRecoverTable I 20.229s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.AutoRecoverTable (120 ms) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.AutoRecoverTableWithDefault I 20.229s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.AutoRecoverTableWithDefault (122 ms) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.AutoRecoverTableNullFilter I 20.229s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.AutoRecoverTableNullFilter (76 ms) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.AutoRecoverTableWithRowid I 20.229s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.AutoRecoverTableWithRowid (67 ms) I 20.229s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.AutoRecoverTableWithCompoundKey I 20.230s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.AutoRecoverTableWithCompoundKey (85 ms) I 20.230s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.AutoRecoverTableMissingColumns I 20.230s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.AutoRecoverTableMissingColumns (65 ms) I 20.230s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.Bug387868 I 20.230s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.Bug387868 (23 ms) I 20.230s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.NoMmap I 20.230s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.NoMmap (19 ms) I 20.230s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.RecoverDatabase I 20.230s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.RecoverDatabase (219 ms) I 20.230s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.RecoverDatabaseDelete I 20.230s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: PRAGMA auto_vacuum I 20.230s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: PRAGMA journal_mode=TRUNCATE I 20.230s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.230s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: SELECT COUNT(*) FROM sqlite_master I 20.230s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] sqlite error 26, errno -2: file is not a database, sql: ATTACH DATABASE ? AS ? I 20.230s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] sqlite error 26, errno -2: file is not a database, sql: ATTACH DATABASE ? AS ? I 20.231s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.RecoverDatabaseDelete (29 ms) I 20.231s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.BeginRecoverDatabase I 20.231s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.BeginRecoverDatabase (208 ms) I 20.231s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.AttachFailure I 20.231s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: PRAGMA auto_vacuum I 20.231s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: PRAGMA journal_mode=TRUNCATE I 20.231s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: SELECT 1 FROM sqlite_master WHERE type=? AND name=? I 20.231s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 26, errno 0: file is not a database, sql: SELECT COUNT(*) FROM sqlite_master I 20.231s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] sqlite error 26, errno -2: file is not a database, sql: ATTACH DATABASE ? AS ? I 20.231s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.AttachFailure (62 ms) I 20.231s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLRecoveryTest.PageSize I 20.231s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLRecoveryTest.PageSize (342 ms) I 20.231s run_tests_on_device(04980fddf0d7bae7) [----------] 18 tests from SQLRecoveryTest (2016 ms total) I 20.231s run_tests_on_device(04980fddf0d7bae7) I 20.231s run_tests_on_device(04980fddf0d7bae7) [----------] 1 test from SQLMemoryDumpProviderTest I 20.231s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLMemoryDumpProviderTest.OnMemoryDump I 20.231s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLMemoryDumpProviderTest.OnMemoryDump (3 ms) I 20.232s run_tests_on_device(04980fddf0d7bae7) [----------] 1 test from SQLMemoryDumpProviderTest (3 ms total) I 20.232s run_tests_on_device(04980fddf0d7bae7) I 20.232s run_tests_on_device(04980fddf0d7bae7) [----------] 10 tests from SQLiteFeaturesTest I 20.232s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.NoFTS1 I 20.232s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.NoFTS1 (9 ms) I 20.232s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.NoFTS2 I 20.232s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.NoFTS2 (11 ms) I 20.232s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.FTS3 I 20.232s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.FTS3 (35 ms) I 20.232s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.FTS3_Prefix I 20.232s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.FTS3_Prefix (68 ms) I 20.232s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.UsesUsleep I 20.232s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.UsesUsleep (12 ms) I 20.232s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.ForeignKeySupport I 20.232s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.ForeignKeySupport (141 ms) I 20.232s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.BooleanSupport I 20.232s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.BooleanSupport (52 ms) I 20.233s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.Mmap I 20.233s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.Mmap (2 ms) I 20.233s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.CachedRegexp I 20.233s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.CachedRegexp (102 ms) I 20.233s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLiteFeaturesTest.WALNoClose I 20.233s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLiteFeaturesTest.WALNoClose (105 ms) I 20.233s run_tests_on_device(04980fddf0d7bae7) [----------] 10 tests from SQLiteFeaturesTest (560 ms total) I 20.233s run_tests_on_device(04980fddf0d7bae7) I 20.233s run_tests_on_device(04980fddf0d7bae7) [----------] 3 tests from SqlStatementIdTest I 20.233s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SqlStatementIdTest.LessThan I 20.233s run_tests_on_device(04980fddf0d7bae7) [ OK ] SqlStatementIdTest.LessThan (5 ms) I 20.233s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SqlStatementIdTest.CopyConstructor I 20.233s run_tests_on_device(04980fddf0d7bae7) [ OK ] SqlStatementIdTest.CopyConstructor (1 ms) I 20.233s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SqlStatementIdTest.CopyAssignment I 20.233s run_tests_on_device(04980fddf0d7bae7) [ OK ] SqlStatementIdTest.CopyAssignment (1 ms) I 20.233s run_tests_on_device(04980fddf0d7bae7) [----------] 3 tests from SqlStatementIdTest (7 ms total) I 20.233s run_tests_on_device(04980fddf0d7bae7) I 20.234s run_tests_on_device(04980fddf0d7bae7) [----------] 5 tests from SQLStatementTest I 20.234s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLStatementTest.Assign I 20.234s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLStatementTest.Assign (2 ms) I 20.234s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLStatementTest.Run I 20.234s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLStatementTest.Run (29 ms) I 20.234s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLStatementTest.ErrorCallback I 20.234s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 20, errno 0: datatype mismatch, sql: INSERT INTO foo (a) VALUES (?) I 20.234s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLStatementTest.ErrorCallback (29 ms) I 20.234s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLStatementTest.ScopedIgnoreError I 20.234s run_tests_on_device(04980fddf0d7bae7) [ERROR:database.cc(1601)] SQLTest.db sqlite error 20, errno 0: datatype mismatch, sql: INSERT INTO foo (a) VALUES (?) I 20.234s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLStatementTest.ScopedIgnoreError (27 ms) I 20.234s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLStatementTest.Reset I 20.234s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLStatementTest.Reset (60 ms) I 20.234s run_tests_on_device(04980fddf0d7bae7) [----------] 5 tests from SQLStatementTest (148 ms total) I 20.234s run_tests_on_device(04980fddf0d7bae7) I 20.234s run_tests_on_device(04980fddf0d7bae7) [----------] 3 tests from SQLTransactionTest I 20.234s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLTransactionTest.Commit I 20.235s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLTransactionTest.Commit (33 ms) I 20.235s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLTransactionTest.Rollback I 20.235s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLTransactionTest.Rollback (48 ms) I 20.235s run_tests_on_device(04980fddf0d7bae7) [ RUN ] SQLTransactionTest.NestedRollback I 20.235s run_tests_on_device(04980fddf0d7bae7) [ OK ] SQLTransactionTest.NestedRollback (43 ms) I 20.235s run_tests_on_device(04980fddf0d7bae7) [----------] 3 tests from SQLTransactionTest (124 ms total) I 20.235s run_tests_on_device(04980fddf0d7bae7) I 20.235s run_tests_on_device(04980fddf0d7bae7) [----------] Global test environment tear-down I 20.235s run_tests_on_device(04980fddf0d7bae7) [==========] 88 tests from 8 test suites ran. (5711 ms total) I 20.235s run_tests_on_device(04980fddf0d7bae7) [ PASSED ] 88 tests. I 20.235s run_tests_on_device(04980fddf0d7bae7) <<ScopedMainEntryLogger I 20.244s run_tests_on_device(04980fddf0d7bae7) Finished running tests on this device. I 20.262s Main FINISHED TRY #1/3 I 20.262s Main All tests completed. C 20.262s Main ******************************************************************************** C 20.262s Main Summary C 20.262s Main ******************************************************************************** C 20.263s Main [==========] 88 tests ran. C 20.263s Main [ PASSED ] 88 tests. C 20.263s Main ******************************************************************************** I 20.265s tear_down_device(04980fddf0d7bae7) Wrote device cache: /b/swarming/w/ir/out/Release/device_cache_04980fddf0d7bae7.json I 20.269s Main Generated json results file at /b/swarming/w/itThFg2C/tmpsTZ1Em I 20.270s Main Finishing archiving output. [W2019-04-25T03:34:34.947607Z 2364 0 butler.go:240] Butler Context was cancelled. Initiating shutdown. {"error":"context canceled"} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' not met [E2019-04-25T03:34:34.996705Z 2364 0 main.go:205] Butler terminated with error. {"error":"context canceled"} [E2019-04-25T03:34:34.996753Z 2364 0 main.go:233] Failed to serve. original error: context canceled [I2019-04-25T03:34:34.996936Z 2364 0 main.go:349] Terminating. {"returnCode":250} INFO:devil.utils.timeout_retry:condition 'logdog_stopped' met 2019-04-25 02:45:23,600 - root: [DEBUG] Contents of task_output_dir: ['/b/swarming/w/ir/tmp/t/tmpBeyjPS/446ca5ef7acf1510'] 2019-04-25 02:45:23,600 - root: [DEBUG] Found shard_json_files: ['/b/swarming/w/ir/tmp/t/tmpBeyjPS/446ca5ef7acf1510/output.json'] 2019-04-25 02:45:23,600 - root: [INFO] merge_cmd: /b/swarming/w/ir/cache/vpython/ba947a/bin/python /b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py --build-properties {"bot_id": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556183953350327, "id": "8915216570890049072", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/16846", "builder:android-kitkat-arm-rel", "buildset:commit/git/a6231905d0cc80365722216f88050cf3334579cc", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6231905d0cc80365722216f88050cf3334579cc", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080646632862402864", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 16846, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "a6231905d0cc80365722216f88050cf3334579cc", "got_revision_cp": "refs/heads/master@{#653955}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "906b883133e43401ba8bbc490e003481ca366368", "got_v8_revision_cp": "refs/heads/7.6.28@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "a6231905d0cc80365722216f88050cf3334579cc"} --summary-json /b/swarming/w/ir/tmp/t/tmpO33aso.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpBeyjPS --bucket chromium-result-details --test-name sql_unittests -o /b/swarming/w/ir/tmp/t/tmpTdGGOT.json /b/swarming/w/ir/tmp/t/tmpBeyjPS/446ca5ef7acf1510/output.json Running ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--build-properties', '{"bot_id": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556183953350327, "id": "8915216570890049072", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/16846", "builder:android-kitkat-arm-rel", "buildset:commit/git/a6231905d0cc80365722216f88050cf3334579cc", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6231905d0cc80365722216f88050cf3334579cc", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080646632862402864", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 16846, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "a6231905d0cc80365722216f88050cf3334579cc", "got_revision_cp": "refs/heads/master@{#653955}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "906b883133e43401ba8bbc490e003481ca366368", "got_v8_revision_cp": "refs/heads/7.6.28@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "a6231905d0cc80365722216f88050cf3334579cc"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpO33aso.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpBeyjPS', u'--bucket', u'chromium-result-details', u'--test-name', u'sql_unittests', '-o', '/b/swarming/w/ir/tmp/t/tmpTdGGOT.json', '/b/swarming/w/ir/tmp/t/tmpBeyjPS/446ca5ef7acf1510/output.json'] in None (env: None) Command ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/build/android/pylib/results/presentation/test_results_presentation.py', '--build-properties', '{"bot_id": "swarm265-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1556183953350327, "id": "8915216570890049072", "project": "chromium", "tags": ["build_address:luci.chromium.ci/android-kitkat-arm-rel/16846", "builder:android-kitkat-arm-rel", "buildset:commit/git/a6231905d0cc80365722216f88050cf3334579cc", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6231905d0cc80365722216f88050cf3334579cc", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9080646632862402864", "scheduler_job_id:chromium/android-kitkat-arm-rel", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "android-kitkat-arm-rel", "buildnumber": 16846, "got_angle_revision": "1b0acbb5126e7f7d03bde3bde6d4b2fba20811c8", "got_dawn_revision": "22cee9ae36b23a8908525d668ef4728a26c931c4", "got_nacl_revision": "6abc006f6760ec49350cd45e8bccbff4809725ac", "got_revision": "a6231905d0cc80365722216f88050cf3334579cc", "got_revision_cp": "refs/heads/master@{#653955}", "got_swarming_client_revision": "aa60736aded9fc32a0e21a81f5fc51f6009d01f3", "got_v8_revision": "906b883133e43401ba8bbc490e003481ca366368", "got_v8_revision_cp": "refs/heads/7.6.28@{#1}", "got_webrtc_revision": "852bffb6063aa36814c89a58390581e59643f1fb", "got_webrtc_revision_cp": "refs/heads/master@{#27678}", "mastername": "chromium.android", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "a6231905d0cc80365722216f88050cf3334579cc"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmpO33aso.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpBeyjPS', u'--bucket', u'chromium-result-details', u'--test-name', u'sql_unittests', '-o', '/b/swarming/w/ir/tmp/t/tmpTdGGOT.json', '/b/swarming/w/ir/tmp/t/tmpBeyjPS/446ca5ef7acf1510/output.json'] returned exit code 0