[23:20:02.765] New invocation is queued and will start shortly
[23:20:05.036] Starting the invocation (attempt 1)
[23:20:05.092] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:20:05.092] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:20:05.092] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029315848527566176",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4f79df41f8ba69adaf5404870c5540a3e0fc55de\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029315848527566176",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/4f79df41f8ba69adaf5404870c5540a3e0fc55de",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f79df41f8ba69adaf5404870c5540a3e0fc55de",
"gitiles_ref:refs/heads/master"
]
}
[23:20:06.114] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605136805238181",
"id": "8863885785269056272",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4f79df41f8ba69adaf5404870c5540a3e0fc55de\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605136805839911",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21259",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4f79df41f8ba69adaf5404870c5540a3e0fc55de",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f79df41f8ba69adaf5404870c5540a3e0fc55de",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029315848527566176",
"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/8863885785269056272/+/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": "1605136805840098",
"url": "https://ci.chromium.org/b/8863885785269056272",
"utcnow_ts": "1605136806102111"
}
}
[23:20:06.114] Task URL: https://ci.chromium.org/b/8863885785269056272
[23:20:06.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:2:0) after 1m0s
[23:21:06.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:2:0)
[23:21:06.169] Timer tick, asking Buildbucket for the build status
[23:21:06.331] Build 8863885785269056272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:06.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:3:0) after 1m0s
[23:22:06.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:3:0)
[23:22:06.338] Timer tick, asking Buildbucket for the build status
[23:22:06.646] Build 8863885785269056272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:06.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:4:0) after 1m0s
[23:23:06.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:4:0)
[23:23:06.672] Timer tick, asking Buildbucket for the build status
[23:23:06.764] Build 8863885785269056272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:06.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:5:0) after 1m0s
[23:24:02.727] Received PubSub notification, asking Buildbucket for the build status
[23:24:02.819] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:06.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:5:0)
[23:24:06.802] Timer tick, asking Buildbucket for the build status
[23:24:06.878] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:06.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:7:0) after 1m0s
[23:25:06.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:7:0)
[23:25:06.954] Timer tick, asking Buildbucket for the build status
[23:25:07.062] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:07.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:8:0) after 1m0s
[23:26:07.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:8:0)
[23:26:07.160] Timer tick, asking Buildbucket for the build status
[23:26:07.305] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:07.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:9:0) after 1m0s
[23:27:07.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:9:0)
[23:27:07.379] Timer tick, asking Buildbucket for the build status
[23:27:07.443] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:07.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:10:0) after 1m0s
[23:28:07.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:10:0)
[23:28:07.533] Timer tick, asking Buildbucket for the build status
[23:28:07.941] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:07.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:11:0) after 1m0s
[23:29:08.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:11:0)
[23:29:08.048] Timer tick, asking Buildbucket for the build status
[23:29:08.182] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:08.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:12:0) after 1m0s
[23:30:08.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:12:0)
[23:30:08.266] Timer tick, asking Buildbucket for the build status
[23:30:08.556] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:08.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:13:0) after 1m0s
[23:31:08.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:13:0)
[23:31:08.596] Timer tick, asking Buildbucket for the build status
[23:31:08.914] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:08.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:14:0) after 1m0s
[23:32:09.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:14:0)
[23:32:09.152] Timer tick, asking Buildbucket for the build status
[23:32:09.217] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:09.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:15:0) after 1m0s
[23:33:09.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:15:0)
[23:33:09.336] Timer tick, asking Buildbucket for the build status
[23:33:09.414] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:09.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:16:0) after 1m0s
[23:34:09.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:16:0)
[23:34:09.536] Timer tick, asking Buildbucket for the build status
[23:34:09.680] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:09.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:17:0) after 1m0s
[23:35:09.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:17:0)
[23:35:09.793] Timer tick, asking Buildbucket for the build status
[23:35:09.904] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:09.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:18:0) after 1m0s
[23:36:10.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:18:0)
[23:36:10.044] Timer tick, asking Buildbucket for the build status
[23:36:10.126] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:10.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:19:0) after 1m0s
[23:37:10.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:19:0)
[23:37:10.191] Timer tick, asking Buildbucket for the build status
[23:37:10.650] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:10.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:20:0) after 1m0s
[23:38:10.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:20:0)
[23:38:10.668] Timer tick, asking Buildbucket for the build status
[23:38:10.736] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:10.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:21:0) after 1m0s
[23:39:10.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:21:0)
[23:39:10.775] Timer tick, asking Buildbucket for the build status
[23:39:11.132] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:11.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:22:0) after 1m0s
[23:40:11.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:22:0)
[23:40:11.180] Timer tick, asking Buildbucket for the build status
[23:40:11.732] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:11.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:23:0) after 1m0s
[23:41:11.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:23:0)
[23:41:11.768] Timer tick, asking Buildbucket for the build status
[23:41:12.175] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:12.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:24:0) after 1m0s
[23:42:12.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:24:0)
[23:42:12.208] Timer tick, asking Buildbucket for the build status
[23:42:12.312] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:12.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:25:0) after 1m0s
[23:43:12.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:25:0)
[23:43:12.389] Timer tick, asking Buildbucket for the build status
[23:43:12.449] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:12.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:26:0) after 1m0s
[23:44:12.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:26:0)
[23:44:12.484] Timer tick, asking Buildbucket for the build status
[23:44:12.550] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:12.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:27:0) after 1m0s
[23:45:12.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:27:0)
[23:45:12.561] Timer tick, asking Buildbucket for the build status
[23:45:12.681] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:12.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:28:0) after 1m0s
[23:46:12.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:28:0)
[23:46:12.712] Timer tick, asking Buildbucket for the build status
[23:46:13.102] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:13.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:29:0) after 1m0s
[23:47:13.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:29:0)
[23:47:13.119] Timer tick, asking Buildbucket for the build status
[23:47:13.207] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:13.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:30:0) after 1m0s
[23:48:13.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:30:0)
[23:48:13.221] Timer tick, asking Buildbucket for the build status
[23:48:13.307] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:13.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:31:0) after 1m0s
[23:49:13.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:31:0)
[23:49:13.397] Timer tick, asking Buildbucket for the build status
[23:49:13.486] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:13.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:32:0) after 1m0s
[23:50:13.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:32:0)
[23:50:13.590] Timer tick, asking Buildbucket for the build status
[23:50:13.733] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:13.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:33:0) after 1m0s
[23:51:13.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:33:0)
[23:51:13.818] Timer tick, asking Buildbucket for the build status
[23:51:13.990] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:13.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:34:0) after 1m0s
[23:52:14.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:34:0)
[23:52:14.031] Timer tick, asking Buildbucket for the build status
[23:52:14.112] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:14.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:35:0) after 1m0s
[23:53:14.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:35:0)
[23:53:14.181] Timer tick, asking Buildbucket for the build status
[23:53:14.247] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:14.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:36:0) after 1m0s
[23:54:14.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:36:0)
[23:54:14.325] Timer tick, asking Buildbucket for the build status
[23:54:14.692] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:14.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:37:0) after 1m0s
[23:55:14.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:37:0)
[23:55:14.734] Timer tick, asking Buildbucket for the build status
[23:55:15.569] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:15.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:38:0) after 1m0s
[23:56:15.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:38:0)
[23:56:15.639] Timer tick, asking Buildbucket for the build status
[23:56:16.211] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:16.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:39:0) after 1m0s
[23:57:16.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:39:0)
[23:57:16.345] Timer tick, asking Buildbucket for the build status
[23:57:16.404] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:16.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:40:0) after 1m0s
[23:58:16.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:40:0)
[23:58:16.485] Timer tick, asking Buildbucket for the build status
[23:58:16.611] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:16.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:41:0) after 1m0s
[23:59:16.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:41:0)
[23:59:16.834] Timer tick, asking Buildbucket for the build status
[23:59:16.933] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:16.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:42:0) after 1m0s
[00:00:17.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:42:0)
[00:00:17.241] Timer tick, asking Buildbucket for the build status
[00:00:17.823] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:17.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:43:0) after 1m0s
[00:01:18.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:43:0)
[00:01:18.169] Timer tick, asking Buildbucket for the build status
[00:01:18.371] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:18.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:44:0) after 1m0s
[00:02:18.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:44:0)
[00:02:18.564] Timer tick, asking Buildbucket for the build status
[00:02:18.642] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:18.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:45:0) after 1m0s
[00:03:18.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:45:0)
[00:03:18.808] Timer tick, asking Buildbucket for the build status
[00:03:18.919] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:18.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:46:0) after 1m0s
[00:04:19.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:46:0)
[00:04:19.067] Timer tick, asking Buildbucket for the build status
[00:04:19.170] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:19.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:47:0) after 1m0s
[00:05:19.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:47:0)
[00:05:19.245] Timer tick, asking Buildbucket for the build status
[00:05:19.990] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:19.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:48:0) after 1m0s
[00:06:20.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:48:0)
[00:06:20.124] Timer tick, asking Buildbucket for the build status
[00:06:20.238] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:20.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:49:0) after 1m0s
[00:07:20.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:49:0)
[00:07:20.351] Timer tick, asking Buildbucket for the build status
[00:07:21.135] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:21.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:50:0) after 1m0s
[00:08:21.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:50:0)
[00:08:21.334] Timer tick, asking Buildbucket for the build status
[00:08:21.453] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:21.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:51:0) after 1m0s
[00:09:21.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:51:0)
[00:09:21.715] Timer tick, asking Buildbucket for the build status
[00:09:22.306] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:22.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:52:0) after 1m0s
[00:10:22.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:52:0)
[00:10:22.349] Timer tick, asking Buildbucket for the build status
[00:10:22.497] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:22.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:53:0) after 1m0s
[00:11:22.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:53:0)
[00:11:22.665] Timer tick, asking Buildbucket for the build status
[00:11:22.778] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:22.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:54:0) after 1m0s
[00:12:22.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:54:0)
[00:12:22.856] Timer tick, asking Buildbucket for the build status
[00:12:23.672] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:23.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:55:0) after 1m0s
[00:13:23.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:55:0)
[00:13:23.737] Timer tick, asking Buildbucket for the build status
[00:13:23.879] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:23.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:56:0) after 1m0s
[00:14:23.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:56:0)
[00:14:23.907] Timer tick, asking Buildbucket for the build status
[00:14:23.978] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:23.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:57:0) after 1m0s
[00:15:24.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:57:0)
[00:15:24.073] Timer tick, asking Buildbucket for the build status
[00:15:24.474] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:24.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:58:0) after 1m0s
[00:16:24.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:58:0)
[00:16:24.563] Timer tick, asking Buildbucket for the build status
[00:16:24.675] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:24.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:59:0) after 1m0s
[00:17:24.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:59:0)
[00:17:24.782] Timer tick, asking Buildbucket for the build status
[00:17:25.198] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:25.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:60:0) after 1m0s
[00:18:25.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:60:0)
[00:18:25.341] Timer tick, asking Buildbucket for the build status
[00:18:25.686] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:25.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:61:0) after 1m0s
[00:19:25.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:61:0)
[00:19:25.866] Timer tick, asking Buildbucket for the build status
[00:19:26.055] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:26.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:62:0) after 1m0s
[00:20:26.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:62:0)
[00:20:26.212] Timer tick, asking Buildbucket for the build status
[00:20:26.344] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:26.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:63:0) after 1m0s
[00:21:26.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:63:0)
[00:21:26.412] Timer tick, asking Buildbucket for the build status
[00:21:26.497] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:26.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:64:0) after 1m0s
[00:22:26.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:64:0)
[00:22:26.534] Timer tick, asking Buildbucket for the build status
[00:22:26.617] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:26.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:65:0) after 1m0s
[00:23:26.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:65:0)
[00:23:26.710] Timer tick, asking Buildbucket for the build status
[00:23:26.964] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:26.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:66:0) after 1m0s
[00:24:27.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:66:0)
[00:24:27.042] Timer tick, asking Buildbucket for the build status
[00:24:27.190] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:27.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:67:0) after 1m0s
[00:25:27.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:67:0)
[00:25:27.199] Timer tick, asking Buildbucket for the build status
[00:25:27.327] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:27.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:68:0) after 1m0s
[00:26:27.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:68:0)
[00:26:27.351] Timer tick, asking Buildbucket for the build status
[00:26:27.420] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:27.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:69:0) after 1m0s
[00:27:27.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:69:0)
[00:27:27.523] Timer tick, asking Buildbucket for the build status
[00:27:28.022] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:28.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:70:0) after 1m0s
[00:28:28.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:70:0)
[00:28:28.058] Timer tick, asking Buildbucket for the build status
[00:28:28.571] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:28.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:71:0) after 1m0s
[00:29:28.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:71:0)
[00:29:28.601] Timer tick, asking Buildbucket for the build status
[00:29:28.675] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:28.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:72:0) after 1m0s
[00:30:28.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:72:0)
[00:30:28.756] Timer tick, asking Buildbucket for the build status
[00:30:28.918] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:28.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:73:0) after 1m0s
[00:31:28.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:73:0)
[00:31:28.952] Timer tick, asking Buildbucket for the build status
[00:31:29.024] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:29.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:74:0) after 1m0s
[00:32:29.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:74:0)
[00:32:29.106] Timer tick, asking Buildbucket for the build status
[00:32:29.743] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:29.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:75:0) after 1m0s
[00:33:29.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:75:0)
[00:33:29.856] Timer tick, asking Buildbucket for the build status
[00:33:29.957] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:29.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:76:0) after 1m0s
[00:34:30.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:76:0)
[00:34:30.013] Timer tick, asking Buildbucket for the build status
[00:34:30.116] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:30.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:77:0) after 1m0s
[00:35:30.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:77:0)
[00:35:30.155] Timer tick, asking Buildbucket for the build status
[00:35:30.282] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:30.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:78:0) after 1m0s
[00:36:30.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:78:0)
[00:36:30.706] Timer tick, asking Buildbucket for the build status
[00:36:30.854] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:30.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:79:0) after 1m0s
[00:37:30.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:79:0)
[00:37:30.897] Timer tick, asking Buildbucket for the build status
[00:37:30.968] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:30.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:80:0) after 1m0s
[00:38:31.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:80:0)
[00:38:31.030] Timer tick, asking Buildbucket for the build status
[00:38:31.105] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:31.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:81:0) after 1m0s
[00:39:31.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:81:0)
[00:39:31.212] Timer tick, asking Buildbucket for the build status
[00:39:31.290] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:31.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:82:0) after 1m0s
[00:40:31.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:82:0)
[00:40:31.382] Timer tick, asking Buildbucket for the build status
[00:40:32.296] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:32.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:83:0) after 1m0s
[00:41:32.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:83:0)
[00:41:32.316] Timer tick, asking Buildbucket for the build status
[00:41:32.594] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:32.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:84:0) after 1m0s
[00:42:32.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:84:0)
[00:42:32.697] Timer tick, asking Buildbucket for the build status
[00:42:32.837] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:32.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:85:0) after 1m0s
[00:43:32.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:85:0)
[00:43:32.937] Timer tick, asking Buildbucket for the build status
[00:43:33.198] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:33.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:86:0) after 1m0s
[00:44:33.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:86:0)
[00:44:33.800] Timer tick, asking Buildbucket for the build status
[00:44:34.198] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:34.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:87:0) after 1m0s
[00:45:34.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:87:0)
[00:45:34.288] Timer tick, asking Buildbucket for the build status
[00:45:34.695] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:34.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:88:0) after 1m0s
[00:46:34.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:88:0)
[00:46:34.736] Timer tick, asking Buildbucket for the build status
[00:46:35.195] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:35.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:89:0) after 1m0s
[00:47:35.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:89:0)
[00:47:35.272] Timer tick, asking Buildbucket for the build status
[00:47:35.885] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:35.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:90:0) after 1m0s
[00:48:35.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:90:0)
[00:48:35.953] Timer tick, asking Buildbucket for the build status
[00:48:36.021] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:36.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:91:0) after 1m0s
[00:49:36.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:91:0)
[00:49:36.074] Timer tick, asking Buildbucket for the build status
[00:49:36.168] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:36.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:92:0) after 1m0s
[00:50:36.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:92:0)
[00:50:36.232] Timer tick, asking Buildbucket for the build status
[00:50:36.345] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:36.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:93:0) after 1m0s
[00:51:36.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:93:0)
[00:51:36.389] Timer tick, asking Buildbucket for the build status
[00:51:36.467] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:36.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:94:0) after 1m0s
[00:52:36.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:94:0)
[00:52:36.558] Timer tick, asking Buildbucket for the build status
[00:52:36.639] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:36.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:95:0) after 1m0s
[00:53:36.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:95:0)
[00:53:36.725] Timer tick, asking Buildbucket for the build status
[00:53:36.814] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:36.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:96:0) after 1m0s
[00:54:36.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:96:0)
[00:54:36.870] Timer tick, asking Buildbucket for the build status
[00:54:36.971] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:36.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:97:0) after 1m0s
[00:55:37.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:97:0)
[00:55:37.002] Timer tick, asking Buildbucket for the build status
[00:55:37.148] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:37.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:98:0) after 1m0s
[00:56:37.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:98:0)
[00:56:37.132] Timer tick, asking Buildbucket for the build status
[00:56:37.432] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:37.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:99:0) after 1m0s
[00:57:37.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:99:0)
[00:57:37.450] Timer tick, asking Buildbucket for the build status
[00:57:37.527] Build 8863885785269056272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:37.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029315848527566176:100:0) after 1m0s
[00:58:37.200] Received PubSub notification, asking Buildbucket for the build status
[00:58:37.337] Build 8863885785269056272: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:58:37.339] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605142715693346",
"created_by": "project:chromium",
"created_ts": "1605136805238181",
"failure_reason": "BUILD_FAILURE",
"id": "8863885785269056272",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4f79df41f8ba69adaf5404870c5540a3e0fc55de\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ExistingUserControllerActiveDirectoryTest.UserKerberosFilesChangedSignalTriggersFileUpdate\\n\\n- ExistingUserControllerActiveDirectoryTest.ActiveDirectoryOnlineLogin_Success\\n\\n- ExistingUserControllerActiveDirectoryTest.ActiveDirectoryOfflineLogin_Success\\n\\n- ExistingUserControllerActiveDirectoryTest.PolicyChangeTriggersFileUpdate\"}, \"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\": \"4f79df41f8ba69adaf5404870c5540a3e0fc55de\", \"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-102-p9wv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21259, \"got_angle_revision\": \"c360709829e16ddfbc97070219cdc414e5e59fb3\", \"got_dawn_revision\": \"3120d5ea0de8840298cc1dd3e702a1a3ebfe9523\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"4f79df41f8ba69adaf5404870c5540a3e0fc55de\", \"got_revision_cp\": \"refs/heads/master@{#826527}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e1012cfc791ddbc6ce11e319831da7973b9a5b32\", \"got_v8_revision\": \"90a57536166aad8480e2252806dbc6b2e843bd77\", \"got_v8_revision_cp\": \"refs/heads/8.8.288@{#1}\", \"got_webrtc_revision\": \"06bbeb3398afa8651ca76ea7eb56b7d046edfca8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32588}\", \"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\": \"4f79df41f8ba69adaf5404870c5540a3e0fc55de\", \"swarm_hashes_refs/heads/master(at){#826527}_without_patch\": {\"absl_hardening_tests\": \"b7634617140e63ec3271c85f229dd04208c98447\", \"accessibility_unittests\": \"3ea8ce8abdc5313c8e719c263ccebf86935a2334\", \"angle_unittests\": \"da9bcf854c9e5dc4e0ca160517525b6d1bea3255\", \"app_list_unittests\": \"c45fbc77960d33bea90e5a81e87e3a42af280293\", \"app_shell_unittests\": \"b7f7ef3fb23a8260c287b8d77da0c89505425d66\", \"ash_unittests\": \"47805f7537f443e5c21ea563d8034f464e050756\", \"aura_unittests\": \"109efaa683781e29f7d36c0aa299eb78b506f0e5\", \"base_unittests\": \"02d79520a0b1584dc7cbd58c711e42a7c90d1cb6\", \"base_util_unittests\": \"34d839706e8e026634594183ba70b2a056edb7b9\", \"blink_common_unittests\": \"44d441fdfcafa0e93a6184688acc02de9c8d5812\", \"blink_fuzzer_unittests\": \"567889e2e46a5acd97b2f41b4b06e255d15dacde\", \"blink_heap_unittests\": \"e7dbcc85830346abe63a2f9eb7e9a0863952af98\", \"blink_platform_unittests\": \"827e9ae0acd10e446948318de467c53b5b321f40\", \"blink_unittests\": \"8364f947fafe72909cc570c95a55a66bcfeba2b6\", \"boringssl_crypto_tests\": \"425dc4d8c9d6f1ce6c59e6445aec3f79b5e83234\", \"boringssl_ssl_tests\": \"c56ae0904517fc0c06054866a80965f624be8045\", \"browser_tests\": \"cbc4dc7887ca18d26320aa4c90be24d34eadc833\", \"capture_unittests\": \"00529bcea0b506327d5a568fd2afe52338bf2eaa\", \"cast_unittests\": \"fa92f4099b41eb9014ef80c41f90a8365f05b82a\", \"cc_unittests\": \"26f80ffb788e328905994ee2d24f1e1f604781b6\", \"chrome_app_unittests\": \"4374643214c01498949918839400a1128680358e\", \"chromedriver_unittests\": \"156f4ae29dac7ee1e4342d8f8925092f16016a9d\", \"chromeos_components_unittests\": \"d3bddc7fc88dd94640af7cf9b9e95417b64057e2\", \"chromeos_unittests\": \"395cb0375bab4d449bc46daf899926240bbbfdb5\", \"components_browsertests\": \"7092f7b50fd71c2d422515dde4ae0c2ab7ae496d\", \"components_unittests\": \"a9d80d36d2987cb354b8c8f6160f37f8a4392e83\", \"compositor_unittests\": \"8ce55691d50fd8d4b5d9053d80ba11177bdfe819\", \"content_browsertests\": \"72c85b8cca43e9c3b67c9fb93646e6b572c364a5\", \"content_unittests\": \"c3f44d2d62f41cefb5d25a530c528a8e1ba0b446\", \"crashpad_tests\": \"2463b1a13265eb3a0ec232c15e710e6165eda243\", \"crypto_unittests\": \"6336ea6abfe1b2b792518d4bba470d08131b880e\", \"dbus_unittests\": \"fcb639095cd56b8fe44815b674ef4bcdfb207e13\", \"device_unittests\": \"4a755188eaaa84c28f603d57bb47e690cac16e1a\", \"display_unittests\": \"944d52c0d771523f280bc820943254b3083c6e6e\", \"events_unittests\": \"bd7a271916f47e28e07c8042a379f617c675230f\", \"exo_unittests\": \"beca284bfd7238dd8544cd643d53e4820166d915\", \"extensions_browsertests\": \"54974d3f657242e74ca6a9df378830e41fa15f18\", \"extensions_unittests\": \"8c3468c126cd1646811d4332ec80241f44ccece1\", \"filesystem_service_unittests\": \"ddaa807fdc2d28086f4dc55664a8d41d389be3bf\", \"gcm_unit_tests\": \"ba37e2ef1c41cb23f57774ad2e06be3db5795e31\", \"gfx_unittests\": \"44e5dd7fa4ee8d55e303f81e17bcb7fcc9d69076\", \"gin_unittests\": \"b4d6badd48c18a0d28423de0f42e9866e8de2a4a\", \"gl_unittests_ozone\": \"e8ff7fe87e2ff0f69636a9b798cdcc9c303f1804\", \"google_apis_unittests\": \"a94e071cb22fd57376be97e0071d1a98118f7942\", \"gpu_unittests\": \"be61a1f13704b0dbe3ba3e94b9e53bfa65166fad\", \"gwp_asan_unittests\": \"eaa588d1252f4aeb56f7885661db209e117f6d56\", \"interactive_ui_tests\": \"8d7ad4c086779934af3eb5856179cbcb511c89df\", \"ipc_tests\": \"b1a7f0bce471bd62d90ed0629059b28add11367a\", \"jingle_unittests\": \"74657b68b2cc8186342760f38b38790c1cb9f460\", \"keyboard_unittests\": \"623d494064c17fbd2ec2a02c7d4478c76629130c\", \"latency_unittests\": \"0bbed51ef0f671ed88f704b4db609ae8730d278e\", \"libjingle_xmpp_unittests\": \"356bff412202566c98ee352da0fc16d012eff066\", \"liburlpattern_unittests\": \"e015ad77105763d98f600d1031be33125b5e2008\", \"media_blink_unittests\": \"200573495d4f97c971025164d0f839495e73571c\", \"media_unittests\": \"a65376d6a75806a299ba6fb54ac21eaeab88f27e\", \"message_center_unittests\": \"183b1bcd6ec9d368cb2b2a198a95d275d664d99a\", \"midi_unittests\": \"24772e91d641ff2b17d3889bd1653215c41eb78a\", \"mojo_core_unittests\": \"a716e9d70d37f9c1b68a4d30ad64e7506952f736\", \"mojo_unittests\": \"4485a70233c7a68cfd4c44c86c83fc92a292f2cc\", \"nacl_helper_nonsfi_unittests\": \"31bb144afe16dbc467b5b3194c9cbc9d8084e69b\", \"nacl_loader_unittests\": \"109ed00cb799b8ae3f40b0cbea6c56239dd60fe9\", \"native_theme_unittests\": \"db96613ec32a37dc46536b723b9ea14c957c05f7\", \"net_unittests\": \"a98844b7e1a44160233a5a515365d14ac254b78f\", \"ozone_gl_unittests\": \"7c0975eb23ebe5c9d0a49f635a8a6723763407f8\", \"ozone_unittests\": \"7d6b268c7a2aece492481f61e5c622a3ca09a3ff\", \"ozone_x11_unittests\": \"29d45ad8712758f4ef3ebdc729e9f614bd301ba7\", \"pdf_unittests\": \"24b3400c36a1f1ed98ec8ba71dc07a8c7f7afbb6\", \"perfetto_unittests\": \"44d88f0fefb66312af4d51dc1641848445a85cba\", \"ppapi_unittests\": \"260f2d92d4fc159808ef9c6f4d67b7677e07296e\", \"printing_unittests\": \"c9c4592be2c6c329c3cced9519abfe2710dfdf23\", \"remoting_unittests\": \"9d086d9188e3e7244742fb1efa03593a0960d650\", \"sandbox_linux_unittests\": \"8ecf0f6d0848568dbc3911d2bb04ae0567954d42\", \"service_manager_unittests\": \"791082b1aa06881db718049c913c7c97b434894b\", \"services_unittests\": \"94ad345af4c0cefc0079c6ccbadb885ea0a13b4e\", \"shell_dialogs_unittests\": \"4b715e9790473f0932885af6b1486ee79bb0d826\", \"skia_unittests\": \"3d3abe7b29f435cfae748eed246df1c670960a91\", \"snapshot_unittests\": \"6336a2034c75edd075fd4510030af5a584a1e0f8\", \"sql_unittests\": \"8edcaf6b5b3e43e394ff40930e1f6a9e052604b2\", \"storage_unittests\": \"3723a32d4f33da18c9141d7a4d0e34b9b8060a05\", \"sync_integration_tests\": \"20bd0e8ba7e8f066fc9ef220db46abc20d9aef96\", \"traffic_annotation_auditor_unittests\": \"2b03ea5b17d4ecdd407ebf23ff908f858d3520f0\", \"ui_base_unittests\": \"4aad3eb61913588bad219de46edb6de0d702c823\", \"ui_chromeos_unittests\": \"e9d7faf320e059474f053d091725ebdcc051bcae\", \"ui_touch_selection_unittests\": \"afd4277af22c9d11c26fae4b9f81c683436442e8\", \"unit_tests\": \"7b4fd960c6f636411cc11f94cddfdb2eb3ccd818\", \"url_unittests\": \"5d7cf98f817a529a4441c2f348b521b46414c640\", \"usage_time_limit_unittests\": \"cf5cc812c315cf4cf482171d83b59ac628244919\", \"views_unittests\": \"383853649dd1173227a87e294feec99216383d67\", \"viz_unittests\": \"1788ac0a0334887e9c5f8c3a326304f11d0753ce\", \"wm_unittests\": \"366a7490050b86e308f344e0d2e5f556f0998034\", \"wtf_unittests\": \"83bf833150699616e7d47c8b2a27132546588240\", \"zlib_unittests\": \"73082aabf8bfbc8bf1694e7a4e671127a9a16b40\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-102-p9wv\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"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- ExistingUserControllerActiveDirectoryTest.UserKerberosFilesChangedSignalTriggersFileUpdate\\n\\n- ExistingUserControllerActiveDirectoryTest.ActiveDirectoryOnlineLogin_Success\\n\\n- ExistingUserControllerActiveDirectoryTest.ActiveDirectoryOfflineLogin_Success\\n\\n- ExistingUserControllerActiveDirectoryTest.PolicyChangeTriggersFileUpdate\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605137041854559",
"status": "COMPLETED",
"status_changed_ts": "1605137042187470",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21259",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4f79df41f8ba69adaf5404870c5540a3e0fc55de",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f79df41f8ba69adaf5404870c5540a3e0fc55de",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029315848527566176",
"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/8863885785269056272/+/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:4fd26d7a334bef10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605142716568830",
"url": "https://ci.chromium.org/b/8863885785269056272",
"utcnow_ts": "1605142717320122"
}
}
[00:58:37.339] Invocation finished in 1h38m34.591884749s with status FAILED