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

'C:\b\s\w\ir\cipd_bin_packages\python.exe' -u 'C:\b\s\w\ir\kitchen-checkout\build\scripts\tools\runit.py' --show-path --with-third-party-lib -- python 'C:\b\s\w\ir\kitchen-checkout\build\scripts\slave\recipe_modules\chromium_swarming\resources\collect_task.py' --verbose -o 'c:\b\s\w\ir\tmp\t\tmp9ftfg6.json' --task-output-dir 'c:\b\s\w\ir\tmp\t\tmpldw9_o' --merge-script 'C:\b\s\w\ir\cache\builder\src\tools\perf\process_perf_results.py' --merge-script-stdout-file 'c:\b\s\w\ir\tmp\t\tmpf0kveumerge_script_log' --merge-additional-args '["--smoke-test-mode"]' --build-properties '{"attempt_start_ts": 1552482929000000, "blamelist": ["sinhak@chromium.org"], "bot_id": "win10-ssd-b329b685-us-east1-d-3gh7", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1552486530052024, "id": "8919093600222291200", "project": "chromium", "tags": ["build_address:luci.chromium.try/win7-rel/41114", "builder:win7-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1508392/8", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "win7-rel", "buildnumber": 41114, "category": "cq", "got_angle_revision": "3c1f5a6bd487ac8912fa7266b114515ebf6dd5c8", "got_dawn_revision": "ea2c7f20f2f96e15570f7e9416fb6c826f809747", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "c0acb512366015c242cf040dca4da2c72df16d68", "got_revision_cp": "refs/heads/master@{#640306}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "4244ba53498be264e89e4936b95ed39d5ea72284", "got_v8_revision_cp": "refs/heads/7.5.24@{#1}", "got_webrtc_revision": "1175ae0d800e10ebd021b9998d47c0f6e18ad899", "got_webrtc_revision_cp": "refs/heads/master@{#27095}", "mastername": "tryserver.chromium.win", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1508392, "patch_project": "chromium/src", "patch_ref": "refs/changes/92/1508392/8", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 8, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}' --summary-json-file 'c:\b\s\w\ir\tmp\t\tmpnh9cri.json' -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json 'c:\b\s\w\ir\tmp\t\tmpk7lof4.json' in dir C:\b\s\w\ir\k: allow_subannotations: False base_name: 'components_perftests (with patch)' cmd: ['C:\\b\\s\\w\\ir\\cipd_bin_packages\\python.exe', '-u', 'C:\\b\\s\\w\\ir\\kitchen-checkout\\build\\scripts\\tools\\runit.py', '--show-path', '--with-third-party-lib', '--', 'python', 'C:\\b\\s\\w\\ir\\kitchen-checkout\\build\\scripts\\slave\\recipe_modules\\chromium_swarming\\resources\\collect_task.py', '--verbose', '-o', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmp9ftfg6.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o', '--merge-script', 'C:\\b\\s\\w\\ir\\cache\\builder\\src\\tools\\perf\\process_perf_results.py', '--merge-script-stdout-file', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpf0kveumerge_script_log', '--merge-additional-args', '["--smoke-test-mode"]', '--build-properties', '{"attempt_start_ts": 1552482929000000, "blamelist": ["sinhak@chromium.org"], "bot_id": "win10-ssd-b329b685-us-east1-d-3gh7", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1552486530052024, "id": "8919093600222291200", "project": "chromium", "tags": ["build_address:luci.chromium.try/win7-rel/41114", "builder:win7-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1508392/8", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "win7-rel", "buildnumber": 41114, "category": "cq", "got_angle_revision": "3c1f5a6bd487ac8912fa7266b114515ebf6dd5c8", "got_dawn_revision": "ea2c7f20f2f96e15570f7e9416fb6c826f809747", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "c0acb512366015c242cf040dca4da2c72df16d68", "got_revision_cp": "refs/heads/master@{#640306}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "4244ba53498be264e89e4936b95ed39d5ea72284", "got_v8_revision_cp": "refs/heads/7.5.24@{#1}", "got_webrtc_revision": "1175ae0d800e10ebd021b9998d47c0f6e18ad899", "got_webrtc_revision_cp": "refs/heads/master@{#27095}", "mastername": "tryserver.chromium.win", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1508392, "patch_project": "chromium/src", "patch_ref": "refs/changes/92/1508392/8", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 8, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json-file', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpnh9cri.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpk7lof4.json'] env: {'CHROME_HEADLESS': '1'} env_prefixes: {'PATH': 'C:\\b\\s\\w\\ir\\cache\\swarming_client'} env_suffixes: {} infra_step: False name: 'components_perftests (with patch)' nest_level: 0 ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: ALLUSERSPROFILE: C:\ProgramData APPDATA: C:\Users\chrome-bot\AppData\Roaming BOTO_CONFIG: C:\b\s\w\ir\tmp\gsutil_task\.boto BUILDBUCKET_EXPERIMENTAL: FALSE CHROME_HEADLESS: 1 CIPD_CACHE_DIR: C:\b\s\cipd_cache\cache CIPD_EXE_SHIM: "C:\b\s\w\ir\cipd_bin_packages\vpython.exe" CIPD_PROTOCOL: v2 COMMONPROGRAMFILES: C:\Program Files\Common Files COMMONPROGRAMFILES(X86): C:\Program Files (x86)\Common Files COMMONPROGRAMW6432: C:\Program Files\Common Files COMPUTERNAME: WIN10-SSD-B329B COMSPEC: C:\Windows\system32\cmd.exe DOCKER_CONFIG: C:\b\s\w\ir\tmp\docker_cfg_task DOCKER_TMPDIR: C:\b\s\w\ir\tmp\docker_tmp_task FPS_BROWSER_APP_PROFILE_STRING: Internet Explorer FPS_BROWSER_USER_PROFILE_STRING: Default GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOMEDRIVE: C: HOMEPATH: \Users\chrome-bot INFRA_GIT_WRAPPER_HOME: C:\b\s\w\ir\tmp\git_home_task LC_ALL: English_United States.UTF-8 LC_COLLATE: English_United States.UTF-8 LC_CTYPE: English_United States.UTF-8 LC_MONETARY: English_United States.UTF-8 LC_NUMERIC: English_United States.UTF-8 LC_TIME: English_United States.UTF-8 LOCALAPPDATA: C:\Users\chrome-bot\AppData\Local LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8919093600222291200 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: net.pipe:LUCILogDogKitchen_6792 LOGONSERVER: \\WIN10-SSD-B329B LUCI_CONTEXT: C:\b\s\w\itdbupxq\luci_context.415078050 MAC_CHROMIUM_TMPDIR: C:\b\s\w\ir\tmp\t NO_GCE_CHECK: False NUMBER_OF_PROCESSORS: 8 ONEDRIVE: C:\Users\chrome-bot\OneDrive OS: Windows_NT PATH: C:\b\s\w\ir\cache\swarming_client;C:\b\s\w\ir\cipd_bin_packages;C:\b\s\w\ir\cipd_bin_packages\bin;C:\b\s\cipd_cache\bin;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files\Puppet Labs\Puppet\bin PATHEXT: .COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE: AMD64 PROCESSOR_IDENTIFIER: Intel64 Family 6 Model 63 Stepping 0, GenuineIntel PROCESSOR_LEVEL: 6 PROCESSOR_REVISION: 3f00 PROGRAMDATA: C:\ProgramData PROGRAMFILES: C:\Program Files PROGRAMFILES(X86): C:\Program Files (x86) PROGRAMW6432: C:\Program Files PROMPT: $P$G PSMODULEPATH: C:\Program Files\WindowsPowerShell\Modules;C:\Windows\system32\WindowsPowerShell\v1.0\Modules PUBLIC: C:\Users\Public PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SESSIONNAME: Console SWARMING_BOT_ID: win10-ssd-b329b685-us-east1-d-3gh7 SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43903a079b206211 SYSTEMDRIVE: C: SYSTEMROOT: C:\Windows TEMP: C:\b\s\w\ir\tmp\t TEMPDIR: C:\b\s\w\ir\tmp\t TMP: C:\b\s\w\ir\tmp\t TMPDIR: C:\b\s\w\ir\tmp\t USERDOMAIN: WIN10-SSD-B329B USERDOMAIN_ROAMINGPROFILE: WIN10-SSD-B329B USERNAME: chrome-bot USERPROFILE: C:\Users\chrome-bot VPYTHON_VIRTUALENV_ROOT: C:\b\s\w\ir\cache\vpython WINDIR: C:\Windows Set PYTHONPATH: C:\b\s\w\ir\kitchen-checkout\build\scripts;C:\b\s\w\ir\kitchen-checkout\build\site_config;C:\b\s\w\ir\kitchen-checkout\build\third_party;C:\b\s\w\ir\kitchen-checkout\build\third_party\buildbot_8_4p1;C:\b\s\w\ir\kitchen-checkout\build\third_party\buildbot_slave_8_4;C:\b\s\w\ir\kitchen-checkout\build\third_party\coverage-3.7.1;C:\b\s\w\ir\kitchen-checkout\build\third_party\decorator_3_3_1;C:\b\s\w\ir\kitchen-checkout\build\third_party\google_api_python_client;C:\b\s\w\ir\kitchen-checkout\build\third_party\httplib2\python2;C:\b\s\w\ir\kitchen-checkout\build\third_party\infra_libs;C:\b\s\w\ir\kitchen-checkout\build\third_party\jinja2;C:\b\s\w\ir\kitchen-checkout\build\third_party\markupsafe;C:\b\s\w\ir\kitchen-checkout\build\third_party\oauth2client;C:\b\s\w\ir\kitchen-checkout\build\third_party\pyasn1;C:\b\s\w\ir\kitchen-checkout\build\third_party\pyasn1-modules;C:\b\s\w\ir\kitchen-checkout\build\third_party\python-rsa;C:\b\s\w\ir\kitchen-checkout\build\third_party\requests_2_10_0;C:\b\s\w\ir\kitchen-checkout\build\third_party\setuptools-0.6c11;C:\b\s\w\ir\kitchen-checkout\build\third_party\sqlalchemy_0_7_1;C:\b\s\w\ir\kitchen-checkout\build\third_party\sqlalchemy_migrate_0_7_1;C:\b\s\w\ir\kitchen-checkout\build\third_party\tempita_0_5;C:\b\s\w\ir\kitchen-checkout\build\third_party\twisted_10_2;C:\b\s\w\ir\kitchen-checkout\build\third_party\uritemplate;C:\b\s\w\ir\kitchen-checkout\build\third_party\site-packages 2019-03-13 07:35:18,805 - root: [DEBUG] Using task_output_dir: 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o' 2019-03-13 07:35:18,805 - root: [WARNING] task_output_dir 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o' already exists! 2019-03-13 07:35:18,805 - root: [WARNING] task_output_dir existing content: [] 2019-03-13 07:35:18,805 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json c:\b\s\w\ir\tmp\t\tmpk7lof4.json -output-dir c:\b\s\w\ir\tmp\t\tmpldw9_o -task-summary-json c:\b\s\w\ir\tmp\t\tmpnh9cri.json [D2019-03-13T07:35:18.823233-07:00 3308 0 auth.go:1265] Minting a new token {"key":"luci_ctx/833a2a4dafe6434286aca0896741be78bf71877670ed5b9fa3eadad5ac24c592", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-13T07:35:18.823233-07:00 3308 0 luci_ctx.go:138] POST http://127.0.0.1:49933/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/833a2a4dafe6434286aca0896741be78bf71877670ed5b9fa3eadad5ac24c592", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-13T07:35:18.825375-07:00 3308 0 auth.go:1222] Token expires in 51m40.1746244s {"key":"luci_ctx/833a2a4dafe6434286aca0896741be78bf71877670ed5b9fa3eadad5ac24c592", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 43904b160c5b4110: exit 0 Additional test environment: CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox CHROME_HEADLESS=1 LANG=en_US.UTF-8 Command: e:\b\swarm_slave\w\ir\.swarming_module_cache\vpython\b3f1c2\Scripts\python.exe ..\..\testing\scripts\run_performance_tests.py --xvfb --non-telemetry=true components_perftests --gtest-benchmark-name=components_perftests --isolated-script-test-output=e:\b\swarm_slave\w\ioi2g3gn\output.json --isolated-script-test-perf-output=e:\b\swarm_slave\w\ioi2g3gn\perftest-output.json Additional test environment: CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox CHROME_HEADLESS=1 LANG=en_US.UTF-8 Command: .\components_perftests.exe --verbose --test-launcher-print-test-stdio=always Running ['.\\components_perftests.exe', '--verbose', '--test-launcher-print-test-stdio=always'] in None (env: {'TMP': 'e:\\b\\swarm_slave\\w\\itmagr34', 'LC_NUMERIC': 'English_United States.UTF-8', 'COMPUTERNAME': 'VM31-M4', 'VS110COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 11.0\\Common7\\Tools\\', 'USERDOMAIN': 'GOLO', 'LC_CTYPE': 'English_United States.UTF-8', 'PSMODULEPATH': 'C:\\Windows\\system32\\WindowsPowerShell\\v1.0\\Modules\\', 'COMMONPROGRAMFILES': 'C:\\Program Files\\Common Files', 'PROCESSOR_IDENTIFIER': 'Intel64 Family 6 Model 45 Stepping 7, GenuineIntel', 'PROGRAMFILES': 'C:\\Program Files', 'PROCESSOR_REVISION': '2d07', 'HOME': 'c:\\Users\\chrome-bot', 'BOTO_CONFIG': 'c:\\Users\\chrome-bot\\.boto', 'SYSTEMROOT': 'C:\\Windows', 'SWARMING_BOT_ID': 'vm31-m4', 'PROGRAMFILES(X86)': 'C:\\Program Files (x86)', 'COMSPEC': 'C:\\Windows\\system32\\cmd.exe', 'LANG': 'en_US.UTF-8', 'VIRTUAL_ENV': 'e:\\b\\swarm_slave\\w\\ir\\.swarming_module_cache\\vpython\\b3f1c2', 'HOMEDRIVE': 'C:', 'SWARMING_SERVER': 'https://chromium-swarm.appspot.com', 'WINDOWS_TRACING_LOGFILE': 'C:\\BVTBin\\Tests\\installpackage\\csilogfile.log', 'LC_MONETARY': 'English_United States.UTF-8', 'CHROME_DEVEL_SANDBOX': '/opt/chromium/chrome_sandbox', 'COMMONPROGRAMFILES(X86)': 'C:\\Program Files (x86)\\Common Files', 'PROCESSOR_ARCHITECTURE': 'AMD64', 'CHOCOLATEYINSTALL': 'C:\\ProgramData\\chocolatey', 'SWARMING_HEADLESS': '1', 'ALLUSERSPROFILE': 'C:\\ProgramData', 'USERPROFILE': 'C:\\Users\\chrome-bot', 'LOCALAPPDATA': 'C:\\Users\\chrome-bot\\AppData\\Local', 'PYTHONNOUSERSITE': '1', 'HOMEPATH': '\\Users\\chrome-bot', 'LUCI_CONTEXT': 'e:\\b\\swarm_slave\\w\\itmagr34\\luci_ctx.uyoirf.json', 'VS120COMNTOOLS': 'C:\\Program Files (x86)\\Microsoft Visual Studio 12.0\\Common7\\Tools\\', 'CIPD_CACHE_DIR': 'e:\\b\\swarm_slave\\cipd_cache\\cache', 'PROGRAMW6432': 'C:\\Program Files', 'USERNAME': 'chrome-bot', 'LC_ALL': 'English_United States.UTF-8', 'LOGONSERVER': '\\\\AD2', 'PROMPT': '$P$G', 'WINDOWS_TRACING_FLAGS': '3', 'PROGRAMDATA': 'C:\\ProgramData', 'VPYTHON_VIRTUALENV_ROOT': 'e:\\b\\swarm_slave\\w\\ir\\.swarming_module_cache\\vpython', 'PATH': 'e:\\b\\swarm_slave\\w\\ir\\.swarming_module_cache\\vpython\\b3f1c2\\Scripts;e:\\b\\swarm_slave\\w\\ir\\.swarming_module;e:\\b\\swarm_slave\\w\\ir\\.swarming_module\\bin;e:\\b\\swarm_slave\\cipd_cache\\bin;C:\\ProgramData\\chocolatey\\bin;C:\\Windows\\system32;C:\\Windows;C:\\Windows\\System32\\Wbem;C:\\Windows\\System32\\WindowsPowerShell\\v1.0\\;C:\\Program Files\\Microsoft SQL Server\\110\\Tools\\Binn\\;C:\\Program Files (x86)\\Windows Kits\\8.1\\Windows Performance Toolkit\\;C:\\Program Files (x86)\\QuickTime\\QTSystem\\;C:\\Program Files\\Puppet Labs\\Puppet\\bin;c:\\tools;e:\\b\\swarm_slave\\w\\ir\\.swarming_module_cache\\vpython\\b3f1c2\\lib\\site-packages\\pywin32_system32;e:\\b\\swarm_slave\\w\\ir\\.swarming_module_cache\\vpython\\b3f1c2\\lib\\site-packages\\pywin32_system32', 'USERDNSDOMAIN': 'GOLO.CHROMIUM.ORG', 'NO_GCE_CHECK': 'False', 'CHROME_HEADLESS': '1', 'PATHEXT': '.COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC', 'TMPDIR': 'e:\\b\\swarm_slave\\w\\itmagr34', 'SESSIONNAME': 'Console', 'FP_NO_HOST_CHECK': 'NO', 'SWARMING_TASK_ID': '439043ad6e893c11', 'TEMP': 'e:\\b\\swarm_slave\\w\\itmagr34', 'CIPD_PROTOCOL': 'v2', 'SYSTEMDRIVE': 'C:', 'PUBLIC': 'C:\\Users\\Public', 'NUMBER_OF_PROCESSORS': '8', 'APPDATA': 'C:\\Users\\chrome-bot\\AppData\\Roaming', 'PROCESSOR_LEVEL': '6', 'LC_TIME': 'English_United States.UTF-8', 'COMMONPROGRAMW6432': 'C:\\Program Files\\Common Files', 'OS': 'Windows_NT', 'LC_COLLATE': 'English_United States.UTF-8', 'WINDIR': 'C:\\Windows'}) IMPORTANT DEBUGGING NOTE: batches of tests are run inside their own process. For debugging a test inside a debugger, use the --gtest_filter=<your_test_name> flag along with --single-process-tests. Using sharding settings from environment. This is shard 0/1 Using 1 parallel jobs. Note: Google Test filter = DiscardableSharedMemoryHeapTest.SearchFreeLists:ProtoDBPerfTest.InsertMultipleDBsAlternating_LargeBatch_100b:ProtoDBPerfTest.InsertMultipleDBsAlternating_LargeBatch_1000b:ProtoDBPerfTest.InsertSingleDBAlternating_LargeBatch_100b:ProtoDBPerfTest.InsertSingleDBAlternating_LargeBatch_1000b:ProtoDBPerfTest.DistributionTestSmall_FewEntries_Single:ProtoDBPerfTest.DistributionTestSmall_FewEntries_Multi:ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Single:ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Multi:ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Batch_Single [==========] Running 10 tests from 2 test suites. [----------] Global test environment set-up. [----------] 1 test from DiscardableSharedMemoryHeapTest [ RUN ] DiscardableSharedMemoryHeapTest.SearchFreeLists *RESULT search_free_list: = 1228905.1305884141 runs/s [ OK ] DiscardableSharedMemoryHeapTest.SearchFreeLists (2044 ms) [----------] 1 test from DiscardableSharedMemoryHeapTest (2044 ms total) [----------] 9 tests from ProtoDBPerfTest [ RUN ] ProtoDBPerfTest.InsertMultipleDBsAlternating_LargeBatch_100b *RESULT InsertMultipleDBsAlternating_LargeBatch200_200_100: num_runs= 5 *RESULT InsertMultipleDBsAlternating_LargeBatch200_200_100: time= 5.953 ms *RESULT InsertMultipleDBsAlternating_LargeBatch200_200_100: max memory use= 164000 bytes *RESULT InsertMultipleDBsAlternating_LargeBatch200_200_100: average memory use= 106600 bytes [6280:3520:0313/072624.799:17077445:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.799:17077445:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.814:17077460:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.814:17077460:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.814:17077460:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.InsertMultipleDBsAlternating_LargeBatch_100b (31 ms) [ RUN ] ProtoDBPerfTest.InsertMultipleDBsAlternating_LargeBatch_1000b *RESULT InsertMultipleDBsAlternating_LargeBatch200_200_1000: num_runs= 5 *RESULT InsertMultipleDBsAlternating_LargeBatch200_200_1000: time= 11.532 ms *RESULT InsertMultipleDBsAlternating_LargeBatch200_200_1000: max memory use= 1068015 bytes *RESULT InsertMultipleDBsAlternating_LargeBatch200_200_1000: average memory use= 649009 bytes [6280:3520:0313/072624.845:17077491:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.845:17077491:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.845:17077491:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.845:17077491:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.845:17077491:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.InsertMultipleDBsAlternating_LargeBatch_1000b (31 ms) [ RUN ] ProtoDBPerfTest.InsertSingleDBAlternating_LargeBatch_100b *RESULT InsertSingleDBAlternating_LargeBatch200_200_100: num_runs= 5 *RESULT InsertSingleDBAlternating_LargeBatch200_200_100: time= 5.487 ms *RESULT InsertSingleDBAlternating_LargeBatch200_200_100: max memory use= 164000 bytes *RESULT InsertSingleDBAlternating_LargeBatch200_200_100: average memory use= 98400 bytes [6280:3520:0313/072624.861:17077507:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.InsertSingleDBAlternating_LargeBatch_100b (16 ms) [ RUN ] ProtoDBPerfTest.InsertSingleDBAlternating_LargeBatch_1000b *RESULT InsertSingleDBAlternating_LargeBatch200_200_1000: num_runs= 5 *RESULT InsertSingleDBAlternating_LargeBatch200_200_1000: time= 12.299999999999999 ms *RESULT InsertSingleDBAlternating_LargeBatch200_200_1000: max memory use= 1065174 bytes *RESULT InsertSingleDBAlternating_LargeBatch200_200_1000: average memory use= 639293 bytes [6280:3520:0313/072624.877:17077523:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.InsertSingleDBAlternating_LargeBatch_1000b (16 ms) [ RUN ] ProtoDBPerfTest.DistributionTestSmall_FewEntries_Single *RESULT DistributionTestSmall_FewEntriesSingle: Total memory use= 4100 bytes [6280:3520:0313/072624.908:17077554:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.DistributionTestSmall_FewEntries_Single (31 ms) [ RUN ] ProtoDBPerfTest.DistributionTestSmall_FewEntries_Multi *RESULT DistributionTestSmall_FewEntriesMulti: Total memory use= 36900 bytes [6280:3520:0313/072624.955:17077601:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.955:17077601:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.955:17077601:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.955:17077601:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.970:17077616:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.970:17077616:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.970:17077616:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.970:17077616:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072624.970:17077616:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.DistributionTestSmall_FewEntries_Multi (62 ms) [ RUN ] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Single *RESULT DistributionTestSmall_ManyEntriesSingle: Total memory use= 32800 bytes [6280:3520:0313/072625.142:17077788:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Single (172 ms) [ RUN ] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Multi *RESULT DistributionTestSmall_ManyEntriesMulti: Total memory use= 49200 bytes [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [6280:3520:0313/072625.376:17078022:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Multi (234 ms) [ RUN ] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Batch_Single *RESULT DistributionTestSmall_ManyEntries_BatchSingle: Total memory use= 32800 bytes [6280:3520:0313/072625.563:17078209:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Batch_Single (187 ms) [----------] 9 tests from ProtoDBPerfTest (780 ms total) [----------] Global test environment tear-down [==========] 10 tests from 2 test suites ran. (2824 ms total) [ PASSED ] 10 tests. [1/65] DiscardableSharedMemoryHeapTest.SearchFreeLists (2044 ms) [2/65] ProtoDBPerfTest.InsertMultipleDBsAlternating_LargeBatch_100b (31 ms) [3/65] ProtoDBPerfTest.InsertMultipleDBsAlternating_LargeBatch_1000b (31 ms) [4/65] ProtoDBPerfTest.InsertSingleDBAlternating_LargeBatch_100b (16 ms) [5/65] ProtoDBPerfTest.InsertSingleDBAlternating_LargeBatch_1000b (16 ms) [6/65] ProtoDBPerfTest.DistributionTestSmall_FewEntries_Single (31 ms) [7/65] ProtoDBPerfTest.DistributionTestSmall_FewEntries_Multi (62 ms) [8/65] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Single (172 ms) [9/65] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Multi (234 ms) [10/65] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Batch_Single (187 ms) Note: Google Test filter = ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Batch_Multi:ProtoDBPerfTest.LoadEntriesSingle_Small:ProtoDBPerfTest.LoadEntriesSingle_Medium:ProtoDBPerfTest.LoadEntriesSingle_Large:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Small:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Medium:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Large:ProtoDBPerfTest.LoadEntriesMulti_Small:ProtoDBPerfTest.LoadEntriesMulti_Medium:ProtoDBPerfTest.LoadEntriesMulti_Large [==========] Running 10 tests from 1 test suite. [----------] Global test environment set-up. [----------] 10 tests from ProtoDBPerfTest [ RUN ] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Batch_Multi *RESULT DistributionTestSmall_ManyEntries_BatchMulti: Total memory use= 49200 bytes [5864:2180:0313/072625.953:17078599:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072625.953:17078599:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072625.953:17078599:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072625.953:17078599:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072625.953:17078615:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072625.969:17078615:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072625.969:17078615:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072625.969:17078615:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072625.969:17078615:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Batch_Multi (234 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_Small *RESULT ProtoDBPerfTestLoadEntriesSingle_5_300_10: Memory use after writes= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_5_300_10: Memory use after load= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_5_300_10: Total time taken= 5 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_5_300_10: Max individual time taken= 0 ms [5864:2180:0313/072625.984:17078630:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_Small (15 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_Medium *RESULT ProtoDBPerfTestLoadEntriesSingle_5_3000_10: Memory use after writes= 446900 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_5_3000_10: Memory use after load= 852765 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_5_3000_10: Total time taken= 60 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_5_3000_10: Max individual time taken= 0 ms [5864:2180:0313/072626.140:17078786:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_Medium (156 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_Large *RESULT ProtoDBPerfTestLoadEntriesSingle_5_3000_100: Memory use after writes= 1476000 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_5_3000_100: Memory use after load= 2113910 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_5_3000_100: Total time taken= 71 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_5_3000_100: Max individual time taken= 0 ms [5864:2180:0313/072626.343:17078989:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_Large (203 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Small *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_300_10: Memory use after writes= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_300_10: Memory use after load= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_300_10: Max individual time taken= 1 ms [5864:2180:0313/072626.359:17079005:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Small (16 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Medium *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_3000_10: Memory use after writes= 446900 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_3000_10: Memory use after load= 587144 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_3000_10: Total time taken= 12 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_3000_10: Max individual time taken= 12 ms [5864:2180:0313/072626.483:17079129:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Medium (124 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Large *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_3000_100: Memory use after writes= 1476000 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_3000_100: Memory use after load= 904907 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_3000_100: Total time taken= 15 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_5_3000_100: Max individual time taken= 15 ms [5864:2180:0313/072626.624:17079270:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Large (141 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_Small *RESULT ProtoDBPerfTestLoadEntriesMulti_5_300_10: Memory use after writes= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_5_300_10: Memory use after load= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_5_300_10: Total time taken= 5 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_5_300_10: Max individual time taken= 1 ms [5864:2180:0313/072626.671:17079317:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072626.671:17079317:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072626.671:17079317:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072626.671:17079317:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072626.671:17079317:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_Small (47 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_Medium *RESULT ProtoDBPerfTestLoadEntriesMulti_5_3000_10: Memory use after writes= 1127500 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_5_3000_10: Memory use after load= 1127500 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_5_3000_10: Total time taken= 50 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_5_3000_10: Max individual time taken= 10 ms [5864:2180:0313/072626.842:17079488:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072626.858:17079504:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072626.858:17079504:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072626.858:17079504:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072626.858:17079504:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_Medium (187 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_Large *RESULT ProtoDBPerfTestLoadEntriesMulti_5_3000_100: Memory use after writes= 2460000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_5_3000_100: Memory use after load= 2460000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_5_3000_100: Total time taken= 60 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_5_3000_100: Max individual time taken= 12 ms [5864:2180:0313/072627.061:17079707:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072627.061:17079707:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072627.061:17079707:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072627.061:17079707:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [5864:2180:0313/072627.061:17079707:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_Large (203 ms) [----------] 10 tests from ProtoDBPerfTest (1326 ms total) [----------] Global test environment tear-down [==========] 10 tests from 1 test suite ran. (1326 ms total) [ PASSED ] 10 tests. [11/65] ProtoDBPerfTest.DistributionTestSmall_ManyEntries_Batch_Multi (234 ms) [12/65] ProtoDBPerfTest.LoadEntriesSingle_Small (15 ms) [13/65] ProtoDBPerfTest.LoadEntriesSingle_Medium (156 ms) [14/65] ProtoDBPerfTest.LoadEntriesSingle_Large (203 ms) [15/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Small (16 ms) [16/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Medium (124 ms) [17/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_Large (141 ms) [18/65] ProtoDBPerfTest.LoadEntriesMulti_Small (47 ms) [19/65] ProtoDBPerfTest.LoadEntriesMulti_Medium (187 ms) [20/65] ProtoDBPerfTest.LoadEntriesMulti_Large (203 ms) Note: Google Test filter = ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Small:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Medium:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Large:ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Small:ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Medium:ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Large:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Small:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Medium:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Large:ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Small [==========] Running 10 tests from 1 test suite. [----------] Global test environment set-up. [----------] 10 tests from ProtoDBPerfTest [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Small *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_300_10: Memory use after writes= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_300_10: Memory use after load= 24600 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_300_10: Max individual time taken= 1 ms [3852:5056:0313/072627.295:17079941:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Small (47 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Medium *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_3000_10: Memory use after writes= 1127500 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_3000_10: Memory use after load= 225500 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_3000_10: Total time taken= 10 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_3000_10: Max individual time taken= 10 ms [3852:5056:0313/072627.404:17080050:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Medium (109 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Large *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_3000_100: Memory use after writes= 2460000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_3000_100: Memory use after load= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_3000_100: Total time taken= 12 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_5_3000_100: Max individual time taken= 12 ms [3852:5056:0313/072627.544:17080190:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Large (140 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Small *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_300_10: Memory use after writes= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_300_10: Memory use after load= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_300_10: Total time taken= 5 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_300_10: Max individual time taken= 0 ms [3852:5056:0313/072627.575:17080221:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Small (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Medium *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_3000_10: Memory use after writes= 446900 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_3000_10: Memory use after load= 446900 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_3000_10: Total time taken= 59 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_3000_10: Max individual time taken= 0 ms [3852:5056:0313/072627.716:17080362:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Medium (141 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Large *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_3000_100: Memory use after writes= 1476000 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_3000_100: Memory use after load= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_3000_100: Total time taken= 77 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_SkipReadCache_5_3000_100: Max individual time taken= 0 ms [3852:5056:0313/072627.919:17080565:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Large (188 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Small *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_300_10: Memory use after writes= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_300_10: Memory use after load= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_300_10: Max individual time taken= 1 ms [3852:5056:0313/072627.950:17080596:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Small (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Medium *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_3000_10: Memory use after writes= 446900 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_3000_10: Memory use after load= 446900 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_3000_10: Total time taken= 12 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_3000_10: Max individual time taken= 12 ms [3852:5056:0313/072628.043:17080689:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Medium (93 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Large *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_3000_100: Memory use after writes= 1476000 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_3000_100: Memory use after load= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_3000_100: Total time taken= 15 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_SkipReadCache_5_3000_100: Max individual time taken= 15 ms [3852:5056:0313/072628.168:17080814:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Large (125 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Small *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_300_10: Memory use after writes= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_300_10: Memory use after load= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_300_10: Total time taken= 5 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_300_10: Max individual time taken= 1 ms [3852:5056:0313/072628.199:17080845:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [3852:5056:0313/072628.199:17080845:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [3852:5056:0313/072628.199:17080845:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [3852:5056:0313/072628.215:17080861:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [3852:5056:0313/072628.215:17080861:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Small (47 ms) [----------] 10 tests from ProtoDBPerfTest (967 ms total) [----------] Global test environment tear-down [==========] 10 tests from 1 test suite ran. (967 ms total) [ PASSED ] 10 tests. [21/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Small (47 ms) [22/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Medium (109 ms) [23/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_Large (140 ms) [24/65] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Small (31 ms) [25/65] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Medium (141 ms) [26/65] ProtoDBPerfTest.LoadEntriesSingle_SkipReadCache_Large (188 ms) [27/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Small (31 ms) [28/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Medium (93 ms) [29/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_SkipReadCache_Large (125 ms) [30/65] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Small (47 ms) Note: Google Test filter = ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Medium:ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Large:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Small:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Medium:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Large:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Small:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Medium:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Large:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Small:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Medium [==========] Running 10 tests from 1 test suite. [----------] Global test environment set-up. [----------] 10 tests from ProtoDBPerfTest [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Medium *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_3000_10: Memory use after writes= 1127500 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_3000_10: Memory use after load= 1127500 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_3000_10: Total time taken= 50 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_3000_10: Max individual time taken= 10 ms [2596:6296:0313/072628.543:17081189:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [2596:6296:0313/072628.543:17081189:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [2596:6296:0313/072628.543:17081189:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [2596:6296:0313/072628.543:17081189:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [2596:6296:0313/072628.543:17081189:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Medium (172 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Large *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_3000_100: Memory use after writes= 2460000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_3000_100: Memory use after load= 2460000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_3000_100: Total time taken= 60 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_SkipReadCache_5_3000_100: Max individual time taken= 12 ms [2596:6296:0313/072628.761:17081407:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [2596:6296:0313/072628.761:17081407:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [2596:6296:0313/072628.761:17081407:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [2596:6296:0313/072628.761:17081407:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [2596:6296:0313/072628.761:17081407:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Large (203 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Small *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_300_10: Memory use after writes= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_300_10: Memory use after load= 24600 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_300_10: Max individual time taken= 1 ms [2596:6296:0313/072628.792:17081438:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Small (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Medium *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_3000_10: Memory use after writes= 1127500 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_3000_10: Memory use after load= 225500 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_3000_10: Total time taken= 10 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_3000_10: Max individual time taken= 10 ms [2596:6296:0313/072628.917:17081563:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Medium (125 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Large *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_3000_100: Memory use after writes= 2460000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_3000_100: Memory use after load= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_3000_100: Total time taken= 12 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_SkipReadCache_5_3000_100: Max individual time taken= 12 ms [2596:6296:0313/072629.042:17081688:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Large (125 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Small *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_5_300_10: Memory use after writes= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_5_300_10: Memory use after load= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_5_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_5_300_10: Max individual time taken= 1 ms [2596:6296:0313/072629.073:17081719:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Small (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Medium *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_10_300_10: Memory use after writes= 221400 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_10_300_10: Memory use after load= 221400 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_10_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_10_300_10: Max individual time taken= 1 ms [2596:6296:0313/072629.104:17081750:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Medium (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Large *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_20_300_10: Memory use after writes= 438700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_20_300_10: Memory use after load= 438700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_20_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_20_300_10: Max individual time taken= 1 ms [2596:6296:0313/072629.151:17081797:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Large (47 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Small *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_5_300_10: Memory use after writes= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_5_300_10: Memory use after load= 24600 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_5_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_5_300_10: Max individual time taken= 1 ms [2596:6296:0313/072629.182:17081828:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Small (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Medium *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_10_300_10: Memory use after writes= 246000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_10_300_10: Memory use after load= 24600 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_10_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_10_300_10: Max individual time taken= 1 ms [2596:6296:0313/072629.260:17081906:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Medium (78 ms) [----------] 10 tests from ProtoDBPerfTest (889 ms total) [----------] Global test environment tear-down [==========] 10 tests from 1 test suite ran. (889 ms total) [ PASSED ] 10 tests. [31/65] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Medium (172 ms) [32/65] ProtoDBPerfTest.LoadEntriesMulti_SkipReadCache_Large (203 ms) [33/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Small (31 ms) [34/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Medium (125 ms) [35/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_SkipReadCache_Large (125 ms) [36/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Small (31 ms) [37/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Medium (31 ms) [38/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_Large (47 ms) [39/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Small (31 ms) [40/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Medium (78 ms) Note: Google Test filter = ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Large:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Small:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Medium:ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Large:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Small:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Medium:ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Large:ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Small:ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Medium:ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Large [==========] Running 10 tests from 1 test suite. [----------] Global test environment set-up. [----------] 10 tests from ProtoDBPerfTest [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Large *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_20_300_10: Memory use after writes= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_20_300_10: Memory use after load= 24600 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_20_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_20_300_10: Max individual time taken= 1 ms [7840:5724:0313/072629.541:17082187:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Large (141 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Small *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_5_300_10: Memory use after writes= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_5_300_10: Memory use after load= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_5_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_5_300_10: Max individual time taken= 1 ms [7840:5724:0313/072629.572:17082218:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Small (15 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Medium *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_10_300_10: Memory use after writes= 221400 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_10_300_10: Memory use after load= 221400 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_10_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_10_300_10: Max individual time taken= 1 ms [7840:5724:0313/072629.603:17082249:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Medium (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Large *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_20_300_10: Memory use after writes= 438700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_20_300_10: Memory use after load= 438700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_20_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_20_300_10: Max individual time taken= 1 ms [7840:5724:0313/072629.650:17082296:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Large (47 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Small *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_5_300_10: Memory use after writes= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_5_300_10: Memory use after load= 24600 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_5_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_5_300_10: Max individual time taken= 1 ms [7840:5724:0313/072629.681:17082327:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Small (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Medium *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_10_300_10: Memory use after writes= 246000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_10_300_10: Memory use after load= 24600 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_10_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_10_300_10: Max individual time taken= 1 ms [7840:5724:0313/072629.744:17082390:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Medium (63 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Large *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_20_300_10: Memory use after writes= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_20_300_10: Memory use after load= 24600 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_20_300_10: Total time taken= 1 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_20_300_10: Max individual time taken= 1 ms [7840:5724:0313/072629.869:17082515:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Large (140 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Small *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_5_300_10: Memory use after writes= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_5_300_10: Memory use after load= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_5_300_10: Total time taken= 5 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_5_300_10: Max individual time taken= 0 ms [7840:5724:0313/072629.900:17082546:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Small (16 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Medium *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_10_300_10: Memory use after writes= 221400 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_10_300_10: Memory use after load= 221400 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_10_300_10: Total time taken= 10 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_10_300_10: Max individual time taken= 0 ms [7840:5724:0313/072629.947:17082593:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Medium (47 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Large *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_20_300_10: Memory use after writes= 438700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_20_300_10: Memory use after load= 438700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_20_300_10: Total time taken= 22 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_20_300_10: Max individual time taken= 0 ms [7840:5724:0313/072630.009:17082655:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Large (62 ms) [----------] 10 tests from ProtoDBPerfTest (593 ms total) [----------] Global test environment tear-down [==========] 10 tests from 1 test suite ran. (593 ms total) [ PASSED ] 10 tests. [41/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_Large (141 ms) [42/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Small (15 ms) [43/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Medium (31 ms) [44/65] ProtoDBPerfTest.LoadEntriesSingle_OnePrefix_DifferingNumDBs_SkipReadCache_Large (47 ms) [45/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Small (31 ms) [46/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Medium (63 ms) [47/65] ProtoDBPerfTest.LoadEntriesMulti_OnePrefix_DifferingNumDBs_SkipReadCache_Large (140 ms) [48/65] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Small (16 ms) [49/65] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Medium (47 ms) [50/65] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_Large (62 ms) Note: Google Test filter = ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Small:ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Medium:ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Large:ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Small:ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Medium:ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Large:ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Small:ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Medium:ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Large:HQPPerfTestOnePopularURL.Typing [==========] Running 10 tests from 2 test suites. [----------] Global test environment set-up. [----------] 9 tests from ProtoDBPerfTest [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Small *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_5_300_10: Memory use after writes= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_5_300_10: Memory use after load= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_5_300_10: Total time taken= 5 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_5_300_10: Max individual time taken= 1 ms [1416:2324:0313/072630.227:17082873:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.227:17082873:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.227:17082873:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.227:17082873:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.227:17082873:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Small (46 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Medium *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_10_300_10: Memory use after writes= 246000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_10_300_10: Memory use after load= 246000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_10_300_10: Total time taken= 10 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_10_300_10: Max individual time taken= 1 ms [1416:2324:0313/072630.305:17082951:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.305:17082951:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.305:17082951:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.321:17082967:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.321:17082967:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.321:17082967:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.321:17082967:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.321:17082967:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.321:17082967:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.321:17082967:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Medium (94 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Large *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_20_300_10: Memory use after writes= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_20_300_10: Memory use after load= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_20_300_10: Total time taken= 20 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_20_300_10: Max individual time taken= 1 ms [1416:2324:0313/072630.477:17083123:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.477:17083123:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.477:17083123:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.477:17083123:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.477:17083123:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.477:17083123:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.493:17083139:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Large (172 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Small *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_5_300_10: Memory use after writes= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_5_300_10: Memory use after load= 110700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_5_300_10: Total time taken= 5 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_5_300_10: Max individual time taken= 0 ms [1416:2324:0313/072630.524:17083170:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Small (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Medium *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_10_300_10: Memory use after writes= 221400 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_10_300_10: Memory use after load= 221400 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_10_300_10: Total time taken= 10 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_10_300_10: Max individual time taken= 0 ms [1416:2324:0313/072630.555:17083201:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Medium (31 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Large *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_20_300_10: Memory use after writes= 438700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_20_300_10: Memory use after load= 438700 bytes *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_20_300_10: Total time taken= 22 ms *RESULT ProtoDBPerfTestLoadEntriesSingle_DifferingNumDBs_SkipReadCache_20_300_10: Max individual time taken= 0 ms [1416:2324:0313/072630.633:17083279:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Large (78 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Small *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_5_300_10: Memory use after writes= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_5_300_10: Memory use after load= 123000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_5_300_10: Total time taken= 5 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_5_300_10: Max individual time taken= 1 ms [1416:2324:0313/072630.680:17083326:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.680:17083326:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.680:17083326:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.680:17083326:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.680:17083326:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Small (47 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Medium *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_10_300_10: Memory use after writes= 246000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_10_300_10: Memory use after load= 246000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_10_300_10: Total time taken= 10 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_10_300_10: Max individual time taken= 1 ms [1416:2324:0313/072630.758:17083404:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.758:17083404:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.758:17083404:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.758:17083404:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.773:17083419:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.773:17083419:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.773:17083419:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.773:17083419:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.773:17083419:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.773:17083419:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Medium (93 ms) [ RUN ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Large *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_20_300_10: Memory use after writes= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_20_300_10: Memory use after load= 492000 bytes *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_20_300_10: Total time taken= 20 ms *RESULT ProtoDBPerfTestLoadEntriesMulti_DifferingNumDBs_SkipReadCache_20_300_10: Max individual time taken= 1 ms [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [1416:2324:0313/072630.945:17083591:WARNING:scoped_temp_dir.cc(23)] Could not delete temp dir in dtor. [ OK ] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Large (188 ms) [----------] 9 tests from ProtoDBPerfTest (780 ms total) [----------] 1 test from HQPPerfTestOnePopularURL [ RUN ] HQPPerfTestOnePopularURL.Typing *RESULT HQPPerfTestOnePopularURLTyping: 0-4= [1,21,18,18,19,] ms *RESULT HQPPerfTestOnePopularURLTyping: 5-9= [18,17,17,20,18,] ms *RESULT HQPPerfTestOnePopularURLTyping: 10-14= [18,18,18,20,18,] ms *RESULT HQPPerfTestOnePopularURLTyping: 15-19= [18,19,19,12,17,] ms *RESULT HQPPerfTestOnePopularURLTyping: 20-24= [2,19,19,19,2,] ms *RESULT HQPPerfTestOnePopularURLTyping: 25-29= [19,15,24,21,20,] ms *RESULT HQPPerfTestOnePopularURLTyping: 30-34= [21,20,20,20,4,] ms *RESULT HQPPerfTestOnePopularURLTyping: 35-39= [19,21,21,21,21,] ms *RESULT HQPPerfTestOnePopularURLTyping: 40-44= [21,20,21,21,21,] ms *RESULT HQPPerfTestOnePopularURLTyping: 45-49= [21,16,5,1,1,] ms *RESULT HQPPerfTestOnePopularURLTyping: 50-54= [1,1,1,1,1,] ms [1416:6356:0313/072635.784:17088443:WARNING:file_util_win.cc(841)] CreateFile failed for path e:\b\swarm_slave\w\itmagr34\scoped_dir1416_13613\History Provider Cache: The system cannot find the path specified. (0x3) [1416:6356:0313/072635.784:17088443:WARNING:url_index_private_data.cc(941)] Failed to write e:\b\swarm_slave\w\itmagr34\scoped_dir1416_13613\History Provider Cache [ OK ] HQPPerfTestOnePopularURL.Typing (4854 ms) [----------] 1 test from HQPPerfTestOnePopularURL (4854 ms total) [----------] Global test environment tear-down [==========] 10 tests from 2 test suites ran. (5634 ms total) [ PASSED ] 10 tests. [51/65] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Small (46 ms) [52/65] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Medium (94 ms) [53/65] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_Large (172 ms) [54/65] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Small (31 ms) [55/65] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Medium (31 ms) [56/65] ProtoDBPerfTest.LoadEntriesSingle_DifferingNumDBs_SkipReadCache_Large (78 ms) [57/65] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Small (47 ms) [58/65] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Medium (93 ms) [59/65] ProtoDBPerfTest.LoadEntriesMulti_DifferingNumDBs_SkipReadCache_Large (188 ms) [60/65] HQPPerfTestOnePopularURL.Typing (4854 ms) Note: Google Test filter = HQPPerfTestOnePopularURL.Backspacing:IndexedRulesetPerftest.IndexRuleset:IndexedRulesetPerftest.MatchAll:VisitedLink.TestAddAndQuery:V4StorePerftest.StressTest [==========] Running 5 tests from 4 test suites. [----------] Global test environment set-up. [----------] 1 test from HQPPerfTestOnePopularURL [ RUN ] HQPPerfTestOnePopularURL.Backspacing *RESULT HQPPerfTestOnePopularURLBackspacing: 54-50= [1,1,1,1,1,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 49-45= [3,2,2,12,19,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 44-40= [20,20,19,19,19,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 39-35= [19,21,20,20,21,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 34-30= [3,18,20,20,21,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 29-25= [20,20,20,20,19,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 24-20= [2,16,18,19,2,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 19-15= [16,17,18,18,18,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 14-10= [18,21,18,18,18,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 9-5= [19,20,18,18,18,] ms *RESULT HQPPerfTestOnePopularURLBackspacing: 4-0= [18,18,18,21,1,] ms [7056:2908:0313/072640.638:17093294:WARNING:file_util_win.cc(841)] CreateFile failed for path e:\b\swarm_slave\w\itmagr34\scoped_dir7056_26952\History Provider Cache: The system cannot find the path specified. (0x3) [7056:2908:0313/072640.638:17093294:WARNING:url_index_private_data.cc(941)] Failed to write e:\b\swarm_slave\w\itmagr34\scoped_dir7056_26952\History Provider Cache [ OK ] HQPPerfTestOnePopularURL.Backspacing (4698 ms) [----------] 1 test from HQPPerfTestOnePopularURL (4698 ms total) [----------] 2 tests from IndexedRulesetPerftest [ RUN ] IndexedRulesetPerftest.IndexRuleset *RESULT index_and_write_time: = 9060 microseconds [ OK ] IndexedRulesetPerftest.IndexRuleset (31 ms) [ RUN ] IndexedRulesetPerftest.MatchAll *RESULT median_match_time: = 268013 microseconds [ OK ] IndexedRulesetPerftest.MatchAll (1342 ms) [----------] 2 tests from IndexedRulesetPerftest (1373 ms total) [----------] 1 test from VisitedLink [ RUN ] VisitedLink.TestAddAndQuery *RESULT Visited_link_add_and_query: = 286.032 ms [ OK ] VisitedLink.TestAddAndQuery (452 ms) [----------] 1 test from VisitedLink (452 ms total) [----------] 1 test from V4StorePerftest [ RUN ] V4StorePerftest.StressTest *RESULT GetMatchingHashPrefix: = 3039.505 ms [ OK ] V4StorePerftest.StressTest (8051 ms) [----------] 1 test from V4StorePerftest (8051 ms total) [----------] Global test environment tear-down [==========] 5 tests from 4 test suites ran. (14574 ms total) [ PASSED ] 5 tests. [61/65] HQPPerfTestOnePopularURL.Backspacing (4698 ms) [62/65] IndexedRulesetPerftest.IndexRuleset (31 ms) [63/65] IndexedRulesetPerftest.MatchAll (1342 ms) [64/65] VisitedLink.TestAddAndQuery (452 ms) [65/65] V4StorePerftest.StressTest (8051 ms) SUCCESS: all tests passed. Tests took 28 seconds. Command ['.\\components_perftests.exe', '--verbose', '--test-launcher-print-test-stdio=always'] returned exit code 0 2019-03-13 07:35:19,733 - root: [DEBUG] Contents of task_output_dir: ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o\\43904b160c5b4110'] 2019-03-13 07:35:19,733 - root: [DEBUG] Found shard_json_files: ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o\\43904b160c5b4110\\output.json'] 2019-03-13 07:35:19,733 - root: [INFO] merge_cmd: C:\b\s\w\ir\cache\vpython\691c07\Scripts\python.exe C:\b\s\w\ir\cache\builder\src\tools\perf\process_perf_results.py --build-properties {"attempt_start_ts": 1552482929000000, "blamelist": ["sinhak@chromium.org"], "bot_id": "win10-ssd-b329b685-us-east1-d-3gh7", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1552486530052024, "id": "8919093600222291200", "project": "chromium", "tags": ["build_address:luci.chromium.try/win7-rel/41114", "builder:win7-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1508392/8", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "win7-rel", "buildnumber": 41114, "category": "cq", "got_angle_revision": "3c1f5a6bd487ac8912fa7266b114515ebf6dd5c8", "got_dawn_revision": "ea2c7f20f2f96e15570f7e9416fb6c826f809747", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "c0acb512366015c242cf040dca4da2c72df16d68", "got_revision_cp": "refs/heads/master@{#640306}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "4244ba53498be264e89e4936b95ed39d5ea72284", "got_v8_revision_cp": "refs/heads/7.5.24@{#1}", "got_webrtc_revision": "1175ae0d800e10ebd021b9998d47c0f6e18ad899", "got_webrtc_revision_cp": "refs/heads/master@{#27095}", "mastername": "tryserver.chromium.win", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1508392, "patch_project": "chromium/src", "patch_ref": "refs/changes/92/1508392/8", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 8, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"} --summary-json c:\b\s\w\ir\tmp\t\tmpnh9cri.json --task-output-dir c:\b\s\w\ir\tmp\t\tmpldw9_o --smoke-test-mode -o c:\b\s\w\ir\tmp\t\tmp9ftfg6.json c:\b\s\w\ir\tmp\t\tmpldw9_o\43904b160c5b4110\output.json Running ['C:\\b\\s\\w\\ir\\cache\\vpython\\691c07\\Scripts\\python.exe', 'C:\\b\\s\\w\\ir\\cache\\builder\\src\\tools\\perf\\process_perf_results.py', '--build-properties', '{"attempt_start_ts": 1552482929000000, "blamelist": ["sinhak@chromium.org"], "bot_id": "win10-ssd-b329b685-us-east1-d-3gh7", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1552486530052024, "id": "8919093600222291200", "project": "chromium", "tags": ["build_address:luci.chromium.try/win7-rel/41114", "builder:win7-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1508392/8", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "win7-rel", "buildnumber": 41114, "category": "cq", "got_angle_revision": "3c1f5a6bd487ac8912fa7266b114515ebf6dd5c8", "got_dawn_revision": "ea2c7f20f2f96e15570f7e9416fb6c826f809747", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "c0acb512366015c242cf040dca4da2c72df16d68", "got_revision_cp": "refs/heads/master@{#640306}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "4244ba53498be264e89e4936b95ed39d5ea72284", "got_v8_revision_cp": "refs/heads/7.5.24@{#1}", "got_webrtc_revision": "1175ae0d800e10ebd021b9998d47c0f6e18ad899", "got_webrtc_revision_cp": "refs/heads/master@{#27095}", "mastername": "tryserver.chromium.win", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1508392, "patch_project": "chromium/src", "patch_ref": "refs/changes/92/1508392/8", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 8, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpnh9cri.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o', u'--smoke-test-mode', '-o', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmp9ftfg6.json', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o\\43904b160c5b4110\\output.json'] in None (env: None) Duration of Generating perf log streams: 0 seconds Duration of Analyzing perf json test results: 0 seconds Duration of Merging json test results: 0 seconds Duration of Total process_perf_results: 0 seconds Command ['C:\\b\\s\\w\\ir\\cache\\vpython\\691c07\\Scripts\\python.exe', 'C:\\b\\s\\w\\ir\\cache\\builder\\src\\tools\\perf\\process_perf_results.py', '--build-properties', '{"attempt_start_ts": 1552482929000000, "blamelist": ["sinhak@chromium.org"], "bot_id": "win10-ssd-b329b685-us-east1-d-3gh7", "buildbucket": {"build": {"bucket": "luci.chromium.try", "created_by": "user:5071639625-1lppvbtck1morgivc6sq4dul7klu27sd@developer.gserviceaccount.com", "created_ts": 1552486530052024, "id": "8919093600222291200", "project": "chromium", "tags": ["build_address:luci.chromium.try/win7-rel/41114", "builder:win7-rel", "buildset:patch/gerrit/chromium-review.googlesource.com/1508392/8", "cq_experimental:false", "user_agent:cq"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "win7-rel", "buildnumber": 41114, "category": "cq", "got_angle_revision": "3c1f5a6bd487ac8912fa7266b114515ebf6dd5c8", "got_dawn_revision": "ea2c7f20f2f96e15570f7e9416fb6c826f809747", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "c0acb512366015c242cf040dca4da2c72df16d68", "got_revision_cp": "refs/heads/master@{#640306}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "4244ba53498be264e89e4936b95ed39d5ea72284", "got_v8_revision_cp": "refs/heads/7.5.24@{#1}", "got_webrtc_revision": "1175ae0d800e10ebd021b9998d47c0f6e18ad899", "got_webrtc_revision_cp": "refs/heads/master@{#27095}", "mastername": "tryserver.chromium.win", "patch_gerrit_url": "https://chromium-review.googlesource.com", "patch_issue": 1508392, "patch_project": "chromium/src", "patch_ref": "refs/changes/92/1508392/8", "patch_repository_url": "https://chromium.googlesource.com/chromium/src", "patch_set": 8, "patch_storage": "gerrit", "path_config": "generic", "reason": "CQ", "recipe": "chromium_trybot", "repository": "https://chromium.googlesource.com/chromium/src", "revision": "HEAD"}', '--summary-json', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpnh9cri.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o', u'--smoke-test-mode', '-o', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmp9ftfg6.json', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpldw9_o\\43904b160c5b4110\\output.json'] returned exit code 0