[17:48:24.473] New invocation is queued and will start shortly
[17:48:25.596] Starting the invocation (attempt 1)
[17:48:25.629] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:48:25.629] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:48:25.629] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018918062258784352",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"03d93768d7d3eb9bb106418e8d7274fb2431d795\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018918062258784352",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/03d93768d7d3eb9bb106418e8d7274fb2431d795",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03d93768d7d3eb9bb106418e8d7274fb2431d795",
"gitiles_ref:refs/heads/master"
]
}
[17:48:27.113] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615052905737666",
"id": "8853488000272635056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03d93768d7d3eb9bb106418e8d7274fb2431d795\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615052906847812",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45956",
"builder:linux-chromeos-rel",
"buildset:commit/git/03d93768d7d3eb9bb106418e8d7274fb2431d795",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03d93768d7d3eb9bb106418e8d7274fb2431d795",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018918062258784352",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853488000272635056/+/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": "1615052906847934",
"url": "https://ci.chromium.org/b/8853488000272635056",
"utcnow_ts": "1615052907100275"
}
}
[17:48:27.113] Task URL: https://ci.chromium.org/b/8853488000272635056
[17:48:27.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:2:0) after 1m0s
[17:49:27.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:2:0)
[17:49:27.182] Timer tick, asking Buildbucket for the build status
[17:49:27.348] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:27.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:3:0) after 1m0s
[17:50:27.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:3:0)
[17:50:27.391] Timer tick, asking Buildbucket for the build status
[17:50:27.539] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:27.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:4:0) after 1m0s
[17:51:27.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:4:0)
[17:51:27.521] Timer tick, asking Buildbucket for the build status
[17:51:27.753] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:27.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:5:0) after 1m0s
[17:52:27.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:5:0)
[17:52:27.782] Timer tick, asking Buildbucket for the build status
[17:52:28.127] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:28.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:6:0) after 1m0s
[17:53:28.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:6:0)
[17:53:28.136] Timer tick, asking Buildbucket for the build status
[17:53:28.207] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:28.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:7:0) after 1m0s
[17:54:28.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:7:0)
[17:54:28.254] Timer tick, asking Buildbucket for the build status
[17:54:28.315] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:28.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:8:0) after 1m0s
[17:55:28.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:8:0)
[17:55:28.341] Timer tick, asking Buildbucket for the build status
[17:55:28.402] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:28.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:9:0) after 1m0s
[17:56:28.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:9:0)
[17:56:28.455] Timer tick, asking Buildbucket for the build status
[17:56:28.511] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:56:28.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:10:0) after 1m0s
[17:57:28.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:10:0)
[17:57:28.548] Timer tick, asking Buildbucket for the build status
[17:57:28.611] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:57:28.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:11:0) after 1m0s
[17:58:28.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:11:0)
[17:58:28.613] Timer tick, asking Buildbucket for the build status
[17:58:28.688] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:58:28.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:12:0) after 1m0s
[17:59:28.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:12:0)
[17:59:28.705] Timer tick, asking Buildbucket for the build status
[17:59:28.940] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:59:28.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:13:0) after 1m0s
[18:00:28.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:13:0)
[18:00:28.955] Timer tick, asking Buildbucket for the build status
[18:00:29.016] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:00:29.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:14:0) after 1m0s
[18:01:29.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:14:0)
[18:01:29.030] Timer tick, asking Buildbucket for the build status
[18:01:29.133] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:01:29.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:15:0) after 1m0s
[18:02:29.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:15:0)
[18:02:29.190] Timer tick, asking Buildbucket for the build status
[18:02:29.326] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:29.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:16:0) after 1m0s
[18:03:29.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:16:0)
[18:03:29.340] Timer tick, asking Buildbucket for the build status
[18:03:29.428] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:29.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:17:0) after 1m0s
[18:04:29.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:17:0)
[18:04:29.443] Timer tick, asking Buildbucket for the build status
[18:04:29.509] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:29.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:18:0) after 1m0s
[18:05:29.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:18:0)
[18:05:29.524] Timer tick, asking Buildbucket for the build status
[18:05:29.581] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:29.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:19:0) after 1m0s
[18:06:29.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:19:0)
[18:06:29.596] Timer tick, asking Buildbucket for the build status
[18:06:29.919] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:06:29.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:20:0) after 1m0s
[18:07:29.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:20:0)
[18:07:29.940] Timer tick, asking Buildbucket for the build status
[18:07:30.112] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:07:30.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:21:0) after 1m0s
[18:08:30.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:21:0)
[18:08:30.127] Timer tick, asking Buildbucket for the build status
[18:08:30.306] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:30.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:22:0) after 1m0s
[18:09:30.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:22:0)
[18:09:30.333] Timer tick, asking Buildbucket for the build status
[18:09:30.404] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:30.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:23:0) after 1m0s
[18:10:30.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:23:0)
[18:10:30.422] Timer tick, asking Buildbucket for the build status
[18:10:30.532] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:30.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:24:0) after 1m0s
[18:11:30.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:24:0)
[18:11:30.566] Timer tick, asking Buildbucket for the build status
[18:11:30.635] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:30.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:25:0) after 1m0s
[18:12:30.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:25:0)
[18:12:30.650] Timer tick, asking Buildbucket for the build status
[18:12:30.705] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:30.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:26:0) after 1m0s
[18:13:30.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:26:0)
[18:13:30.720] Timer tick, asking Buildbucket for the build status
[18:13:30.950] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:13:30.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:27:0) after 1m0s
[18:14:30.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:27:0)
[18:14:30.968] Timer tick, asking Buildbucket for the build status
[18:14:31.208] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:14:31.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:28:0) after 1m0s
[18:15:31.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:28:0)
[18:15:31.321] Timer tick, asking Buildbucket for the build status
[18:15:31.436] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:15:31.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:29:0) after 1m0s
[18:16:31.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:29:0)
[18:16:31.450] Timer tick, asking Buildbucket for the build status
[18:16:31.507] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:16:31.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:30:0) after 1m0s
[18:17:34.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:30:0)
[18:17:34.251] Timer tick, asking Buildbucket for the build status
[18:17:34.312] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:17:34.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:31:0) after 1m0s
[18:18:34.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:31:0)
[18:18:34.342] Timer tick, asking Buildbucket for the build status
[18:18:34.413] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:34.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:32:0) after 1m0s
[18:19:34.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:32:0)
[18:19:34.460] Timer tick, asking Buildbucket for the build status
[18:19:34.515] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:34.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:33:0) after 1m0s
[18:20:34.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:33:0)
[18:20:34.546] Timer tick, asking Buildbucket for the build status
[18:20:34.603] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:34.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:34:0) after 1m0s
[18:21:34.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:34:0)
[18:21:34.626] Timer tick, asking Buildbucket for the build status
[18:21:34.752] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:34.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:35:0) after 1m0s
[18:22:34.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:35:0)
[18:22:34.747] Timer tick, asking Buildbucket for the build status
[18:22:34.906] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:34.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:36:0) after 1m0s
[18:23:34.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:36:0)
[18:23:34.955] Timer tick, asking Buildbucket for the build status
[18:23:35.035] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:35.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:37:0) after 1m0s
[18:24:35.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:37:0)
[18:24:35.050] Timer tick, asking Buildbucket for the build status
[18:24:35.113] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:24:35.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:38:0) after 1m0s
[18:25:35.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:38:0)
[18:25:35.130] Timer tick, asking Buildbucket for the build status
[18:25:35.210] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:35.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:39:0) after 1m0s
[18:26:35.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:39:0)
[18:26:35.265] Timer tick, asking Buildbucket for the build status
[18:26:35.327] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:26:35.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:40:0) after 1m0s
[18:27:35.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:40:0)
[18:27:35.391] Timer tick, asking Buildbucket for the build status
[18:27:35.448] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:35.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:41:0) after 1m0s
[18:28:35.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:41:0)
[18:28:35.463] Timer tick, asking Buildbucket for the build status
[18:28:35.550] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:35.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:42:0) after 1m0s
[18:29:35.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:42:0)
[18:29:35.619] Timer tick, asking Buildbucket for the build status
[18:29:35.687] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:35.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:43:0) after 1m0s
[18:30:35.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:43:0)
[18:30:35.703] Timer tick, asking Buildbucket for the build status
[18:30:35.861] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:35.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:44:0) after 1m0s
[18:31:35.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:44:0)
[18:31:35.899] Timer tick, asking Buildbucket for the build status
[18:31:35.995] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:35.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:45:0) after 1m0s
[18:32:36.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:45:0)
[18:32:36.084] Timer tick, asking Buildbucket for the build status
[18:32:36.167] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:36.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:46:0) after 1m0s
[18:33:36.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:46:0)
[18:33:36.228] Timer tick, asking Buildbucket for the build status
[18:33:36.293] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:36.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:47:0) after 1m0s
[18:34:36.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:47:0)
[18:34:36.315] Timer tick, asking Buildbucket for the build status
[18:34:36.369] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:36.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:48:0) after 1m0s
[18:35:36.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:48:0)
[18:35:36.387] Timer tick, asking Buildbucket for the build status
[18:35:36.444] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:36.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:49:0) after 1m0s
[18:36:36.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:49:0)
[18:36:36.435] Timer tick, asking Buildbucket for the build status
[18:36:36.548] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:36.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:50:0) after 1m0s
[18:37:36.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:50:0)
[18:37:36.590] Timer tick, asking Buildbucket for the build status
[18:37:36.641] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:36.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:51:0) after 1m0s
[18:38:36.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:51:0)
[18:38:36.618] Timer tick, asking Buildbucket for the build status
[18:38:36.777] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:36.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:52:0) after 1m0s
[18:39:36.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:52:0)
[18:39:36.823] Timer tick, asking Buildbucket for the build status
[18:39:36.877] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:36.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:53:0) after 1m0s
[18:40:36.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:53:0)
[18:40:36.912] Timer tick, asking Buildbucket for the build status
[18:40:36.968] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:36.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:54:0) after 1m0s
[18:41:36.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:54:0)
[18:41:36.985] Timer tick, asking Buildbucket for the build status
[18:41:37.118] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:37.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:55:0) after 1m0s
[18:42:37.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:55:0)
[18:42:37.133] Timer tick, asking Buildbucket for the build status
[18:42:37.232] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:37.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:56:0) after 1m0s
[18:43:37.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:56:0)
[18:43:37.268] Timer tick, asking Buildbucket for the build status
[18:43:37.421] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:37.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:57:0) after 1m0s
[18:44:37.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:57:0)
[18:44:37.437] Timer tick, asking Buildbucket for the build status
[18:44:37.534] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:37.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:58:0) after 1m0s
[18:45:37.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:58:0)
[18:45:37.590] Timer tick, asking Buildbucket for the build status
[18:45:37.672] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:37.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:59:0) after 1m0s
[18:46:37.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:59:0)
[18:46:37.720] Timer tick, asking Buildbucket for the build status
[18:46:37.873] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:37.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:60:0) after 1m0s
[18:47:37.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:60:0)
[18:47:37.890] Timer tick, asking Buildbucket for the build status
[18:47:37.942] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:37.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:61:0) after 1m0s
[18:48:38.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:61:0)
[18:48:38.003] Timer tick, asking Buildbucket for the build status
[18:48:38.073] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:38.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:62:0) after 1m0s
[18:49:38.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:62:0)
[18:49:38.125] Timer tick, asking Buildbucket for the build status
[18:49:38.335] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:38.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:63:0) after 1m0s
[18:50:38.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:63:0)
[18:50:38.353] Timer tick, asking Buildbucket for the build status
[18:50:38.522] Build 8853488000272635056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:38.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:64:0) after 1m0s
[18:51:18.277] Received PubSub notification, asking Buildbucket for the build status
[18:51:18.346] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:38.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:64:0)
[18:51:38.608] Timer tick, asking Buildbucket for the build status
[18:51:38.733] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:38.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:66:0) after 1m0s
[18:52:38.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:66:0)
[18:52:38.834] Timer tick, asking Buildbucket for the build status
[18:52:38.926] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:38.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:67:0) after 1m0s
[18:53:38.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:67:0)
[18:53:38.995] Timer tick, asking Buildbucket for the build status
[18:53:39.082] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:39.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:68:0) after 1m0s
[18:54:39.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:68:0)
[18:54:39.117] Timer tick, asking Buildbucket for the build status
[18:54:39.178] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:39.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:69:0) after 1m0s
[18:55:39.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:69:0)
[18:55:39.222] Timer tick, asking Buildbucket for the build status
[18:55:39.371] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:39.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:70:0) after 1m0s
[18:56:39.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:70:0)
[18:56:39.450] Timer tick, asking Buildbucket for the build status
[18:56:39.546] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:39.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:71:0) after 1m0s
[18:57:39.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:71:0)
[18:57:39.593] Timer tick, asking Buildbucket for the build status
[18:57:39.789] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:39.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:72:0) after 1m0s
[18:58:39.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:72:0)
[18:58:39.852] Timer tick, asking Buildbucket for the build status
[18:58:39.950] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:39.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:73:0) after 1m0s
[18:59:40.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:73:0)
[18:59:40.049] Timer tick, asking Buildbucket for the build status
[18:59:40.111] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:40.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:74:0) after 1m0s
[19:00:40.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:74:0)
[19:00:40.130] Timer tick, asking Buildbucket for the build status
[19:00:40.209] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:40.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:75:0) after 1m0s
[19:01:40.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:75:0)
[19:01:40.283] Timer tick, asking Buildbucket for the build status
[19:01:40.350] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:40.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:76:0) after 1m0s
[19:02:40.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:76:0)
[19:02:40.406] Timer tick, asking Buildbucket for the build status
[19:02:40.462] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:40.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:77:0) after 1m0s
[19:03:40.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:77:0)
[19:03:40.496] Timer tick, asking Buildbucket for the build status
[19:03:40.568] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:40.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:78:0) after 1m0s
[19:04:40.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:78:0)
[19:04:40.587] Timer tick, asking Buildbucket for the build status
[19:04:40.678] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:40.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:79:0) after 1m0s
[19:05:40.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:79:0)
[19:05:40.706] Timer tick, asking Buildbucket for the build status
[19:05:40.919] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:40.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:80:0) after 1m0s
[19:06:40.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:80:0)
[19:06:40.938] Timer tick, asking Buildbucket for the build status
[19:06:41.140] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:41.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:81:0) after 1m0s
[19:07:41.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:81:0)
[19:07:41.224] Timer tick, asking Buildbucket for the build status
[19:07:41.290] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:41.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:82:0) after 1m0s
[19:08:41.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:82:0)
[19:08:41.385] Timer tick, asking Buildbucket for the build status
[19:08:41.459] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:41.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:83:0) after 1m0s
[19:09:41.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:83:0)
[19:09:41.463] Timer tick, asking Buildbucket for the build status
[19:09:41.551] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:41.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:84:0) after 1m0s
[19:10:41.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:84:0)
[19:10:41.569] Timer tick, asking Buildbucket for the build status
[19:10:41.695] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:41.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:85:0) after 1m0s
[19:11:41.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:85:0)
[19:11:41.750] Timer tick, asking Buildbucket for the build status
[19:11:41.824] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:41.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:86:0) after 1m0s
[19:12:41.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:86:0)
[19:12:41.917] Timer tick, asking Buildbucket for the build status
[19:12:41.983] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:41.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:87:0) after 1m0s
[19:13:41.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:87:0)
[19:13:41.982] Timer tick, asking Buildbucket for the build status
[19:13:42.061] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:42.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:88:0) after 1m0s
[19:14:42.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:88:0)
[19:14:42.042] Timer tick, asking Buildbucket for the build status
[19:14:42.234] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:42.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:89:0) after 1m0s
[19:15:42.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:89:0)
[19:15:42.821] Timer tick, asking Buildbucket for the build status
[19:15:43.120] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:43.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:90:0) after 1m0s
[19:16:43.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:90:0)
[19:16:43.099] Timer tick, asking Buildbucket for the build status
[19:16:43.166] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:43.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:91:0) after 1m0s
[19:17:43.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:91:0)
[19:17:43.276] Timer tick, asking Buildbucket for the build status
[19:17:43.345] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:43.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:92:0) after 1m0s
[19:18:43.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:92:0)
[19:18:43.362] Timer tick, asking Buildbucket for the build status
[19:18:43.719] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:43.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:93:0) after 1m0s
[19:19:43.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:93:0)
[19:19:43.772] Timer tick, asking Buildbucket for the build status
[19:19:43.839] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:43.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:94:0) after 1m0s
[19:20:43.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:94:0)
[19:20:43.820] Timer tick, asking Buildbucket for the build status
[19:20:43.900] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:43.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:95:0) after 1m0s
[19:21:43.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:95:0)
[19:21:43.966] Timer tick, asking Buildbucket for the build status
[19:21:44.032] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:44.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:96:0) after 1m0s
[19:22:44.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:96:0)
[19:22:44.052] Timer tick, asking Buildbucket for the build status
[19:22:44.109] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:44.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:97:0) after 1m0s
[19:23:44.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:97:0)
[19:23:44.204] Timer tick, asking Buildbucket for the build status
[19:23:44.310] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:44.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:98:0) after 1m0s
[19:24:44.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:98:0)
[19:24:44.330] Timer tick, asking Buildbucket for the build status
[19:24:44.424] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:44.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:99:0) after 1m0s
[19:25:44.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:99:0)
[19:25:44.479] Timer tick, asking Buildbucket for the build status
[19:25:44.555] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:44.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:100:0) after 1m0s
[19:26:44.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:100:0)
[19:26:44.535] Timer tick, asking Buildbucket for the build status
[19:26:44.627] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:44.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:101:0) after 1m0s
[19:27:44.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:101:0)
[19:27:44.646] Timer tick, asking Buildbucket for the build status
[19:27:44.746] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:44.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:102:0) after 1m0s
[19:28:44.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:102:0)
[19:28:44.781] Timer tick, asking Buildbucket for the build status
[19:28:44.870] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:44.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:103:0) after 1m0s
[19:29:44.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:103:0)
[19:29:44.901] Timer tick, asking Buildbucket for the build status
[19:29:44.960] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:44.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:104:0) after 1m0s
[19:30:44.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:104:0)
[19:30:44.945] Timer tick, asking Buildbucket for the build status
[19:30:45.032] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:45.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:105:0) after 1m0s
[19:31:45.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:105:0)
[19:31:45.169] Timer tick, asking Buildbucket for the build status
[19:31:45.292] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:45.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:106:0) after 1m0s
[19:32:45.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:106:0)
[19:32:45.276] Timer tick, asking Buildbucket for the build status
[19:32:45.460] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:45.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:107:0) after 1m0s
[19:33:45.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:107:0)
[19:33:45.546] Timer tick, asking Buildbucket for the build status
[19:33:45.625] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:45.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:108:0) after 1m0s
[19:34:45.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:108:0)
[19:34:45.642] Timer tick, asking Buildbucket for the build status
[19:34:45.715] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:45.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:109:0) after 1m0s
[19:35:45.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:109:0)
[19:35:45.690] Timer tick, asking Buildbucket for the build status
[19:35:45.758] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:45.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:110:0) after 1m0s
[19:36:45.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:110:0)
[19:36:45.789] Timer tick, asking Buildbucket for the build status
[19:36:45.860] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:45.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:111:0) after 1m0s
[19:37:45.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:111:0)
[19:37:45.889] Timer tick, asking Buildbucket for the build status
[19:37:45.952] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:45.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:112:0) after 1m0s
[19:38:46.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:112:0)
[19:38:46.507] Timer tick, asking Buildbucket for the build status
[19:38:46.612] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:46.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:113:0) after 1m0s
[19:39:46.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:113:0)
[19:39:46.897] Timer tick, asking Buildbucket for the build status
[19:39:46.961] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:46.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:114:0) after 1m0s
[19:40:47.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:114:0)
[19:40:47.166] Timer tick, asking Buildbucket for the build status
[19:40:47.234] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:47.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:115:0) after 1m0s
[19:41:47.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:115:0)
[19:41:47.419] Timer tick, asking Buildbucket for the build status
[19:41:47.534] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:47.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:116:0) after 1m0s
[19:42:47.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:116:0)
[19:42:47.751] Timer tick, asking Buildbucket for the build status
[19:42:47.816] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:47.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:117:0) after 1m0s
[19:43:48.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:117:0)
[19:43:48.037] Timer tick, asking Buildbucket for the build status
[19:43:48.114] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:48.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:118:0) after 1m0s
[19:44:48.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:118:0)
[19:44:48.134] Timer tick, asking Buildbucket for the build status
[19:44:48.270] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:48.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:119:0) after 1m0s
[19:45:48.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:119:0)
[19:45:48.386] Timer tick, asking Buildbucket for the build status
[19:45:48.447] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:48.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:120:0) after 1m0s
[19:46:48.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:120:0)
[19:46:48.706] Timer tick, asking Buildbucket for the build status
[19:46:48.766] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:48.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:121:0) after 1m0s
[19:47:48.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:121:0)
[19:47:48.882] Timer tick, asking Buildbucket for the build status
[19:47:48.961] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:48.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:122:0) after 1m0s
[19:48:50.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:122:0)
[19:48:50.788] Timer tick, asking Buildbucket for the build status
[19:48:50.868] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:50.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:123:0) after 1m0s
[19:49:50.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:123:0)
[19:49:50.922] Timer tick, asking Buildbucket for the build status
[19:49:51.302] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:51.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:124:0) after 1m0s
[19:50:51.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:124:0)
[19:50:51.364] Timer tick, asking Buildbucket for the build status
[19:50:51.421] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:51.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:125:0) after 1m0s
[19:51:51.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:125:0)
[19:51:51.492] Timer tick, asking Buildbucket for the build status
[19:51:51.556] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:51.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:126:0) after 1m0s
[19:52:51.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:126:0)
[19:52:51.612] Timer tick, asking Buildbucket for the build status
[19:52:51.676] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:51.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:127:0) after 1m0s
[19:53:51.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:127:0)
[19:53:51.767] Timer tick, asking Buildbucket for the build status
[19:53:51.853] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:51.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:128:0) after 1m0s
[19:54:51.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:128:0)
[19:54:51.894] Timer tick, asking Buildbucket for the build status
[19:54:51.956] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:51.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:129:0) after 1m0s
[19:55:52.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:129:0)
[19:55:52.207] Timer tick, asking Buildbucket for the build status
[19:55:52.312] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:52.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:130:0) after 1m0s
[19:56:52.388] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:130:0)
[19:56:52.388] Timer tick, asking Buildbucket for the build status
[19:56:52.456] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:52.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:131:0) after 1m0s
[19:57:52.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:131:0)
[19:57:52.521] Timer tick, asking Buildbucket for the build status
[19:57:52.701] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:52.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:132:0) after 1m0s
[19:58:52.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:132:0)
[19:58:52.810] Timer tick, asking Buildbucket for the build status
[19:58:53.230] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:53.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:133:0) after 1m0s
[19:59:53.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:133:0)
[19:59:53.265] Timer tick, asking Buildbucket for the build status
[19:59:53.406] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:53.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:134:0) after 1m0s
[20:00:53.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:134:0)
[20:00:53.434] Timer tick, asking Buildbucket for the build status
[20:00:53.522] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:53.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:135:0) after 1m0s
[20:01:53.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:135:0)
[20:01:53.539] Timer tick, asking Buildbucket for the build status
[20:01:53.728] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:53.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:136:0) after 1m0s
[20:02:53.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:136:0)
[20:02:53.835] Timer tick, asking Buildbucket for the build status
[20:02:54.055] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:54.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:137:0) after 1m0s
[20:03:54.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:137:0)
[20:03:54.141] Timer tick, asking Buildbucket for the build status
[20:03:54.247] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:54.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:138:0) after 1m0s
[20:04:54.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:138:0)
[20:04:54.287] Timer tick, asking Buildbucket for the build status
[20:04:54.402] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:54.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:139:0) after 1m0s
[20:05:54.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:139:0)
[20:05:54.467] Timer tick, asking Buildbucket for the build status
[20:05:54.627] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:54.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:140:0) after 1m0s
[20:06:54.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:140:0)
[20:06:54.695] Timer tick, asking Buildbucket for the build status
[20:06:54.754] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:54.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:141:0) after 1m0s
[20:07:54.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:141:0)
[20:07:54.751] Timer tick, asking Buildbucket for the build status
[20:07:54.831] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:54.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:142:0) after 1m0s
[20:08:54.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:142:0)
[20:08:54.982] Timer tick, asking Buildbucket for the build status
[20:08:55.061] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:55.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:143:0) after 1m0s
[20:09:55.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:143:0)
[20:09:55.316] Timer tick, asking Buildbucket for the build status
[20:09:55.496] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:55.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:144:0) after 1m0s
[20:10:55.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:144:0)
[20:10:55.771] Timer tick, asking Buildbucket for the build status
[20:10:55.847] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:55.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:145:0) after 1m0s
[20:11:55.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:145:0)
[20:11:55.916] Timer tick, asking Buildbucket for the build status
[20:11:55.993] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:55.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:146:0) after 1m0s
[20:12:56.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:146:0)
[20:12:56.041] Timer tick, asking Buildbucket for the build status
[20:12:56.144] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:56.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:147:0) after 1m0s
[20:13:56.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:147:0)
[20:13:56.191] Timer tick, asking Buildbucket for the build status
[20:13:56.309] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:56.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:148:0) after 1m0s
[20:14:56.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:148:0)
[20:14:56.336] Timer tick, asking Buildbucket for the build status
[20:14:56.606] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:56.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:149:0) after 1m0s
[20:15:56.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:149:0)
[20:15:56.660] Timer tick, asking Buildbucket for the build status
[20:15:56.833] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:56.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:150:0) after 1m0s
[20:16:56.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:150:0)
[20:16:56.819] Timer tick, asking Buildbucket for the build status
[20:16:56.962] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:151:0) after 1m0s
[20:17:56.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:151:0)
[20:17:56.971] Timer tick, asking Buildbucket for the build status
[20:17:57.062] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:57.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:152:0) after 1m0s
[20:18:57.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:152:0)
[20:18:57.091] Timer tick, asking Buildbucket for the build status
[20:18:57.188] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:57.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:153:0) after 1m0s
[20:19:57.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:153:0)
[20:19:57.265] Timer tick, asking Buildbucket for the build status
[20:19:57.362] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:57.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:154:0) after 1m0s
[20:20:57.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:154:0)
[20:20:57.426] Timer tick, asking Buildbucket for the build status
[20:20:57.914] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:57.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:155:0) after 1m0s
[20:21:58.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:155:0)
[20:21:58.030] Timer tick, asking Buildbucket for the build status
[20:21:58.246] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:58.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:156:0) after 1m0s
[20:22:58.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:156:0)
[20:22:58.271] Timer tick, asking Buildbucket for the build status
[20:22:58.332] Build 8853488000272635056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:58.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018918062258784352:157:0) after 1m0s
[20:23:32.108] Received PubSub notification, asking Buildbucket for the build status
[20:23:32.177] Build 8853488000272635056: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:23:32.177] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615062211800780",
"created_by": "project:chromium",
"created_ts": "1615052905737666",
"failure_reason": "BUILD_FAILURE",
"id": "8853488000272635056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03d93768d7d3eb9bb106418e8d7274fb2431d795\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ServiceWorkerMessagingTest.WorkerShutsDownWhileNativeMessagePortIsOpen\"}, \"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\": \"03d93768d7d3eb9bb106418e8d7274fb2431d795\", \"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-96-5jie\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45956, \"got_angle_revision\": \"a0bc2589a9d0def06ad2e0a9b53ac39805055b3b\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"03d93768d7d3eb9bb106418e8d7274fb2431d795\", \"got_revision_cp\": \"refs/heads/master@{#860548}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"32802403fa8acde342f007b3c531ac12e87b1d2c\", \"got_v8_revision_cp\": \"refs/heads/9.1.59@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": false, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03d93768d7d3eb9bb106418e8d7274fb2431d795\", \"swarm_hashes_refs/heads/master(at){#860548}_without_patch\": {\"absl_hardening_tests\": \"42033aee87f14f7caae70e62ce07b154032900b0\", \"accessibility_unittests\": \"4335da041847ecfdf793295046186255eb1546e1\", \"angle_unittests\": \"a43a109e961af553bda755b1b28dcb799cefc619\", \"app_list_unittests\": \"819605b171a7afe4172a8e375816d444bc0b0322\", \"app_shell_unittests\": \"a5f46333114af86b45fb8f1234ce4a7f98822d2c\", \"ash_unittests\": \"e44a030d680bd33ff28aae7af0a32faa9b17a34d\", \"aura_unittests\": \"b48c40aa4a63e1ac38928ae1b2c9d4f011e595e4\", \"base_unittests\": \"dba58769585832f204d43d906479cd8cd10a1f5a\", \"base_util_unittests\": \"f038265b759aa2a44fb55f4b054878943e935c27\", \"blink_common_unittests\": \"cdc09468a46c64e87618a990180fa44221215321\", \"blink_fuzzer_unittests\": \"cd9121a8302082d87e0f45da791f1bcf4b33aefd\", \"blink_heap_unittests\": \"9665e9f538b03cc1a4a13c967b82b44a3c9d63b0\", \"blink_platform_unittests\": \"09dd656bb415f07f3588bc35cc0bad0dd517867d\", \"blink_unittests\": \"935428d69ee95160a70e7a2638b02fe4a341939b\", \"boringssl_crypto_tests\": \"04d26bf044b9c9cba6645718c183748dc8917c6a\", \"boringssl_ssl_tests\": \"883a3697a0e11e7f91411a460bed70f7730065e2\", \"browser_tests\": \"ee4f333def015e73dcef5857ef2175e03989d36a\", \"capture_unittests\": \"80e9341c90516a997dc0628799f51aa760c14915\", \"cast_unittests\": \"adaf3d70183cecf23e7daef940a96ef1b13efd73\", \"cc_unittests\": \"0309f81cac0183cbc31856227a08c22489be2daf\", \"chrome_app_unittests\": \"5f1524343a70f376f613f10111e50f5c23334324\", \"chromedriver_unittests\": \"c9a7e0e28b1b4d776c7e82b0d867128ac6f472f2\", \"chromeos_components_unittests\": \"d1055e8bc450bcaa4b09e59024d32480b9acbd49\", \"chromeos_unittests\": \"3be55fd59b75466ad1719f1131971097eb0dcb89\", \"color_unittests\": \"ac3824aa95cc57ae914501408bc71e3b67398f2c\", \"components_browsertests\": \"a8b86426ecd468156d82c2b6a3cee8dd73f60cb7\", \"components_unittests\": \"cb89af943ae69475b14f57cdb1354b04c40f7995\", \"compositor_unittests\": \"1206ddaa5d8451cb37512f9c0c3d657ba96c8934\", \"content_browsertests\": \"52cc05847e7d90ed68b04abd049f9b585c91c7cc\", \"content_unittests\": \"12e57cd5dd9148261c31387c17e4860a1e583e49\", \"crashpad_tests\": \"af3095318e2ac3116ec37db1fc5210b253cbffa0\", \"crypto_unittests\": \"39f801dfad3f82028b384212eed182d094b979bb\", \"dbus_unittests\": \"557c61afa249290d1caa8d183c2190badb06714f\", \"device_unittests\": \"9c64f343ad469b4fca0d0c630e71f714d4bf37ba\", \"display_unittests\": \"ae1576fcc443cd126201284ade0e4a6ceb937e2f\", \"events_unittests\": \"11743dd882a55dccf4e01a59055c76a8c8402a4f\", \"exo_unittests\": \"5d3e555210784fbc7b082c97c8c369772ed1afcb\", \"extensions_browsertests\": \"af71cbd3b3d302594755e60c1f4ade5c0d1924dd\", \"extensions_unittests\": \"ff79723065f8c4dabf3950623f2015490a8a650a\", \"filesystem_service_unittests\": \"04aa712b4f93a427b7f3187aed405690545ca3d2\", \"gcm_unit_tests\": \"88cc6968b9e4fdbe888557d025fad22253727625\", \"gfx_unittests\": \"6391b340b30b1b49799fb271463448bcd3a57ea2\", \"gin_unittests\": \"cdaaa628e11cf6b486ae4f6802bea8a0f13ebd16\", \"gl_unittests_ozone\": \"ccb40a339cfa0a441ac9a307eeaaa246f24df86d\", \"google_apis_unittests\": \"ab33f618cca12c8dec051c77cf930b794947b9f4\", \"gpu_unittests\": \"805798b74156482718ebbdb5d2380740283c5be0\", \"gwp_asan_unittests\": \"dc06aa12b2d664cccf90513165fa640d4b5c18f9\", \"interactive_ui_tests\": \"ecd3ef098cb91dbbe51730893389789f52f7c845\", \"ipc_tests\": \"526671e855b620836875a6d9fe77f6231ff77563\", \"jingle_unittests\": \"9e8f8fcbc2d14870c4f9b27fe816fba1883863d9\", \"keyboard_unittests\": \"776be430887ac6d126992175b8cd62d8ad70de63\", \"latency_unittests\": \"6b873ed11ccc03b9be66ea57e1a37c58f1884309\", \"libjingle_xmpp_unittests\": \"058025b421a779e83a418359c5e4222ed321e233\", \"liburlpattern_unittests\": \"feb9f41ec9af2f92127c0d8cb7dea692021e1e48\", \"media_blink_unittests\": \"0d2e4032c256b559d5cb84fd8f1cd6d4e20e5a7d\", \"media_unittests\": \"29d6e2e7ea164d559cbfaa7484fb9a55537c8252\", \"message_center_unittests\": \"1df787dc20ae0bd390c56f0c0e4f025301adc0ee\", \"midi_unittests\": \"63d809856d9f4f0c9914050daa2cc001f6293a9f\", \"mojo_core_unittests\": \"61182564c90cb752840c991d0e53238224a1c3e8\", \"mojo_unittests\": \"9be31639e4466d338f61446622abc9e02d97c9c4\", \"nacl_helper_nonsfi_unittests\": \"be286d5c9bf95fd06396cd13dfb57a993fbacb37\", \"nacl_loader_unittests\": \"ef1c5c83d6de513b3216e84bdc5577133667da7f\", \"native_theme_unittests\": \"98261fbec4d63f90a7e68e836756d33f59819303\", \"net_unittests\": \"a570fb975193800d1b24789da90df138af863e0f\", \"ozone_gl_unittests\": \"8b542251317a3ec940f2ff0a4b6c0f222e9160db\", \"ozone_unittests\": \"81a66b4cb5f537d68bde46f5626b02cb183fbe37\", \"ozone_x11_unittests\": \"6a17f599dcaafe8ebebb887d90841590c0121597\", \"pdf_unittests\": \"1678f9b4d9d5512befc9065e7080f2003a4e0cc9\", \"perfetto_unittests\": \"c5edde32669d488680cf9e7d8950781def80283c\", \"ppapi_unittests\": \"a75aaa0e3ff708d80246daf2594fc81ab217c73a\", \"printing_unittests\": \"c66144dde9b8303243baff9f3ca2a16a5fa32253\", \"remoting_unittests\": \"88f407df561954eaa05abadddae6d8a2dc8ad61a\", \"sandbox_linux_unittests\": \"023c06d1e658192614e99797d9d20a0a9aeeeeff\", \"service_manager_unittests\": \"d35b3e0ef7f74b9eed5ba9fcecf5fd64f23f6248\", \"services_unittests\": \"a2a9f85b85a5f05674e4c467dbb420758556787c\", \"shell_dialogs_unittests\": \"77fac3f18dd9bb999bab8af53c5fa5e15107c117\", \"shell_encryption_unittests\": \"8a970c6110ce7d4908b468486e311d726372cd66\", \"skia_unittests\": \"4fa1bfd4da972a82b194548471dadfd07f471227\", \"snapshot_unittests\": \"0dd6b404eb5444ff02347503b0c84c31bcc80a1a\", \"sql_unittests\": \"147f27658d54072471e57c99ccb2163e5cda7cfd\", \"storage_unittests\": \"f70e2df44fef315175bc4073c1b661252e5bf525\", \"sync_integration_tests\": \"5dcbed0309902b3e5ebc5fa1c7ff0e8c72040703\", \"traffic_annotation_auditor_unittests\": \"2b69d9b416b7dfaa7ac9d97e224ecb8d2dbb7d16\", \"ui_base_unittests\": \"7903a312a315298bb087154e67c1f62409b206e8\", \"ui_chromeos_unittests\": \"59206499005ba478bd4130e119506aced1c85e90\", \"ui_touch_selection_unittests\": \"2c7e20822035c74787403cfa1fb9e5ce964428d1\", \"unit_tests\": \"d6529de8945633d3b0fa23ca48a0fece343a54ef\", \"url_unittests\": \"d40284dcc4f48ffc011e2c73a1048075c611c1b3\", \"usage_time_limit_unittests\": \"bbd91edb9627fdab16fed3397fb62d64ee0baa63\", \"views_unittests\": \"7652ef8047696e7db0e51b55d07bc6c2afba7982\", \"viz_unittests\": \"2327e1538fb1d0c2a5712b7b8d87a12507fdb405\", \"wayland_client_perftests\": \"b45bbfe82ce216d214075f7b93d9249f960f177d\", \"wayland_client_tests\": \"736ac9c9a1e0aa8d0294bbf1ab20633ba530cc07\", \"wm_unittests\": \"8a2359915f8ba65dabdea003980f422c94a910a9\", \"wtf_unittests\": \"23753d9b144baf91551a2f32431ceed1886cfe19\", \"zlib_unittests\": \"41f1d8fdbf0390c74e6d2133d19a39292f2a1c8f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_1baf36be136c6e37e5283db20727ce1fca753922b4729c01ac3834cd33897d7d_v2\", \"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_439308a62373488b965450387292170d4ea9c14a8841f8eafa3bc91f493efcbf_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_d1c901bf0b32c3b29d30f4610b30edc216778df78ff255269593a0f907c3cefa_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-96-5jie\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ServiceWorkerMessagingTest.WorkerShutsDownWhileNativeMessagePortIsOpen\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615056674619886",
"status": "COMPLETED",
"status_changed_ts": "1615056675024444",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45956",
"builder:linux-chromeos-rel",
"buildset:commit/git/03d93768d7d3eb9bb106418e8d7274fb2431d795",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03d93768d7d3eb9bb106418e8d7274fb2431d795",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018918062258784352",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8853488000272635056/+/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:5221792b73f2d110",
"user_agent:luci-scheduler"
],
"updated_ts": "1615062211801124",
"url": "https://ci.chromium.org/b/8853488000272635056",
"utcnow_ts": "1615062212170083"
}
}
[20:23:32.177] Invocation finished in 2h35m7.718325286s with status FAILED