[01:49:04.606] New invocation is queued and will start shortly
[01:49:05.735] Starting the invocation (attempt 1)
[01:49:05.769] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:49:05.769] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:49:05.770] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025773190640035456",
"parameters_json": "{\"builder_name\":\"ToTLinuxASanLibfuzzer\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f230ac0ae3f453c890912f357ee6e50a2c0ebd80\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTLinuxASanLibfuzzer",
"scheduler_invocation_id:9025773190640035456",
"scheduler_job_id:chromium/ToTLinuxASanLibfuzzer",
"user_agent:luci-scheduler",
"buildset:commit/git/f230ac0ae3f453c890912f357ee6e50a2c0ebd80",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f230ac0ae3f453c890912f357ee6e50a2c0ebd80",
"gitiles_ref:refs/heads/master"
]
}
[01:49:06.397] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608515345869856",
"id": "8860343128648436496",
"parameters_json": "{\"builder_name\": \"ToTLinuxASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f230ac0ae3f453c890912f357ee6e50a2c0ebd80\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608515346266487",
"tags": [
"build_address:luci.chromium.ci/ToTLinuxASanLibfuzzer/9944",
"builder:ToTLinuxASanLibfuzzer",
"buildset:commit/git/f230ac0ae3f453c890912f357ee6e50a2c0ebd80",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f230ac0ae3f453c890912f357ee6e50a2c0ebd80",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025773190640035456",
"scheduler_job_id:chromium/ToTLinuxASanLibfuzzer",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8860343128648436496/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1608515346266590",
"url": "https://ci.chromium.org/b/8860343128648436496",
"utcnow_ts": "1608515346390288"
}
}
[01:49:06.397] Task URL: https://ci.chromium.org/b/8860343128648436496
[01:49:06.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:2:0) after 1m0s
[01:50:06.495] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:2:0)
[01:50:06.495] Timer tick, asking Buildbucket for the build status
[01:50:06.588] Build 8860343128648436496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:06.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:3:0) after 1m0s
[01:50:09.901] Received PubSub notification, asking Buildbucket for the build status
[01:50:09.979] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:06.610] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:3:0)
[01:51:06.610] Timer tick, asking Buildbucket for the build status
[01:51:06.688] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:06.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:5:0) after 1m0s
[01:52:06.707] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:5:0)
[01:52:06.707] Timer tick, asking Buildbucket for the build status
[01:52:06.762] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:06.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:6:0) after 1m0s
[01:53:06.779] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:6:0)
[01:53:06.779] Timer tick, asking Buildbucket for the build status
[01:53:06.828] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:06.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:7:0) after 1m0s
[01:54:06.877] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:7:0)
[01:54:06.877] Timer tick, asking Buildbucket for the build status
[01:54:06.997] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:06.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:8:0) after 1m0s
[01:55:07.074] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:8:0)
[01:55:07.074] Timer tick, asking Buildbucket for the build status
[01:55:07.311] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:07.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:9:0) after 1m0s
[01:56:07.364] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:9:0)
[01:56:07.364] Timer tick, asking Buildbucket for the build status
[01:56:07.424] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:07.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:10:0) after 1m0s
[01:57:07.508] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:10:0)
[01:57:07.508] Timer tick, asking Buildbucket for the build status
[01:57:07.563] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:07.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:11:0) after 1m0s
[01:58:07.638] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:11:0)
[01:58:07.638] Timer tick, asking Buildbucket for the build status
[01:58:07.809] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:07.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:12:0) after 1m0s
[01:59:07.862] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:12:0)
[01:59:07.862] Timer tick, asking Buildbucket for the build status
[01:59:08.035] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:08.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:13:0) after 1m0s
[02:00:08.112] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:13:0)
[02:00:08.112] Timer tick, asking Buildbucket for the build status
[02:00:08.299] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:08.299] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:14:0) after 1m0s
[02:01:08.349] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:14:0)
[02:01:08.349] Timer tick, asking Buildbucket for the build status
[02:01:08.437] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:08.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:15:0) after 1m0s
[02:02:08.462] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:15:0)
[02:02:08.462] Timer tick, asking Buildbucket for the build status
[02:02:08.644] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:08.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:16:0) after 1m0s
[02:03:08.662] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:16:0)
[02:03:08.662] Timer tick, asking Buildbucket for the build status
[02:03:08.879] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:08.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:17:0) after 1m0s
[02:04:08.928] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:17:0)
[02:04:08.928] Timer tick, asking Buildbucket for the build status
[02:04:09.246] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:09.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:18:0) after 1m0s
[02:05:09.295] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:18:0)
[02:05:09.295] Timer tick, asking Buildbucket for the build status
[02:05:09.370] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:09.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:19:0) after 1m0s
[02:06:09.419] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:19:0)
[02:06:09.419] Timer tick, asking Buildbucket for the build status
[02:06:09.534] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:09.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:20:0) after 1m0s
[02:07:09.585] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:20:0)
[02:07:09.585] Timer tick, asking Buildbucket for the build status
[02:07:09.636] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:09.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:21:0) after 1m0s
[02:08:09.630] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:21:0)
[02:08:09.630] Timer tick, asking Buildbucket for the build status
[02:08:09.707] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:09.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:22:0) after 1m0s
[02:09:09.724] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:22:0)
[02:09:09.724] Timer tick, asking Buildbucket for the build status
[02:09:10.064] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:10.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:23:0) after 1m0s
[02:10:10.119] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:23:0)
[02:10:10.119] Timer tick, asking Buildbucket for the build status
[02:10:10.187] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:10.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:24:0) after 1m0s
[02:11:10.204] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:24:0)
[02:11:10.204] Timer tick, asking Buildbucket for the build status
[02:11:10.409] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:10.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:25:0) after 1m0s
[02:12:10.428] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:25:0)
[02:12:10.428] Timer tick, asking Buildbucket for the build status
[02:12:10.486] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:10.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:26:0) after 1m0s
[02:13:10.508] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:26:0)
[02:13:10.508] Timer tick, asking Buildbucket for the build status
[02:13:10.565] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:10.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:27:0) after 1m0s
[02:14:10.593] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:27:0)
[02:14:10.593] Timer tick, asking Buildbucket for the build status
[02:14:10.968] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:10.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:28:0) after 1m0s
[02:15:11.064] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:28:0)
[02:15:11.064] Timer tick, asking Buildbucket for the build status
[02:15:11.268] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:11.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:29:0) after 1m0s
[02:16:11.274] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:29:0)
[02:16:11.274] Timer tick, asking Buildbucket for the build status
[02:16:11.339] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:11.339] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:30:0) after 1m0s
[02:17:11.378] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:30:0)
[02:17:11.378] Timer tick, asking Buildbucket for the build status
[02:17:11.535] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:11.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:31:0) after 1m0s
[02:18:11.587] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:31:0)
[02:18:11.587] Timer tick, asking Buildbucket for the build status
[02:18:11.997] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:11.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:32:0) after 1m0s
[02:19:14.267] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:32:0)
[02:19:14.267] Timer tick, asking Buildbucket for the build status
[02:19:14.391] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:14.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:33:0) after 1m0s
[02:20:14.424] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:33:0)
[02:20:14.424] Timer tick, asking Buildbucket for the build status
[02:20:14.517] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:34:0) after 1m0s
[02:21:14.518] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:34:0)
[02:21:14.518] Timer tick, asking Buildbucket for the build status
[02:21:14.580] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:14.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:35:0) after 1m0s
[02:22:14.653] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:35:0)
[02:22:14.653] Timer tick, asking Buildbucket for the build status
[02:22:14.726] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:14.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:36:0) after 1m0s
[02:23:14.760] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:36:0)
[02:23:14.760] Timer tick, asking Buildbucket for the build status
[02:23:14.810] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:14.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:37:0) after 1m0s
[02:24:14.897] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:37:0)
[02:24:14.897] Timer tick, asking Buildbucket for the build status
[02:24:15.136] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:15.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:38:0) after 1m0s
[02:25:15.179] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:38:0)
[02:25:15.179] Timer tick, asking Buildbucket for the build status
[02:25:15.232] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:15.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:39:0) after 1m0s
[02:26:15.274] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:39:0)
[02:26:15.274] Timer tick, asking Buildbucket for the build status
[02:26:15.351] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:15.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:40:0) after 1m0s
[02:27:15.442] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:40:0)
[02:27:15.442] Timer tick, asking Buildbucket for the build status
[02:27:15.497] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:15.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:41:0) after 1m0s
[02:28:15.627] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:41:0)
[02:28:15.627] Timer tick, asking Buildbucket for the build status
[02:28:15.690] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:15.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:42:0) after 1m0s
[02:29:15.775] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:42:0)
[02:29:15.775] Timer tick, asking Buildbucket for the build status
[02:29:15.962] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:15.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:43:0) after 1m0s
[02:30:16.005] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:43:0)
[02:30:16.005] Timer tick, asking Buildbucket for the build status
[02:30:16.180] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:16.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:44:0) after 1m0s
[02:31:16.292] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:44:0)
[02:31:16.292] Timer tick, asking Buildbucket for the build status
[02:31:16.383] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:16.383] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:45:0) after 1m0s
[02:32:16.425] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:45:0)
[02:32:16.425] Timer tick, asking Buildbucket for the build status
[02:32:16.737] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:16.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:46:0) after 1m0s
[02:33:17.144] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:46:0)
[02:33:17.144] Timer tick, asking Buildbucket for the build status
[02:33:17.198] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:17.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:47:0) after 1m0s
[02:34:17.320] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:47:0)
[02:34:17.320] Timer tick, asking Buildbucket for the build status
[02:34:17.587] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:17.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:48:0) after 1m0s
[02:35:17.778] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:48:0)
[02:35:17.778] Timer tick, asking Buildbucket for the build status
[02:35:17.945] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:17.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:49:0) after 1m0s
[02:36:18.330] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:49:0)
[02:36:18.330] Timer tick, asking Buildbucket for the build status
[02:36:18.389] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:18.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:50:0) after 1m0s
[02:37:18.693] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:50:0)
[02:37:18.693] Timer tick, asking Buildbucket for the build status
[02:37:18.927] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:18.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:51:0) after 1m0s
[02:38:18.938] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:51:0)
[02:38:18.938] Timer tick, asking Buildbucket for the build status
[02:38:19.002] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:19.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:52:0) after 1m0s
[02:39:19.112] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:52:0)
[02:39:19.112] Timer tick, asking Buildbucket for the build status
[02:39:19.231] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:19.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:53:0) after 1m0s
[02:40:19.431] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:53:0)
[02:40:19.431] Timer tick, asking Buildbucket for the build status
[02:40:19.497] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:19.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:54:0) after 1m0s
[02:41:19.650] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:54:0)
[02:41:19.650] Timer tick, asking Buildbucket for the build status
[02:41:19.715] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:19.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:55:0) after 1m0s
[02:42:19.768] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:55:0)
[02:42:19.768] Timer tick, asking Buildbucket for the build status
[02:42:19.833] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:19.833] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:56:0) after 1m0s
[02:43:19.878] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:56:0)
[02:43:19.878] Timer tick, asking Buildbucket for the build status
[02:43:19.948] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:19.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:57:0) after 1m0s
[02:44:20.017] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:57:0)
[02:44:20.017] Timer tick, asking Buildbucket for the build status
[02:44:20.261] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:20.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:58:0) after 1m0s
[02:45:20.285] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:58:0)
[02:45:20.285] Timer tick, asking Buildbucket for the build status
[02:45:20.337] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:20.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:59:0) after 1m0s
[02:46:20.372] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:59:0)
[02:46:20.372] Timer tick, asking Buildbucket for the build status
[02:46:20.525] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:20.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:60:0) after 1m0s
[02:47:20.706] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:60:0)
[02:47:20.706] Timer tick, asking Buildbucket for the build status
[02:47:20.771] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:20.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:61:0) after 1m0s
[02:48:20.805] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:61:0)
[02:48:20.805] Timer tick, asking Buildbucket for the build status
[02:48:20.893] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:20.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:62:0) after 1m0s
[02:49:20.966] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:62:0)
[02:49:20.966] Timer tick, asking Buildbucket for the build status
[02:49:21.088] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:21.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:63:0) after 1m0s
[02:50:21.210] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:63:0)
[02:50:21.210] Timer tick, asking Buildbucket for the build status
[02:50:21.273] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:21.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:64:0) after 1m0s
[02:51:21.296] Handling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:64:0)
[02:51:21.296] Timer tick, asking Buildbucket for the build status
[02:51:21.366] Build 8860343128648436496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:21.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTLinuxASanLibfuzzer:9025773190640035456:65:0) after 1m0s
[02:51:54.794] Received PubSub notification, asking Buildbucket for the build status
[02:51:54.951] Build 8860343128648436496: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:51:54.951] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608519114382802",
"created_by": "project:chromium",
"created_ts": "1608515345869856",
"failure_reason": "BUILD_FAILURE",
"id": "8860343128648436496",
"parameters_json": "{\"builder_name\": \"ToTLinuxASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f230ac0ae3f453c890912f357ee6e50a2c0ebd80\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[16075/72875] CXX obj/services/service_manager/public/mojom/mojom/service_manager.mojom.o\\nFAILED: obj/services/service_manager/public/mojom/mojom/service_manager.mojom.o\\n../../third_party/llvm-build/Release+Asserts/bin/clang++ -MMD -MF obj/services/service_manager/publi...(too long)\\nclang++: /b/s/w/ir/cache/builder/src/third_party/llvm/clang/lib/AST/ItaniumMangle.cpp:5798: void {anonymous}::CXXNameMangler::addSubstitution(uintptr_t): Assertion `!Substitutions.count(Ptr) \u0026\u0026 \\\"Substitution already exists!\\\"' failed.\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$build/goma\": {\"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"f230ac0ae3f453c890912f357ee6e50a2c0ebd80\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"tot-linux-asan-libfuzzer-0-r16y\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTLinuxASanLibfuzzer\", \"buildnumber\": 9944, \"clang_revision\": \"llvmorg-12-init-15019-g966f1431-0\", \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"f230ac0ae3f453c890912f357ee6e50a2c0ebd80\", \"got_revision_cp\": \"refs/heads/master@{#838584}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"73bf5d7db9ade92643424d79b47ac70900843225\", \"got_v8_revision_cp\": \"refs/heads/8.9.178@{#1}\", \"got_webrtc_revision\": \"ef9c4e07a351c9396c72e72efaa1be3df728c440\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32863}\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f230ac0ae3f453c890912f357ee6e50a2c0ebd80\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"ToTLinuxASanLibfuzzer\"], \"caches\": [\"builder_924a2904afcfcbbd328cfdc1142e002c0741d79827cb236e881001489d34b9e2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"tot-linux-asan-libfuzzer-0-r16y\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[16075/72875] CXX obj/services/service_manager/public/mojom/mojom/service_manager.mojom.o\\nFAILED: obj/services/service_manager/public/mojom/mojom/service_manager.mojom.o\\n../../third_party/llvm-build/Release+Asserts/bin/clang++ -MMD -MF obj/services/service_manager/publi...(too long)\\nclang++: /b/s/w/ir/cache/builder/src/third_party/llvm/clang/lib/AST/ItaniumMangle.cpp:5798: void {anonymous}::CXXNameMangler::addSubstitution(uintptr_t): Assertion `!Substitutions.count(Ptr) \u0026\u0026 \\\"Substitution already exists!\\\"' failed.\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608515409045354",
"status": "COMPLETED",
"status_changed_ts": "1608515409688947",
"tags": [
"build_address:luci.chromium.ci/ToTLinuxASanLibfuzzer/9944",
"builder:ToTLinuxASanLibfuzzer",
"buildset:commit/git/f230ac0ae3f453c890912f357ee6e50a2c0ebd80",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f230ac0ae3f453c890912f357ee6e50a2c0ebd80",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025773190640035456",
"scheduler_job_id:chromium/ToTLinuxASanLibfuzzer",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8860343128648436496/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:509bcde82da50b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608519114447639",
"url": "https://ci.chromium.org/b/8860343128648436496",
"utcnow_ts": "1608519114943476"
}
}
[02:51:54.951] Invocation finished in 1h2m50.36496998s with status FAILED