[07:52:12.954] New invocation is queued and will start shortly
[07:52:14.151] Starting the invocation (attempt 1)
[07:52:14.190] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:52:14.190] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:52:14.191] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019680347148256320",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ca967f170eca13c9b740202daf6b3b86e9c809b8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019680347148256320",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"gitiles_ref:refs/heads/master"
]
}
[07:52:14.787] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614325934273776",
"id": "8854250285102448912",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614325934651527",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22789",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019680347148256320",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854250285102448912/+/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": "1614325934651640",
"url": "https://ci.chromium.org/b/8854250285102448912",
"utcnow_ts": "1614325934780714"
}
}
[07:52:14.787] Task URL: https://ci.chromium.org/b/8854250285102448912
[07:52:14.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:2:0) after 1m0s
[07:53:14.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:2:0)
[07:53:14.825] Timer tick, asking Buildbucket for the build status
[07:53:14.909] Build 8854250285102448912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:53:14.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:3:0) after 1m0s
[07:54:14.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:3:0)
[07:54:14.954] Timer tick, asking Buildbucket for the build status
[07:54:15.225] Build 8854250285102448912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:54:15.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:4:0) after 1m0s
[07:55:15.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:4:0)
[07:55:15.344] Timer tick, asking Buildbucket for the build status
[07:55:15.405] Build 8854250285102448912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:55:15.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:5:0) after 1m0s
[07:56:15.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:5:0)
[07:56:15.408] Timer tick, asking Buildbucket for the build status
[07:56:15.484] Build 8854250285102448912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:56:15.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:6:0) after 1m0s
[07:57:11.249] Received PubSub notification, asking Buildbucket for the build status
[07:57:11.313] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:15.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:6:0)
[07:57:15.497] Timer tick, asking Buildbucket for the build status
[07:57:15.627] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:15.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:8:0) after 1m0s
[07:58:15.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:8:0)
[07:58:15.644] Timer tick, asking Buildbucket for the build status
[07:58:15.809] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:15.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:9:0) after 1m0s
[07:59:15.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:9:0)
[07:59:15.880] Timer tick, asking Buildbucket for the build status
[07:59:16.034] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:16.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:10:0) after 1m0s
[08:00:16.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:10:0)
[08:00:16.079] Timer tick, asking Buildbucket for the build status
[08:00:16.163] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:16.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:11:0) after 1m0s
[08:01:16.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:11:0)
[08:01:16.800] Timer tick, asking Buildbucket for the build status
[08:01:16.887] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:16.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:12:0) after 1m0s
[08:02:16.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:12:0)
[08:02:16.964] Timer tick, asking Buildbucket for the build status
[08:02:17.118] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:17.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:13:0) after 1m0s
[08:03:17.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:13:0)
[08:03:17.171] Timer tick, asking Buildbucket for the build status
[08:03:17.293] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:17.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:14:0) after 1m0s
[08:04:17.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:14:0)
[08:04:17.334] Timer tick, asking Buildbucket for the build status
[08:04:17.602] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:17.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:15:0) after 1m0s
[08:05:17.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:15:0)
[08:05:17.823] Timer tick, asking Buildbucket for the build status
[08:05:17.903] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:17.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:16:0) after 1m0s
[08:06:18.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:16:0)
[08:06:18.050] Timer tick, asking Buildbucket for the build status
[08:06:18.136] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:18.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:17:0) after 1m0s
[08:07:18.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:17:0)
[08:07:18.260] Timer tick, asking Buildbucket for the build status
[08:07:18.564] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:18.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:18:0) after 1m0s
[08:08:18.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:18:0)
[08:08:18.585] Timer tick, asking Buildbucket for the build status
[08:08:18.681] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:18.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:19:0) after 1m0s
[08:09:18.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:19:0)
[08:09:18.723] Timer tick, asking Buildbucket for the build status
[08:09:18.824] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:18.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:20:0) after 1m0s
[08:10:19.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:20:0)
[08:10:19.005] Timer tick, asking Buildbucket for the build status
[08:10:19.144] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:19.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:21:0) after 1m0s
[08:11:19.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:21:0)
[08:11:19.260] Timer tick, asking Buildbucket for the build status
[08:11:19.368] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:19.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:22:0) after 1m0s
[08:12:19.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:22:0)
[08:12:19.387] Timer tick, asking Buildbucket for the build status
[08:12:19.493] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:19.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:23:0) after 1m0s
[08:13:19.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:23:0)
[08:13:19.519] Timer tick, asking Buildbucket for the build status
[08:13:19.741] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:19.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:24:0) after 1m0s
[08:14:19.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:24:0)
[08:14:19.804] Timer tick, asking Buildbucket for the build status
[08:14:19.943] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:19.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:25:0) after 1m0s
[08:15:20.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:25:0)
[08:15:20.038] Timer tick, asking Buildbucket for the build status
[08:15:21.777] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:21.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:26:0) after 1m0s
[08:16:21.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:26:0)
[08:16:21.888] Timer tick, asking Buildbucket for the build status
[08:16:22.124] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:22.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:27:0) after 1m0s
[08:17:22.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:27:0)
[08:17:22.201] Timer tick, asking Buildbucket for the build status
[08:17:22.697] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:22.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:28:0) after 1m0s
[08:18:22.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:28:0)
[08:18:22.746] Timer tick, asking Buildbucket for the build status
[08:18:22.848] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:22.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:29:0) after 1m0s
[08:19:23.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:29:0)
[08:19:23.029] Timer tick, asking Buildbucket for the build status
[08:19:23.620] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:23.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:30:0) after 1m0s
[08:20:23.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:30:0)
[08:20:23.594] Timer tick, asking Buildbucket for the build status
[08:20:23.678] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:23.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:31:0) after 1m0s
[08:21:23.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:31:0)
[08:21:23.734] Timer tick, asking Buildbucket for the build status
[08:21:23.927] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:23.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:32:0) after 1m0s
[08:22:23.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:32:0)
[08:22:23.979] Timer tick, asking Buildbucket for the build status
[08:22:24.143] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:24.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:33:0) after 1m0s
[08:23:24.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:33:0)
[08:23:24.163] Timer tick, asking Buildbucket for the build status
[08:23:24.434] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:24.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:34:0) after 1m0s
[08:24:24.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:34:0)
[08:24:24.514] Timer tick, asking Buildbucket for the build status
[08:24:24.600] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:24.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:35:0) after 1m0s
[08:25:24.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:35:0)
[08:25:24.674] Timer tick, asking Buildbucket for the build status
[08:25:24.750] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:24.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:36:0) after 1m0s
[08:26:24.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:36:0)
[08:26:24.801] Timer tick, asking Buildbucket for the build status
[08:26:24.972] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:24.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:37:0) after 1m0s
[08:27:25.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:37:0)
[08:27:25.019] Timer tick, asking Buildbucket for the build status
[08:27:25.096] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:25.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:38:0) after 1m0s
[08:28:25.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:38:0)
[08:28:25.150] Timer tick, asking Buildbucket for the build status
[08:28:25.246] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:25.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:39:0) after 1m0s
[08:29:25.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:39:0)
[08:29:25.265] Timer tick, asking Buildbucket for the build status
[08:29:25.330] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:25.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:40:0) after 1m0s
[08:30:25.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:40:0)
[08:30:25.378] Timer tick, asking Buildbucket for the build status
[08:30:25.458] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:25.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:41:0) after 1m0s
[08:31:25.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:41:0)
[08:31:25.442] Timer tick, asking Buildbucket for the build status
[08:31:25.543] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:25.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:42:0) after 1m0s
[08:32:25.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:42:0)
[08:32:25.608] Timer tick, asking Buildbucket for the build status
[08:32:25.716] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:25.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:43:0) after 1m0s
[08:33:25.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:43:0)
[08:33:25.769] Timer tick, asking Buildbucket for the build status
[08:33:25.860] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:25.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:44:0) after 1m0s
[08:34:25.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:44:0)
[08:34:25.875] Timer tick, asking Buildbucket for the build status
[08:34:26.015] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:26.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:45:0) after 1m0s
[08:35:26.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:45:0)
[08:35:26.066] Timer tick, asking Buildbucket for the build status
[08:35:26.332] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:26.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:46:0) after 1m0s
[08:36:26.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:46:0)
[08:36:26.362] Timer tick, asking Buildbucket for the build status
[08:36:26.812] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:26.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:47:0) after 1m0s
[08:37:26.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:47:0)
[08:37:26.926] Timer tick, asking Buildbucket for the build status
[08:37:27.274] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:27.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:48:0) after 1m0s
[08:38:27.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:48:0)
[08:38:27.302] Timer tick, asking Buildbucket for the build status
[08:38:27.625] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:27.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:49:0) after 1m0s
[08:39:27.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:49:0)
[08:39:27.688] Timer tick, asking Buildbucket for the build status
[08:39:27.816] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:27.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:50:0) after 1m0s
[08:40:27.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:50:0)
[08:40:27.853] Timer tick, asking Buildbucket for the build status
[08:40:28.118] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:28.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:51:0) after 1m0s
[08:41:28.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:51:0)
[08:41:28.174] Timer tick, asking Buildbucket for the build status
[08:41:28.244] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:28.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:52:0) after 1m0s
[08:42:28.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:52:0)
[08:42:28.392] Timer tick, asking Buildbucket for the build status
[08:42:28.954] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:28.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:53:0) after 1m0s
[08:43:29.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:53:0)
[08:43:29.012] Timer tick, asking Buildbucket for the build status
[08:43:29.092] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:29.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:54:0) after 1m0s
[08:44:29.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:54:0)
[08:44:29.109] Timer tick, asking Buildbucket for the build status
[08:44:29.218] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:29.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:55:0) after 1m0s
[08:45:29.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:55:0)
[08:45:29.227] Timer tick, asking Buildbucket for the build status
[08:45:29.493] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:29.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:56:0) after 1m0s
[08:46:29.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:56:0)
[08:46:29.580] Timer tick, asking Buildbucket for the build status
[08:46:29.656] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:29.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:57:0) after 1m0s
[08:47:29.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:57:0)
[08:47:29.709] Timer tick, asking Buildbucket for the build status
[08:47:29.830] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:29.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:58:0) after 1m0s
[08:48:29.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:58:0)
[08:48:29.941] Timer tick, asking Buildbucket for the build status
[08:48:30.028] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:30.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:59:0) after 1m0s
[08:49:30.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:59:0)
[08:49:30.066] Timer tick, asking Buildbucket for the build status
[08:49:30.197] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:30.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:60:0) after 1m0s
[08:50:30.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:60:0)
[08:50:30.216] Timer tick, asking Buildbucket for the build status
[08:50:30.305] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:30.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:61:0) after 1m0s
[08:51:30.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:61:0)
[08:51:30.339] Timer tick, asking Buildbucket for the build status
[08:51:30.412] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:30.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:62:0) after 1m0s
[08:52:30.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:62:0)
[08:52:30.408] Timer tick, asking Buildbucket for the build status
[08:52:30.495] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:30.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:63:0) after 1m0s
[08:53:30.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:63:0)
[08:53:30.512] Timer tick, asking Buildbucket for the build status
[08:53:30.792] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:30.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:64:0) after 1m0s
[08:54:30.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:64:0)
[08:54:30.846] Timer tick, asking Buildbucket for the build status
[08:54:30.928] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:30.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:65:0) after 1m0s
[08:55:30.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:65:0)
[08:55:30.946] Timer tick, asking Buildbucket for the build status
[08:55:31.049] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:31.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:66:0) after 1m0s
[08:56:31.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:66:0)
[08:56:31.085] Timer tick, asking Buildbucket for the build status
[08:56:31.387] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:31.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:67:0) after 1m0s
[08:57:31.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:67:0)
[08:57:31.366] Timer tick, asking Buildbucket for the build status
[08:57:31.691] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:31.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:68:0) after 1m0s
[08:58:31.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:68:0)
[08:58:31.736] Timer tick, asking Buildbucket for the build status
[08:58:32.112] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:32.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:69:0) after 1m0s
[08:59:32.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:69:0)
[08:59:32.197] Timer tick, asking Buildbucket for the build status
[08:59:32.301] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:32.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:70:0) after 1m0s
[09:00:32.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:70:0)
[09:00:32.389] Timer tick, asking Buildbucket for the build status
[09:00:32.622] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:32.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:71:0) after 1m0s
[09:01:32.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:71:0)
[09:01:32.676] Timer tick, asking Buildbucket for the build status
[09:01:32.942] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:32.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:72:0) after 1m0s
[09:02:33.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:72:0)
[09:02:33.056] Timer tick, asking Buildbucket for the build status
[09:02:33.162] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:33.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:73:0) after 1m0s
[09:03:33.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:73:0)
[09:03:33.240] Timer tick, asking Buildbucket for the build status
[09:03:33.329] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:33.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:74:0) after 1m0s
[09:04:33.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:74:0)
[09:04:33.395] Timer tick, asking Buildbucket for the build status
[09:04:33.660] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:33.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:75:0) after 1m0s
[09:05:33.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:75:0)
[09:05:33.729] Timer tick, asking Buildbucket for the build status
[09:05:33.827] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:33.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:76:0) after 1m0s
[09:06:33.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:76:0)
[09:06:33.853] Timer tick, asking Buildbucket for the build status
[09:06:33.935] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:33.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:77:0) after 1m0s
[09:07:33.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:77:0)
[09:07:33.952] Timer tick, asking Buildbucket for the build status
[09:07:34.640] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:34.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:78:0) after 1m0s
[09:08:34.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:78:0)
[09:08:34.695] Timer tick, asking Buildbucket for the build status
[09:08:34.775] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:34.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:79:0) after 1m0s
[09:09:34.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:79:0)
[09:09:34.794] Timer tick, asking Buildbucket for the build status
[09:09:34.971] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:34.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:80:0) after 1m0s
[09:10:34.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:80:0)
[09:10:34.986] Timer tick, asking Buildbucket for the build status
[09:10:35.082] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:35.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:81:0) after 1m0s
[09:11:36.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:81:0)
[09:11:36.903] Timer tick, asking Buildbucket for the build status
[09:11:36.994] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:36.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:82:0) after 1m0s
[09:12:37.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:82:0)
[09:12:37.299] Timer tick, asking Buildbucket for the build status
[09:12:37.386] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:37.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:83:0) after 1m0s
[09:13:37.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:83:0)
[09:13:37.492] Timer tick, asking Buildbucket for the build status
[09:13:37.595] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:37.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:84:0) after 1m0s
[09:14:37.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:84:0)
[09:14:37.626] Timer tick, asking Buildbucket for the build status
[09:14:37.893] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:37.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:85:0) after 1m0s
[09:15:37.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:85:0)
[09:15:37.989] Timer tick, asking Buildbucket for the build status
[09:15:38.075] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:38.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:86:0) after 1m0s
[09:16:38.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:86:0)
[09:16:38.145] Timer tick, asking Buildbucket for the build status
[09:16:38.259] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:38.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:87:0) after 1m0s
[09:17:38.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:87:0)
[09:17:38.334] Timer tick, asking Buildbucket for the build status
[09:17:38.437] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:38.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:88:0) after 1m0s
[09:18:38.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:88:0)
[09:18:38.569] Timer tick, asking Buildbucket for the build status
[09:18:38.656] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:38.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:89:0) after 1m0s
[09:19:38.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:89:0)
[09:19:38.857] Timer tick, asking Buildbucket for the build status
[09:19:38.957] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:38.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:90:0) after 1m0s
[09:20:38.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:90:0)
[09:20:38.980] Timer tick, asking Buildbucket for the build status
[09:20:39.117] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:39.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:91:0) after 1m0s
[09:21:39.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:91:0)
[09:21:39.465] Timer tick, asking Buildbucket for the build status
[09:21:39.558] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:39.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:92:0) after 1m0s
[09:22:39.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:92:0)
[09:22:39.948] Timer tick, asking Buildbucket for the build status
[09:22:40.048] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:40.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:93:0) after 1m0s
[09:23:40.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:93:0)
[09:23:40.228] Timer tick, asking Buildbucket for the build status
[09:23:40.399] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:40.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:94:0) after 1m0s
[09:24:40.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:94:0)
[09:24:40.557] Timer tick, asking Buildbucket for the build status
[09:24:40.642] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:40.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:95:0) after 1m0s
[09:25:40.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:95:0)
[09:25:40.700] Timer tick, asking Buildbucket for the build status
[09:25:40.793] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:40.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:96:0) after 1m0s
[09:26:40.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:96:0)
[09:26:40.802] Timer tick, asking Buildbucket for the build status
[09:26:40.941] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:40.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:97:0) after 1m0s
[09:27:41.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:97:0)
[09:27:41.113] Timer tick, asking Buildbucket for the build status
[09:27:41.445] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:41.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:98:0) after 1m0s
[09:28:41.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:98:0)
[09:28:41.519] Timer tick, asking Buildbucket for the build status
[09:28:41.599] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:41.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:99:0) after 1m0s
[09:29:41.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:99:0)
[09:29:41.660] Timer tick, asking Buildbucket for the build status
[09:29:41.761] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:41.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:100:0) after 1m0s
[09:30:41.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:100:0)
[09:30:41.821] Timer tick, asking Buildbucket for the build status
[09:30:42.077] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:42.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:101:0) after 1m0s
[09:31:42.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:101:0)
[09:31:42.157] Timer tick, asking Buildbucket for the build status
[09:31:42.494] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:42.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:102:0) after 1m0s
[09:32:42.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:102:0)
[09:32:42.614] Timer tick, asking Buildbucket for the build status
[09:32:44.325] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:44.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:103:0) after 1m0s
[09:33:44.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:103:0)
[09:33:44.375] Timer tick, asking Buildbucket for the build status
[09:33:44.451] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:44.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:104:0) after 1m0s
[09:34:44.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:104:0)
[09:34:44.468] Timer tick, asking Buildbucket for the build status
[09:34:44.693] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:44.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:105:0) after 1m0s
[09:35:44.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:105:0)
[09:35:44.706] Timer tick, asking Buildbucket for the build status
[09:35:44.890] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:44.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:106:0) after 1m0s
[09:36:44.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:106:0)
[09:36:44.942] Timer tick, asking Buildbucket for the build status
[09:36:45.069] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:45.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:107:0) after 1m0s
[09:37:45.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:107:0)
[09:37:45.158] Timer tick, asking Buildbucket for the build status
[09:37:45.890] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:45.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:108:0) after 1m0s
[09:38:45.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:108:0)
[09:38:45.909] Timer tick, asking Buildbucket for the build status
[09:38:46.055] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:46.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:109:0) after 1m0s
[09:39:46.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:109:0)
[09:39:46.078] Timer tick, asking Buildbucket for the build status
[09:39:46.395] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:46.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:110:0) after 1m0s
[09:40:46.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:110:0)
[09:40:46.432] Timer tick, asking Buildbucket for the build status
[09:40:46.653] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:46.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:111:0) after 1m0s
[09:41:46.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:111:0)
[09:41:46.737] Timer tick, asking Buildbucket for the build status
[09:41:47.000] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:47.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:112:0) after 1m0s
[09:42:47.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:112:0)
[09:42:47.062] Timer tick, asking Buildbucket for the build status
[09:42:47.147] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:47.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:113:0) after 1m0s
[09:43:47.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:113:0)
[09:43:47.120] Timer tick, asking Buildbucket for the build status
[09:43:47.201] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:47.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:114:0) after 1m0s
[09:44:47.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:114:0)
[09:44:47.286] Timer tick, asking Buildbucket for the build status
[09:44:47.506] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:47.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:115:0) after 1m0s
[09:45:47.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:115:0)
[09:45:47.542] Timer tick, asking Buildbucket for the build status
[09:45:47.633] Build 8854250285102448912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:47.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019680347148256320:116:0) after 1m0s
[09:46:32.165] Received PubSub notification, asking Buildbucket for the build status
[09:46:32.265] Build 8854250285102448912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:46:32.265] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614332791200769",
"created_by": "project:chromium",
"created_ts": "1614325934273776",
"id": "8854250285102448912",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\", \"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\": \"luci-chromium-ci-xenial-us-central1-b-8-51-3r19\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22789, \"got_angle_revision\": \"77637f2dd222530c721018185a90e24a51e7a745\", \"got_dawn_revision\": \"87649ff09dee357f0412834527e4174b4989358f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\", \"got_revision_cp\": \"refs/heads/master@{#858051}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"bb52bdf09516ca548c4aff50526eda561f239bc0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33341}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca967f170eca13c9b740202daf6b3b86e9c809b8\", \"swarm_hashes_refs/heads/master(at){#858051}_without_patch\": {\"absl_hardening_tests\": \"4ea543b45004cb13f9e97b3330f3d3b1440142d8\", \"accessibility_unittests\": \"efad74e56c79bd1d4d2c198f425a6d91424b37a4\", \"angle_unittests\": \"a7419ebed7d55bbb03314d51eab9cf14b0e96982\", \"app_list_unittests\": \"7ed3c504ff3486abc4e87b59477a21e629bf60a4\", \"app_shell_unittests\": \"01a6a8c979b98fdf2baa8ec7feaa1f67c8193555\", \"ash_unittests\": \"1b25fcf9c4890b8aac00704612b0933dd69a967a\", \"aura_unittests\": \"301d761978bf580e9e49ec5ba745d3ce9c8c7d64\", \"base_unittests\": \"004ab163e15a85a5480fa5868442d30d2863a224\", \"base_util_unittests\": \"d7b06c621621f7d658d8f2226818f77087a93fcc\", \"blink_common_unittests\": \"508f5cba23a2e6de6b13917f8173ad9d16172d85\", \"blink_fuzzer_unittests\": \"403aab78cf10fca9a0b94c79e72f93754410c64d\", \"blink_heap_unittests\": \"27450dd47b86aa738c2bfd232be5f2a7999495f6\", \"blink_platform_unittests\": \"43c836acea90f12beba8a880493aa59fcb7549be\", \"blink_unittests\": \"c6a8487227502214d2c79b39dd870f432abd84af\", \"boringssl_crypto_tests\": \"1e4bad8c932044104089785fb5e837fe9112d9d1\", \"boringssl_ssl_tests\": \"a57dd865e67f3e20db31aa9463c8c0379fce8275\", \"browser_tests\": \"86b7bffeba9c87516d085acc8f832adf39e285b2\", \"capture_unittests\": \"67717a32eba9e1a61ff36469204d1ca2d2151193\", \"cast_unittests\": \"cb2d4ba3439b29413fd27705e01763d2423db62b\", \"cc_unittests\": \"d3b4a3c14dc71bed62cd3ce64ba8dbe49618f6bd\", \"chrome_app_unittests\": \"06a45c9de52b909b92c1a8c6c35182178ee29ba4\", \"chromedriver_unittests\": \"004587310e9e5f352ae748c4db0ac3b9d51ac8e5\", \"chromeos_components_unittests\": \"c184039c37e6eb09abf418afce517d276a23bee2\", \"chromeos_unittests\": \"313ee0876b6fb071c12c5f1ddb481e8eed99cc7c\", \"color_unittests\": \"fb832fd118db7ffa61c7554f9b5fad71b0901a10\", \"components_browsertests\": \"282cb8a28fdc25b428571d76bdb6a807be0a8cf4\", \"components_unittests\": \"226bc4badb7016f9a65bd682f75d5524d987f632\", \"compositor_unittests\": \"7a1f38b204fa6cb26777b41c8d8d02c7a54ffb8f\", \"content_browsertests\": \"86914262693e639e432c57f021f7d0e34ff5ef26\", \"content_unittests\": \"dd0e6d2e0dc0a943a6957bf3d5ca8f679cdfe63b\", \"crashpad_tests\": \"97972188f3fd4ec9345058769846ae45324ec482\", \"crypto_unittests\": \"ef4dbd4510ea3f5e258afd9db1f901e07c63c003\", \"dbus_unittests\": \"5eba88e177dacbb7ae9a1cf2d5d717c19c15d8ac\", \"device_unittests\": \"e81512123fbdb88eb2fd3c3af62b7daf69eccc56\", \"display_unittests\": \"89554b6a4b98ab0424e32523a5cf6d9a226fe5f1\", \"events_unittests\": \"cc176a4fda608a8f506ce04dc77e3e864af5a6cf\", \"exo_unittests\": \"d4edd06165f7596ee30cd74f8410c730ca61aa08\", \"extensions_browsertests\": \"6514dc4ae52f79ccaeca98d4732f1dae1a586b70\", \"extensions_unittests\": \"ac68f8459a85c16ec18712b8a1de8c4a668a73f2\", \"filesystem_service_unittests\": \"e14f265048f19c9707bb7cd0619af05a21675083\", \"gcm_unit_tests\": \"84364bc8dd7e704f40f01eb266f60d63eab8d144\", \"gfx_unittests\": \"d5f1fc9ab14d4a9bff1ce8a88b0d7326b5a58138\", \"gin_unittests\": \"f1b596f5a2201e694925b2fd4319da8e3188c95e\", \"gl_unittests_ozone\": \"ec43b14e30e480232a70f09a2ad20810499ee87c\", \"google_apis_unittests\": \"6882acad9e426906a6d3f7e1393c613de5eb1094\", \"gpu_unittests\": \"66e1a40209e42a99cf131c7595efe7300ea26268\", \"gwp_asan_unittests\": \"36c032db13b4b55d77c23b9951cd2dfbf12bfb1d\", \"interactive_ui_tests\": \"4510abd4b202d8bc2f1468717c04ddcf0fbb57a4\", \"ipc_tests\": \"0761a93f78abaa3f42f981327b4ae82c67bbeb2c\", \"jingle_unittests\": \"d3e2bbea74b154d172b4f2d867fd6d4a953042e2\", \"keyboard_unittests\": \"ccb3dc6008c0ecb9963ce89f37bd80fa62612644\", \"latency_unittests\": \"f2634cef0d661c631b76522db910f2dc16805e94\", \"libjingle_xmpp_unittests\": \"2da7a787438ae79502c13835fa1bd1221fede0a1\", \"liburlpattern_unittests\": \"f64bc5507021ef4bff84ab730d35dcf1aeeb0ebf\", \"media_blink_unittests\": \"bc3a0ec83292fdd02e0446112115831069914b96\", \"media_unittests\": \"11be74d0bfcab7131a21e1ff83eebfcdd4a3cd7e\", \"message_center_unittests\": \"d36b8a347713abd3a896b53107a0a498b3d7e904\", \"midi_unittests\": \"41e956dabf99099a246a2956acc5bfb74fb7e133\", \"mojo_core_unittests\": \"d6f2f942df0ccb9cdab6d42929379f280d6ea77c\", \"mojo_unittests\": \"9442c9f405e2fd49262af1a4ade62bbcd591519e\", \"nacl_helper_nonsfi_unittests\": \"d484d23548233156a0a1de45deea1ab774b5081c\", \"nacl_loader_unittests\": \"5458bc66dc06ca1f629a8a0aece68b7db88edc92\", \"native_theme_unittests\": \"d40a23e1077e2b3654933fc7e396b3a6a58cb611\", \"net_unittests\": \"30617b82995a7c067d527f310d94e2d9fe81fde7\", \"ozone_gl_unittests\": \"448c7e37856ebafc8617f5c3282498262f105dbe\", \"ozone_unittests\": \"d6944e86ce49560950798dff9400aac84ae99931\", \"ozone_x11_unittests\": \"992df66371e1d37a4a4b7ac216887018508a5c40\", \"pdf_unittests\": \"1dc542cddbcfaf51ac4e12d8c2ecf29302bfa442\", \"perfetto_unittests\": \"e13fe4ff350e47099b58df43bc88d48aa32e469c\", \"ppapi_unittests\": \"7119e42af5872132743d2d1ecd4e941f1d66d238\", \"printing_unittests\": \"c6cc6e64a19df664e54e0a9018b98e2cc740b528\", \"remoting_unittests\": \"47bef9649952efbf2a2426bb5dec077c38e70914\", \"sandbox_linux_unittests\": \"34715b4b706dbbb7a94925dcfc6f4dedd3377fe0\", \"service_manager_unittests\": \"d41f64b791feb51df0384e591eb9333e2b452aa5\", \"services_unittests\": \"c9cd0e153ad8be0c59a2cbd906708d52e75c74cc\", \"shell_dialogs_unittests\": \"a4acb371c17670eaa21b754da82e257d257122dc\", \"shell_encryption_unittests\": \"10655ae90da209a384a925dc80d4e5b16b5dacd3\", \"skia_unittests\": \"f4a019774bd3f083f1d1ec3a67aba0c78fdc97aa\", \"snapshot_unittests\": \"7e56e9cdd02dbb9295787b4a97b9adc29947ac12\", \"sql_unittests\": \"efc79d136f769715e198a1b9788fddc3e6690d46\", \"storage_unittests\": \"b8fbe020ee7368d8f47c7507a22082351b8b5653\", \"sync_integration_tests\": \"430b1388da387ce9acbc8aa0edbb70d74733d7c6\", \"traffic_annotation_auditor_unittests\": \"14a51bae47319c72986453574f481179b149cd17\", \"ui_base_unittests\": \"b6503be6c770ec3111afff43dd7be0a7e887e559\", \"ui_chromeos_unittests\": \"f527805eaf9b476736020a32022c856743fbe087\", \"ui_touch_selection_unittests\": \"ded7208d592727a461c055954f6272ec3841d128\", \"unit_tests\": \"96fb90bb0d7202ba1985375c17092ca1a356b830\", \"url_unittests\": \"58e01ef3ba96b72651d95573da40476bc7bcf026\", \"usage_time_limit_unittests\": \"0f1a90db0a675d75403f09a9b580cce60ef2fc2d\", \"views_unittests\": \"6fb6909813f3dd0c75aae366a8ca0f11c46493fd\", \"viz_unittests\": \"5506d7f5951ce806a64c75209da8222b620f45f7\", \"wayland_client_tests\": \"54b5ecf9ee0a097203b611d4c8542285c79e4adf\", \"wm_unittests\": \"cf23d1049359b32d3be24819c52f466ea17692c1\", \"wtf_unittests\": \"053af5102e7ce77bb12cf28bf229d70209941008\", \"zlib_unittests\": \"fb6ab37933a33867b57dcf089a8cb7fb55266782\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_97036e5ee279fe6b8fb101acad8b19632bb6faa5e992f50a2e031a6b74482977_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_fe96da9c6a19fa2fc3ad0c2b7020b7cb68e4a92161f4cd6cb7dc1d1e2d5af5dc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-51-3r19\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614326230506836",
"status": "COMPLETED",
"status_changed_ts": "1614332791817437",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22789",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca967f170eca13c9b740202daf6b3b86e9c809b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019680347148256320",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854250285102448912/+/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:51f624731484c710",
"user_agent:luci-scheduler"
],
"updated_ts": "1614332791823936",
"url": "https://ci.chromium.org/b/8854250285102448912",
"utcnow_ts": "1614332792255012"
}
}
[09:46:32.265] Invocation finished in 1h54m19.326941953s with status SUCCEEDED