[18:18:49.632] New invocation is queued and will start shortly
[18:18:50.725] Starting the invocation (attempt 1)
[18:18:50.779] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c25c43a60c6fd943add8d5033d11403aec6c541"
[18:18:50.779] Popped gitiles commit info from properties and tags
[18:18:50.779] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:18:50.779] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:18:50.779] Buildbucket request:
{
"requestId": "9017557193946689152",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-asan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3c25c43a60c6fd943add8d5033d11403aec6c541",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9017557193946689152"
},
{
"key": "scheduler_job_id",
"value": "chromium/win-asan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:18:51.863] Scheduled build:
{
"id": "8852127131894944768",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "win-asan"
},
"number": 17909,
"createdBy": "project:chromium",
"createTime": "2021-03-21T18:18:50.956524Z",
"updateTime": "2021-03-21T18:18:51.623102Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3c25c43a60c6fd943add8d5033d11403aec6c541",
"ref": "refs/heads/master"
}
}
}
[18:18:51.863] Task URL: https://cr-buildbucket.appspot.com/build/8852127131894944768
[18:18:51.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:2:0) after 9m25s
[18:18:53.686] Received PubSub notification, asking Buildbucket for the build status
[18:18:53.728] Build status: STARTED
[18:28:16.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:2:0)
[18:28:16.920] Build status: STARTED
[18:28:16.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:4:0) after 4m21s
[18:32:38.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:4:0)
[18:32:38.009] Timer tick, asking Buildbucket for the build status
[18:32:38.101] Build 8852127131894944768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:38.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:5:0) after 1m0s
[18:33:38.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:5:0)
[18:33:38.149] Build status: STARTED
[18:33:38.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:6:0) after 8m9s
[18:41:47.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:6:0)
[18:41:47.199] Build status: STARTED
[18:41:47.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:7:0) after 8m16s
[18:50:03.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:7:0)
[18:50:03.314] Timer tick, asking Buildbucket for the build status
[18:50:03.656] Build 8852127131894944768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:03.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:8:0) after 1m0s
[18:51:03.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:8:0)
[18:51:03.672] Timer tick, asking Buildbucket for the build status
[18:51:03.987] Build 8852127131894944768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:03.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:9:0) after 1m0s
[18:52:04.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:9:0)
[18:52:04.017] Timer tick, asking Buildbucket for the build status
[18:52:04.092] Build 8852127131894944768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:04.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:10:0) after 1m0s
[18:53:04.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:10:0)
[18:53:04.136] Build status: STARTED
[18:53:04.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:11:0) after 9m10s
[19:02:14.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:11:0)
[19:02:14.158] Timer tick, asking Buildbucket for the build status
[19:02:14.269] Build 8852127131894944768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:14.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:12:0) after 1m0s
[19:03:14.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:12:0)
[19:03:14.318] Build status: STARTED
[19:03:14.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:13:0) after 9m43s
[19:12:57.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:13:0)
[19:12:57.334] Timer tick, asking Buildbucket for the build status
[19:12:57.780] Build 8852127131894944768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:57.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:14:0) after 1m0s
[19:13:57.829] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:14:0)
[19:13:57.829] Timer tick, asking Buildbucket for the build status
[19:13:57.919] Build 8852127131894944768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:57.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:15:0) after 1m0s
[19:14:57.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:15:0)
[19:14:57.962] Build status: STARTED
[19:14:57.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9017557193946689152:16:0) after 8m38s
[19:23:22.246] Received PubSub notification, asking Buildbucket for the build status
[19:23:22.493] Build 8852127131894944768: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:23:22.493] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616354601255078",
"created_by": "project:chromium",
"created_ts": "1616350730956524",
"failure_reason": "BUILD_FAILURE",
"id": "8852127131894944768",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- PredictionModelDownloadManagerTest.VerifiedCrxWithBadModelInfoFileShouldDeleteTempFile\\n\\n- PredictionModelDownloadManagerTest.VerifiedCrxWithInvalidModelInfoShouldDeleteTempFile\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"3c25c43a60c6fd943add8d5033d11403aec6c541\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-10-dcpw\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17909, \"clang_revision\": \"llvmorg-13-init-4720-g7bafe336-1\", \"got_angle_revision\": \"90cf278c36871437c89b8f88d62e6a538b51501d\", \"got_dawn_revision\": \"6b80743d3f5bb389665590585c43eeb9cfa70a34\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"3c25c43a60c6fd943add8d5033d11403aec6c541\", \"got_revision_cp\": \"refs/heads/master@{#865002}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"6092f990f654f2d7a4534ee8c5bbb5c4fb800bdc\", \"got_v8_revision_cp\": \"refs/heads/9.1.170@{#1}\", \"got_webrtc_revision\": \"8bf1cd1c665a538a366bce4770acbb990b025388\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33513}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"swarm_hashes_refs/heads/master(at){#865002}_without_patch\": {\"absl_hardening_tests\": \"430bccc41f2a100a7b5ef20566092a05d4d9a52a\", \"accessibility_unittests\": \"54219b2f8801c877ef7de9ba0d53c61acb2e9150\", \"angle_unittests\": \"3b17946c8d14f1b0bfee09b3c646b812a50408c0\", \"app_shell_unittests\": \"6fa591daf7b8262302ee44970c83431e5741d349\", \"aura_unittests\": \"2aeb7b10e665e09a404331c07c9aeb3cb737d47d\", \"base_unittests\": \"19c0fc0078d9ce555d5083c142c6a2715ab53ed2\", \"base_util_unittests\": \"e44a38d6f23c4aa801f5db8ebf2d867747b58f53\", \"blink_common_unittests\": \"c7dac0c6b5b1eb92fc79362579d635af568e4715\", \"blink_fuzzer_unittests\": \"5bcf46ed7b30786ab886ad0330ae824478b341c9\", \"blink_heap_unittests\": \"2bad5f3b77adec25edbc31ef2b919e562cda94a9\", \"blink_platform_unittests\": \"169e7967241c5265b656330e424f9398b3d65cf9\", \"blink_unittests\": \"16d4716ca78d65e5928beb191bd0b19a92f14bd1\", \"boringssl_crypto_tests\": \"7bcb1746ae0cdff8b26c79ade8dcd8c92a2a935f\", \"boringssl_ssl_tests\": \"0907056c59c6a6a8e84f7855bc96dd8f528a2aec\", \"browser_switcher_bho_unittests\": \"ef06f30b8e6f506ca8d11b4093f63c83ea194136\", \"browser_tests\": \"7dd81098973c59870167465cf1ea10aac57b7319\", \"capture_unittests\": \"9f175f2fad291cfe8548686857ea5cbd33ec270a\", \"cast_unittests\": \"ef1c810be83dd306f6aab5434954e4add4771192\", \"cc_unittests\": \"733d89afdc20365ffd0d27ca7166982240d1c20b\", \"chrome_app_unittests\": \"0e151d5f378b823c044096da50c50f122aafe40c\", \"chrome_cleaner_unittests\": \"547c418a6f8b94c413b2b13d63ddd91722d41601\", \"chrome_elf_unittests\": \"17a3d5c060d35088627806d1b82a53ebe9811085\", \"chromedriver_unittests\": \"2e57f72b4c5e6206be61d6c2ebaf1b69b54c489a\", \"color_unittests\": \"d78dc3b0c9e9129872b5d86b46c150612e9321fe\", \"components_browsertests\": \"bb334f56e183dc64041d2994635c9b810628da20\", \"components_unittests\": \"83a7418af574f6c1be4826641b69beb09e25ac7e\", \"compositor_unittests\": \"60bbd733f9c27cf0226cedc7b2a571004684badd\", \"content_browsertests\": \"f99d1038282214bc0af2644392a7d1fbffbddd31\", \"content_unittests\": \"ea0a995f65a5b3c3d3c58766ad501b94ed8a4b1d\", \"courgette_unittests\": \"40ee4ffe6ce9cdac0c0e900927d4b2aa2af294ae\", \"crashpad_tests\": \"2c8d8f1434f5401f4751708fcc6c47d5bb867962\", \"cronet_tests\": \"06395d46360af2814f99590fabec11c0a8d68019\", \"cronet_unittests\": \"1916b5eda08162bf6c211cee0a218eaab2b340a5\", \"crypto_unittests\": \"6c29715e45a4f82e48850fcd27d7c6581f185aa5\", \"delayloads_unittests\": \"4947172d26b59e5079466556957f2b5b9a169fa4\", \"device_unittests\": \"97d24fab0397ea3a5188c03ae0d795e823426c1a\", \"display_unittests\": \"2d27e8495359063b8637aac6e6b1b545ede0951e\", \"elevation_service_unittests\": \"51dbf778f3ed9bff13ecc00161303126335bc1c2\", \"events_unittests\": \"0af161659ddd1c4e615069f40dbf94dd9f18914e\", \"extensions_browsertests\": \"4e9c38d0ebb33f02d6f626bee3ad93075849ef6c\", \"extensions_unittests\": \"a524fe2850f34a0078ef2f6b912b22aa5d33dd60\", \"filesystem_service_unittests\": \"c7d3f81574e9942790ec4f11fac8b85d0f271783\", \"gcm_unit_tests\": \"2394623d2ee66a9a22d1f7306dca40c8406fa68d\", \"gcp_unittests\": \"72ab4cd2bb42b7815b48bac90ee302b342031944\", \"gfx_unittests\": \"b10c77476d76cb968f751e20885448cf2d882083\", \"gin_unittests\": \"df72d87292222723efbf5ee7f2c3d56962dfe6fe\", \"google_apis_unittests\": \"621db8b016d8b19f719d982ac834d21318264970\", \"gpu_unittests\": \"0f09f14d76ebcdda09c15348a5cd7050fcf7e2c5\", \"gwp_asan_unittests\": \"a9292a564c891d649c057c3c5cbf5ce58789362a\", \"headless_browsertests\": \"77e6fa819731ab818d33662f09e73a4e4c6c93d9\", \"headless_unittests\": \"d472ba88bcdfc0954f885deba3af6f662ee92fda\", \"install_static_unittests\": \"f813b2d2c929262e8c8a73de60b632dc792e2332\", \"installer_util_unittests\": \"8e04ccdcc48250b76a51ce8c350ddd2ede4954d2\", \"interactive_ui_tests\": \"8c0bc5c66a318a1a56c28e35b6393b187b02a024\", \"ipc_tests\": \"76944d14b48cc962b67944261d3af1d1ee515400\", \"jingle_unittests\": \"4e361a76dffd511fa61273d1006b40830c9a36ef\", \"latency_unittests\": \"b40b487143ac47f1b36408ae4fcacab4e50a2afd\", \"libjingle_xmpp_unittests\": \"9cfee3bef9cb12ed57b2fd0925a393cd4379c102\", \"liburlpattern_unittests\": \"32ad8b56a488b3d13de2ca53aa6957da252b22e8\", \"media_blink_unittests\": \"cb97d481fafd1e41705a4bd3a3d6aed6c68b13fb\", \"media_unittests\": \"b0a34cb355d5b2af834aadbc7ea9968aa2d83d36\", \"message_center_unittests\": \"1276c2e8597b4eff9ca3f405b7dd01cd10f089ea\", \"midi_unittests\": \"68a0f72886e281c3381291e92a59a9e3a05e2a5e\", \"mojo_core_unittests\": \"5e1648187b5648f6c933dbf7c0ec4c5bbea1d756\", \"mojo_unittests\": \"1a575c2ff7c3ddf871742a8faf95b5245c531547\", \"nacl_loader_unittests\": \"fea86b652ec6d1336496ff6e788c27f41f8aeff8\", \"native_theme_unittests\": \"ed574010ebcd3b55abd1213f20485a685d5ce9a3\", \"net_unittests\": \"c07355215a1dcb41d8730e29dcbddcecb1de1cf7\", \"notification_helper_unittests\": \"898cc623d9db0659556b3161cac5bf07ffd73c1c\", \"pdf_unittests\": \"ab2ef0c797b4e8fb8fdcd112f30e6005ba2e97e2\", \"perfetto_unittests\": \"86660225f0e950b3e5da56ac9e785cce8867e5fd\", \"ppapi_unittests\": \"047b4b7607a21e7f2faac01bf46e7e1d7fd24813\", \"printing_unittests\": \"12726257fe45e38aaf5122a9359874b522d1fac3\", \"remoting_unittests\": \"ac698a76dc0c4e408918efa0042d1d22a2a63947\", \"sbox_integration_tests\": \"c2a0e5fa26055572675e1755bfd985dd320a5052\", \"sbox_unittests\": \"307045860e7dcdb86597183301ab1c40ab0c95d4\", \"sbox_validation_tests\": \"95b00926776c005867d1abad336011b537db52f0\", \"service_manager_unittests\": \"0071eadcbeb5b20539c67970000b3cc76135bfdf\", \"services_unittests\": \"da3a86c2155a02face0eee03eb4d09cbd37c2cfc\", \"setup_unittests\": \"7f5176a3748183a8318776e322a305924f23b0ca\", \"shell_dialogs_unittests\": \"16f025eddcb37c983b703d70d81d6b1a1c71f85d\", \"skia_unittests\": \"d5e57d8cfc19cea7d5cbfb6353758c01ef148ce4\", \"snapshot_unittests\": \"3cb8cf56541830d8b3fe2eefcacdf12f0990150f\", \"sql_unittests\": \"8cc0be45359e6462cee5a39a8cb8b6ea0780a997\", \"storage_unittests\": \"aef3d14b60d015aa4234c72bff025b500abf857d\", \"sync_integration_tests\": \"b2781e271cafc90acbd364f6fba0645f244277b2\", \"traffic_annotation_auditor_unittests\": \"b04e76a5bf28055d3384e6fbef0a8f934229f055\", \"ui_base_unittests\": \"c4c485fb82a5dada945da7389f20ca112563ea44\", \"ui_touch_selection_unittests\": \"582a8abd0b6a2c3798c51324e6e0cad84292ea33\", \"unit_tests\": \"d0a905d195ee9b6928decfa413e8d190028939fe\", \"updater_tests\": \"c19c89675df27ef765ab6a8779bf02b4dc06b5aa\", \"url_unittests\": \"2b6d21657cf7307f545ca95bcc9dd42261b38f71\", \"views_unittests\": \"d0845f53f559889f790daa37560a4296070baa20\", \"viz_unittests\": \"5b9be87505c629b173e4ba5fa0634c0e475f87fe\", \"vr_common_unittests\": \"90f64a8d6d4cb8003d71ecaa302a4980af786e38\", \"vr_pixeltests\": \"cc75e9a31c231a952552e10df7d57d382bb85a8d\", \"weblayer_browsertests\": \"8de8cb00a9ed59fbdda6da0765dca3cbbc1ed9fb\", \"weblayer_unittests\": \"82dc911fca853dd903bd7eed0db2c981f1d81a56\", \"wm_unittests\": \"751a1221b514274053f7256bd484000a13660c1e\", \"wtf_unittests\": \"c61bc6d93a16cc50590e60e6d8c18e6a02c35f37\", \"zlib_unittests\": \"de5713c73fa236b6a978c28f73ea84bb415897fb\", \"zucchini_unittests\": \"e7ad90e0810c029a1f46e9b95d001636c996a0ea\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-10-dcpw\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.13\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- PredictionModelDownloadManagerTest.VerifiedCrxWithBadModelInfoFileShouldDeleteTempFile\\n\\n- PredictionModelDownloadManagerTest.VerifiedCrxWithInvalidModelInfoShouldDeleteTempFile\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616350733226866",
"status": "COMPLETED",
"status_changed_ts": "1616350733473525",
"tags": [
"build_address:luci.chromium.ci/win-asan/17909",
"builder:win-asan",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c25c43a60c6fd943add8d5033d11403aec6c541",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017557193946689152",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852127131894944768/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:526ed466ebbbe210",
"user_agent:luci-scheduler"
],
"updated_ts": "1616354601255351",
"url": "https://ci.chromium.org/b/8852127131894944768",
"utcnow_ts": "1616354602480123"
}
}
[19:23:22.493] Invocation finished in 1h4m32.876718952s with status FAILED