[23:44:44.485] New invocation is queued and will start shortly
[23:44:45.698] Starting the invocation (attempt 1)
[23:44:45.735] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:44:45.735] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:44:45.735] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031035637192976960",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a4867eda65c79eccc99099a15f4180c4448b2ea7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031035637192976960",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a4867eda65c79eccc99099a15f4180c4448b2ea7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a4867eda65c79eccc99099a15f4180c4448b2ea7",
"gitiles_ref:refs/heads/master"
]
}
[23:44:46.489] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603496685853439",
"id": "8865605575093108000",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a4867eda65c79eccc99099a15f4180c4448b2ea7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603496686337568",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20984",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a4867eda65c79eccc99099a15f4180c4448b2ea7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a4867eda65c79eccc99099a15f4180c4448b2ea7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031035637192976960",
"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/8865605575093108000/+/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": "1603496686337717",
"url": "https://ci.chromium.org/b/8865605575093108000",
"utcnow_ts": "1603496686482240"
}
}
[23:44:46.489] Task URL: https://ci.chromium.org/b/8865605575093108000
[23:44:46.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:2:0) after 1m0s
[23:45:46.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:2:0)
[23:45:46.518] Timer tick, asking Buildbucket for the build status
[23:45:46.626] Build 8865605575093108000: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:46.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:3:0) after 1m0s
[23:46:12.613] Received PubSub notification, asking Buildbucket for the build status
[23:46:12.698] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:46.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:3:0)
[23:46:46.682] Timer tick, asking Buildbucket for the build status
[23:46:46.784] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:46.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:5:0) after 1m0s
[23:47:46.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:5:0)
[23:47:46.797] Timer tick, asking Buildbucket for the build status
[23:47:47.535] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:47.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:6:0) after 1m0s
[23:48:47.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:6:0)
[23:48:47.586] Timer tick, asking Buildbucket for the build status
[23:48:47.685] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:47.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:7:0) after 1m0s
[23:49:47.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:7:0)
[23:49:47.723] Timer tick, asking Buildbucket for the build status
[23:49:47.833] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:47.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:8:0) after 1m0s
[23:50:47.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:8:0)
[23:50:47.847] Timer tick, asking Buildbucket for the build status
[23:50:47.971] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:47.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:9:0) after 1m0s
[23:51:47.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:9:0)
[23:51:47.983] Timer tick, asking Buildbucket for the build status
[23:51:48.613] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:48.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:10:0) after 1m0s
[23:52:48.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:10:0)
[23:52:48.638] Timer tick, asking Buildbucket for the build status
[23:52:48.711] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:48.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:11:0) after 1m0s
[23:53:48.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:11:0)
[23:53:48.791] Timer tick, asking Buildbucket for the build status
[23:53:49.125] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:49.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:12:0) after 1m0s
[23:54:49.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:12:0)
[23:54:49.206] Timer tick, asking Buildbucket for the build status
[23:54:49.784] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:49.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:13:0) after 1m0s
[23:55:49.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:13:0)
[23:55:49.857] Timer tick, asking Buildbucket for the build status
[23:55:49.923] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:49.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:14:0) after 1m0s
[23:56:49.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:14:0)
[23:56:49.939] Timer tick, asking Buildbucket for the build status
[23:56:50.013] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:50.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:15:0) after 1m0s
[23:57:50.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:15:0)
[23:57:50.028] Timer tick, asking Buildbucket for the build status
[23:57:50.137] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:50.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:16:0) after 1m0s
[23:58:50.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:16:0)
[23:58:50.172] Timer tick, asking Buildbucket for the build status
[23:58:50.233] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:50.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:17:0) after 1m0s
[23:59:50.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:17:0)
[23:59:50.257] Timer tick, asking Buildbucket for the build status
[23:59:50.366] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:50.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:18:0) after 1m0s
[00:00:50.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:18:0)
[00:00:50.391] Timer tick, asking Buildbucket for the build status
[00:00:50.976] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:50.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:19:0) after 1m0s
[00:01:51.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:19:0)
[00:01:51.042] Timer tick, asking Buildbucket for the build status
[00:01:51.118] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:51.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:20:0) after 1m0s
[00:02:51.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:20:0)
[00:02:51.181] Timer tick, asking Buildbucket for the build status
[00:02:51.243] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:51.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:21:0) after 1m0s
[00:03:51.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:21:0)
[00:03:51.295] Timer tick, asking Buildbucket for the build status
[00:03:51.369] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:51.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:22:0) after 1m0s
[00:04:51.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:22:0)
[00:04:51.438] Timer tick, asking Buildbucket for the build status
[00:04:52.856] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:52.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:23:0) after 1m0s
[00:05:52.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:23:0)
[00:05:52.904] Timer tick, asking Buildbucket for the build status
[00:05:52.984] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:52.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:24:0) after 1m0s
[00:06:53.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:24:0)
[00:06:53.021] Timer tick, asking Buildbucket for the build status
[00:06:53.097] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:53.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:25:0) after 1m0s
[00:07:53.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:25:0)
[00:07:53.307] Timer tick, asking Buildbucket for the build status
[00:07:53.366] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:53.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:26:0) after 1m0s
[00:08:53.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:26:0)
[00:08:53.375] Timer tick, asking Buildbucket for the build status
[00:08:53.455] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:53.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:27:0) after 1m0s
[00:09:53.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:27:0)
[00:09:53.518] Timer tick, asking Buildbucket for the build status
[00:09:53.636] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:53.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:28:0) after 1m0s
[00:10:53.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:28:0)
[00:10:53.800] Timer tick, asking Buildbucket for the build status
[00:10:53.871] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:53.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:29:0) after 1m0s
[00:11:53.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:29:0)
[00:11:53.895] Timer tick, asking Buildbucket for the build status
[00:11:53.958] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:53.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:30:0) after 1m0s
[00:12:53.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:30:0)
[00:12:53.963] Timer tick, asking Buildbucket for the build status
[00:12:54.037] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:54.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:31:0) after 1m0s
[00:13:54.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:31:0)
[00:13:54.058] Timer tick, asking Buildbucket for the build status
[00:13:54.115] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:54.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:32:0) after 1m0s
[00:14:54.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:32:0)
[00:14:54.146] Timer tick, asking Buildbucket for the build status
[00:14:54.250] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:54.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:33:0) after 1m0s
[00:15:54.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:33:0)
[00:15:54.251] Timer tick, asking Buildbucket for the build status
[00:15:54.513] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:54.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:34:0) after 1m0s
[00:16:54.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:34:0)
[00:16:54.547] Timer tick, asking Buildbucket for the build status
[00:16:54.725] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:54.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:35:0) after 1m0s
[00:17:54.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:35:0)
[00:17:54.797] Timer tick, asking Buildbucket for the build status
[00:17:54.855] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:54.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:36:0) after 1m0s
[00:18:54.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:36:0)
[00:18:54.837] Timer tick, asking Buildbucket for the build status
[00:18:55.153] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:55.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:37:0) after 1m0s
[00:19:55.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:37:0)
[00:19:55.180] Timer tick, asking Buildbucket for the build status
[00:19:55.293] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:55.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:38:0) after 1m0s
[00:20:55.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:38:0)
[00:20:55.369] Timer tick, asking Buildbucket for the build status
[00:20:55.587] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:55.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:39:0) after 1m0s
[00:21:55.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:39:0)
[00:21:55.658] Timer tick, asking Buildbucket for the build status
[00:21:55.741] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:55.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:40:0) after 1m0s
[00:22:55.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:40:0)
[00:22:55.789] Timer tick, asking Buildbucket for the build status
[00:22:55.914] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:55.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:41:0) after 1m0s
[00:23:55.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:41:0)
[00:23:55.889] Timer tick, asking Buildbucket for the build status
[00:23:56.096] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:56.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:42:0) after 1m0s
[00:24:56.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:42:0)
[00:24:56.141] Timer tick, asking Buildbucket for the build status
[00:24:56.244] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:56.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:43:0) after 1m0s
[00:25:56.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:43:0)
[00:25:56.309] Timer tick, asking Buildbucket for the build status
[00:25:56.396] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:56.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:44:0) after 1m0s
[00:26:56.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:44:0)
[00:26:56.491] Timer tick, asking Buildbucket for the build status
[00:26:57.372] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:57.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:45:0) after 1m0s
[00:27:57.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:45:0)
[00:27:57.448] Timer tick, asking Buildbucket for the build status
[00:27:57.584] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:57.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:46:0) after 1m0s
[00:28:57.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:46:0)
[00:28:57.606] Timer tick, asking Buildbucket for the build status
[00:28:57.745] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:57.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:47:0) after 1m0s
[00:29:57.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:47:0)
[00:29:57.747] Timer tick, asking Buildbucket for the build status
[00:29:58.113] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:58.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:48:0) after 1m0s
[00:30:58.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:48:0)
[00:30:58.202] Timer tick, asking Buildbucket for the build status
[00:30:58.305] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:58.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:49:0) after 1m0s
[00:31:58.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:49:0)
[00:31:58.329] Timer tick, asking Buildbucket for the build status
[00:31:58.699] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:58.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:50:0) after 1m0s
[00:32:58.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:50:0)
[00:32:58.786] Timer tick, asking Buildbucket for the build status
[00:32:58.956] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:58.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:51:0) after 1m0s
[00:33:58.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:51:0)
[00:33:58.982] Timer tick, asking Buildbucket for the build status
[00:33:59.132] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:59.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:52:0) after 1m0s
[00:34:59.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:52:0)
[00:34:59.180] Timer tick, asking Buildbucket for the build status
[00:34:59.328] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:59.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:53:0) after 1m0s
[00:35:59.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:53:0)
[00:35:59.380] Timer tick, asking Buildbucket for the build status
[00:35:59.465] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:59.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:54:0) after 1m0s
[00:36:59.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:54:0)
[00:36:59.472] Timer tick, asking Buildbucket for the build status
[00:36:59.783] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:59.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:55:0) after 1m0s
[00:37:59.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:55:0)
[00:37:59.808] Timer tick, asking Buildbucket for the build status
[00:38:00.185] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:00.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:56:0) after 1m0s
[00:39:00.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:56:0)
[00:39:00.175] Timer tick, asking Buildbucket for the build status
[00:39:00.240] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:00.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:57:0) after 1m0s
[00:40:00.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:57:0)
[00:40:00.272] Timer tick, asking Buildbucket for the build status
[00:40:00.401] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:00.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:58:0) after 1m0s
[00:41:00.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:58:0)
[00:41:00.428] Timer tick, asking Buildbucket for the build status
[00:41:00.684] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:00.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:59:0) after 1m0s
[00:42:00.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:59:0)
[00:42:00.852] Timer tick, asking Buildbucket for the build status
[00:42:01.073] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:01.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:60:0) after 1m0s
[00:43:01.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:60:0)
[00:43:01.612] Timer tick, asking Buildbucket for the build status
[00:43:01.720] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:01.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:61:0) after 1m0s
[00:44:01.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:61:0)
[00:44:01.795] Timer tick, asking Buildbucket for the build status
[00:44:01.882] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:01.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:62:0) after 1m0s
[00:45:01.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:62:0)
[00:45:01.920] Timer tick, asking Buildbucket for the build status
[00:45:02.040] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:02.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:63:0) after 1m0s
[00:46:02.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:63:0)
[00:46:02.068] Timer tick, asking Buildbucket for the build status
[00:46:02.317] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:02.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:64:0) after 1m0s
[00:47:02.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:64:0)
[00:47:02.364] Timer tick, asking Buildbucket for the build status
[00:47:02.491] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:02.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:65:0) after 1m0s
[00:48:02.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:65:0)
[00:48:02.514] Timer tick, asking Buildbucket for the build status
[00:48:02.589] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:02.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:66:0) after 1m0s
[00:49:02.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:66:0)
[00:49:02.601] Timer tick, asking Buildbucket for the build status
[00:49:02.984] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:02.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:67:0) after 1m0s
[00:50:03.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:67:0)
[00:50:03.021] Timer tick, asking Buildbucket for the build status
[00:50:03.304] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:03.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:68:0) after 1m0s
[00:51:03.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:68:0)
[00:51:03.300] Timer tick, asking Buildbucket for the build status
[00:51:03.626] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:03.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:69:0) after 1m0s
[00:52:03.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:69:0)
[00:52:03.650] Timer tick, asking Buildbucket for the build status
[00:52:03.764] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:03.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:70:0) after 1m0s
[00:53:03.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:70:0)
[00:53:03.782] Timer tick, asking Buildbucket for the build status
[00:53:03.987] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:03.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:71:0) after 1m0s
[00:54:04.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:71:0)
[00:54:04.099] Timer tick, asking Buildbucket for the build status
[00:54:04.232] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:04.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:72:0) after 1m0s
[00:55:04.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:72:0)
[00:55:04.436] Timer tick, asking Buildbucket for the build status
[00:55:04.657] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:04.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:73:0) after 1m0s
[00:56:04.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:73:0)
[00:56:04.699] Timer tick, asking Buildbucket for the build status
[00:56:04.770] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:04.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:74:0) after 1m0s
[00:57:04.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:74:0)
[00:57:04.814] Timer tick, asking Buildbucket for the build status
[00:57:05.018] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:05.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:75:0) after 1m0s
[00:58:05.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:75:0)
[00:58:05.026] Timer tick, asking Buildbucket for the build status
[00:58:05.111] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:05.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:76:0) after 1m0s
[00:59:05.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:76:0)
[00:59:05.900] Timer tick, asking Buildbucket for the build status
[00:59:06.000] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:06.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:77:0) after 1m0s
[01:00:06.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:77:0)
[01:00:06.195] Timer tick, asking Buildbucket for the build status
[01:00:06.350] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:06.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:78:0) after 1m0s
[01:01:06.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:78:0)
[01:01:06.515] Timer tick, asking Buildbucket for the build status
[01:01:06.578] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:06.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:79:0) after 1m0s
[01:02:06.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:79:0)
[01:02:06.689] Timer tick, asking Buildbucket for the build status
[01:02:06.811] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:06.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:80:0) after 1m0s
[01:03:06.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:80:0)
[01:03:06.874] Timer tick, asking Buildbucket for the build status
[01:03:07.079] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:07.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:81:0) after 1m0s
[01:04:07.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:81:0)
[01:04:07.191] Timer tick, asking Buildbucket for the build status
[01:04:07.563] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:07.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:82:0) after 1m0s
[01:05:07.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:82:0)
[01:05:07.674] Timer tick, asking Buildbucket for the build status
[01:05:07.845] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:07.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:83:0) after 1m0s
[01:06:07.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:83:0)
[01:06:07.940] Timer tick, asking Buildbucket for the build status
[01:06:08.018] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:08.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:84:0) after 1m0s
[01:07:08.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:84:0)
[01:07:08.089] Timer tick, asking Buildbucket for the build status
[01:07:08.212] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:08.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:85:0) after 1m0s
[01:08:08.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:85:0)
[01:08:08.559] Timer tick, asking Buildbucket for the build status
[01:08:08.641] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:08.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:86:0) after 1m0s
[01:09:08.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:86:0)
[01:09:08.907] Timer tick, asking Buildbucket for the build status
[01:09:09.006] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:09.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:87:0) after 1m0s
[01:10:09.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:87:0)
[01:10:09.129] Timer tick, asking Buildbucket for the build status
[01:10:09.271] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:09.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:88:0) after 1m0s
[01:11:09.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:88:0)
[01:11:09.305] Timer tick, asking Buildbucket for the build status
[01:11:09.381] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:09.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:89:0) after 1m0s
[01:12:09.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:89:0)
[01:12:09.548] Timer tick, asking Buildbucket for the build status
[01:12:09.614] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:09.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:90:0) after 1m0s
[01:13:09.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:90:0)
[01:13:09.852] Timer tick, asking Buildbucket for the build status
[01:13:09.929] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:09.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:91:0) after 1m0s
[01:14:10.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:91:0)
[01:14:10.046] Timer tick, asking Buildbucket for the build status
[01:14:10.127] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:10.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:92:0) after 1m0s
[01:15:10.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:92:0)
[01:15:10.146] Timer tick, asking Buildbucket for the build status
[01:15:10.270] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:10.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:93:0) after 1m0s
[01:16:10.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:93:0)
[01:16:10.303] Timer tick, asking Buildbucket for the build status
[01:16:10.391] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:10.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:94:0) after 1m0s
[01:17:10.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:94:0)
[01:17:10.420] Timer tick, asking Buildbucket for the build status
[01:17:10.514] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:10.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:95:0) after 1m0s
[01:18:10.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:95:0)
[01:18:10.564] Timer tick, asking Buildbucket for the build status
[01:18:10.688] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:10.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:96:0) after 1m0s
[01:19:10.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:96:0)
[01:19:10.758] Timer tick, asking Buildbucket for the build status
[01:19:10.879] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:10.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:97:0) after 1m0s
[01:20:10.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:97:0)
[01:20:10.990] Timer tick, asking Buildbucket for the build status
[01:20:11.140] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:11.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:98:0) after 1m0s
[01:21:11.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:98:0)
[01:21:11.192] Timer tick, asking Buildbucket for the build status
[01:21:11.385] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:11.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:99:0) after 1m0s
[01:22:11.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:99:0)
[01:22:11.430] Timer tick, asking Buildbucket for the build status
[01:22:11.545] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:11.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:100:0) after 1m0s
[01:23:11.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:100:0)
[01:23:11.648] Timer tick, asking Buildbucket for the build status
[01:23:11.729] Build 8865605575093108000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:11.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031035637192976960:101:0) after 1m0s
[01:23:31.970] Received PubSub notification, asking Buildbucket for the build status
[01:23:32.046] Build 8865605575093108000: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:23:32.046] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603502609704209",
"created_by": "project:chromium",
"created_ts": "1603496685853439",
"id": "8865605575093108000",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a4867eda65c79eccc99099a15f4180c4448b2ea7\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"a4867eda65c79eccc99099a15f4180c4448b2ea7\", \"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-east1-d-8-50-xkjg\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20984, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"8901df8ffe29b3bf2ef3269edfd3a0e25fdf4b82\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"a4867eda65c79eccc99099a15f4180c4448b2ea7\", \"got_revision_cp\": \"refs/heads/master@{#820492}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"c572b4256fc2842c3e466038b8691e4b54a7a385\", \"got_v8_revision_cp\": \"refs/heads/8.8.170@{#1}\", \"got_webrtc_revision\": \"3d25935127400418ef6b5970f0edec5db01d2ba6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32478}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a4867eda65c79eccc99099a15f4180c4448b2ea7\", \"swarm_hashes_refs/heads/master(at){#820492}_without_patch\": {\"absl_hardening_tests\": \"86e11948b1231e60427ebd7eb1b7e7a4983536ad\", \"accessibility_unittests\": \"d7533331118382ac1d3b6e4c38637aaf1f4cbdcc\", \"angle_unittests\": \"70b97cdb4f1349c188a97f6a0710c1b70d27adbd\", \"app_list_unittests\": \"7bf49696db45fafde16d6472d11676a798262102\", \"app_shell_unittests\": \"665537674194f087075f5dd48441a78050c169de\", \"ash_unittests\": \"915fca5aea47950bc275cb9364f2eda67e0fb9cc\", \"aura_unittests\": \"4584dbb7ecd81b47c0d98c870dd65991fcd907c2\", \"base_unittests\": \"e26fc84131dc81ba48203b6e6ce34b8db1ebd7ba\", \"base_util_unittests\": \"e02e1f1bcbfec44a239bb7d413393c42f4b780a0\", \"blink_common_unittests\": \"75850f478fa39289de9cd1b8a91f627e2a544b83\", \"blink_fuzzer_unittests\": \"73bf79834493b7c8e007ed820d4e55634add03fd\", \"blink_heap_unittests\": \"7dc34b36238500a50a10a8f65fc62fdba664f378\", \"blink_platform_unittests\": \"9dc04130a36349e98261befc4a75ff437d4f9953\", \"blink_unittests\": \"96753bf79b4816341098dbdc4fe552e1fbd6eed6\", \"boringssl_crypto_tests\": \"db23e299bb53f5a85c3ac040e4bdbbb35c8bd546\", \"boringssl_ssl_tests\": \"4779a9da637ccd5d5efdbaf2257515559281c3b1\", \"browser_tests\": \"6facf916465c4c90e79633a824a819cbab183701\", \"capture_unittests\": \"882c09351d4555a236640270659e518a6b3bef0e\", \"cast_unittests\": \"d3901a041e26b843b5d979e29caa5f6672e7dc5d\", \"cc_unittests\": \"1ce8e935dbabc7617e956bad64934828c41e3536\", \"chrome_app_unittests\": \"32f3c378440086ec444311ad0368aadea63dda93\", \"chromedriver_unittests\": \"45545bef8769000e8d955351bdbd864d202ba76b\", \"chromeos_components_unittests\": \"05bacc7a119edfc2ef05092162cc168f495e1a65\", \"chromeos_unittests\": \"5e78279cdb0c496951702dd001549b874116820f\", \"components_browsertests\": \"94826f6ab2149cc147383d66cb65b18786387660\", \"components_unittests\": \"4fe79c552b201007421dcd080bbd84770d80f603\", \"compositor_unittests\": \"960308311624eb58d66ebb69ef0e2334ee312fa2\", \"content_browsertests\": \"ef322e050f1858136e5add323710b1fd5d394879\", \"content_unittests\": \"4890ebfd186397e326b91e8cadc82d4b81496b26\", \"crypto_unittests\": \"68d57af2210b01c7bccbf63c82e7c3d9c09b1e2a\", \"dbus_unittests\": \"031369992e0566e05359f0212ccb4ef73c41b57c\", \"device_unittests\": \"cb6bd6e60f115fbc59d188e4efa45fb4e2889e9a\", \"display_unittests\": \"15bcafae72152de98a1c54a6bd5ec4be21707d69\", \"events_unittests\": \"fbeafb35aabcfda0d5d49c887b82288152820719\", \"exo_unittests\": \"a2bf1ffe3af9fca061fd3014a50f35129c8de0d6\", \"extensions_browsertests\": \"04791da4b3122127f13c342a6cf9fa028031ffe5\", \"extensions_unittests\": \"b4f62c835e0a70707fcd6f0407d47dbcfc2192d7\", \"filesystem_service_unittests\": \"466ce3c82fd123051216dc8c893db6e8d233d25d\", \"gcm_unit_tests\": \"2279de6733edbdd11d3c75f3cc11878670e8d556\", \"gfx_unittests\": \"e96c57cdb0ef0a170261a8567063d0459bfb48e9\", \"gin_unittests\": \"4c041ae23cdf5872691a9ca7c73ea72054f5c8d9\", \"gl_unittests_ozone\": \"71dfe416a66052bf25c0cd7dac7b401c5b85a96a\", \"google_apis_unittests\": \"f5d46cbaeabfd7e31fd1fcfe7679a15e91d3e206\", \"gpu_unittests\": \"23bab49cefe770d9536cc06c7cc58d061c1f6dc2\", \"gwp_asan_unittests\": \"1a9ca6afe31c6b6707091d8423083023941f00f6\", \"interactive_ui_tests\": \"19024cba89525345487204d565eba14e943b287b\", \"ipc_tests\": \"1f0660527676adb2fe8f2205365234756c7e0f7d\", \"jingle_unittests\": \"7328549eaf18b88e5ea20bec6bfdce7910dc82aa\", \"keyboard_unittests\": \"01db63e66d535819b5cc2d8403e2f08e85aa29bc\", \"latency_unittests\": \"50c66e18fe0e1749d1a9ab125726781e6de524b8\", \"libjingle_xmpp_unittests\": \"84656189a35840990d1f6bb46fc26c930385d1be\", \"media_blink_unittests\": \"ca812d44e769b98ca8a1d71f8292e43586eb32cb\", \"media_unittests\": \"3e3882805bf3f705c47b0d48bf2b0c63061b8ad5\", \"message_center_unittests\": \"43116c7e330c22a3c8f1609873336664a6da534c\", \"midi_unittests\": \"a5d763f7b8ba7e24fc21ccee4061a5bbae14787a\", \"mojo_core_unittests\": \"498e89045959152c01b4d5cec11e828ca221817a\", \"mojo_unittests\": \"4c11dae7ef5b447b87c8b13c444a9f95af29674a\", \"nacl_helper_nonsfi_unittests\": \"942e19f636cfa6120d90550009e4ce8ef882e3f7\", \"nacl_loader_unittests\": \"70d1f83f5a465d34b11638566c95497e2264658f\", \"native_theme_unittests\": \"2bb0828af26cf3aad6c9e6f45e8a8cb39cafcdac\", \"net_unittests\": \"c2637d15a7080a97aa3a478cbe31ebfe8d9b4288\", \"ozone_gl_unittests\": \"484edbd1d23456558022719d399d079457549d0d\", \"ozone_unittests\": \"62b24ce9ead104084d0ca6e49c97748a8064fc3d\", \"ozone_x11_unittests\": \"962098eb6867194ed6c99206b3c6433998309e57\", \"pdf_unittests\": \"8b225a05a50ec0c9cee3052a7549c48fab73ecb2\", \"perfetto_unittests\": \"a626655bcf341977ec4aad68d0c98a49f6972a1a\", \"ppapi_unittests\": \"df963095293dd3e00b59d2b50ad3963ae4c09169\", \"printing_unittests\": \"3d697aa576587c8ea1feabde1ef3797c3b627abe\", \"remoting_unittests\": \"36c38e86702ac3ca7b66c766598ef8d4f5b33627\", \"sandbox_linux_unittests\": \"790ae35f55086f64c3abe63e914fae6f74350958\", \"service_manager_unittests\": \"69bf13ea201ecfec621fe73a598f924d64c3dc4f\", \"services_unittests\": \"8453942e654933b6548950b0fe61fd01f22d8819\", \"shell_dialogs_unittests\": \"091e4aeea5221191551b72faee5ba8a604e1645c\", \"skia_unittests\": \"718a33106d17d7dba32272488b6a784880424416\", \"snapshot_unittests\": \"1d757e2b411812848b3033a99d5cb9b0ac0c88e2\", \"sql_unittests\": \"d1bcae6e828a8da23cbda697aaf32bf175a4c78b\", \"storage_unittests\": \"7f73c4de69f7e22a9029404b86a1665e0dd1b536\", \"sync_integration_tests\": \"9a6015e52f25b408ee55e24fc21a312ec8e55495\", \"traffic_annotation_auditor_unittests\": \"aa93c3f40152eaa012479f5cbb4feaf1178729e6\", \"ui_base_unittests\": \"25feec651237dd1a9209292a1c911a0194711c59\", \"ui_chromeos_unittests\": \"46c3fb6e9d2eba8f6146eb6469c76e49e3a05c32\", \"ui_touch_selection_unittests\": \"4465758cceefe20a3311383254380d68357b39c0\", \"unit_tests\": \"6c77f2aef831af1692720536266bb39e94322905\", \"url_unittests\": \"6f2b0984ed166ad375f605ff88cbe8e30bb107f3\", \"usage_time_limit_unittests\": \"212e47015e6b8937600e6b39a1f6d1fa54409edf\", \"views_unittests\": \"9a24f02517c77de75623170f4a78cef372862581\", \"viz_unittests\": \"a4b8b67361a1dc4db81d12f600be851c003d1cdf\", \"wm_unittests\": \"63885ce827cbbcd8224a0941fc9aa162fe879446\", \"wtf_unittests\": \"c69a43e182031ad30d83942509faab98429fee42\", \"zlib_unittests\": \"2cb431f00d7ec0ea2efc6e1bcb42f05487ac00a8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_32ded518776cda8cac391977d607693e2958c39df4b87a6f7ec8056ca6add5b1_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61bdd20d7d819d347ba07289798b89353c4febba6899c05d4899596063cb3924_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-east1-d-8-50-xkjg\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603496771635633",
"status": "COMPLETED",
"status_changed_ts": "1603502610209816",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20984",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a4867eda65c79eccc99099a15f4180c4448b2ea7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a4867eda65c79eccc99099a15f4180c4448b2ea7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031035637192976960",
"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/8865605575093108000/+/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:4f70ab3c11011210",
"user_agent:luci-scheduler"
],
"updated_ts": "1603502610270898",
"url": "https://ci.chromium.org/b/8865605575093108000",
"utcnow_ts": "1603502612035609"
}
}
[01:23:32.046] Invocation finished in 1h38m47.578842018s with status SUCCEEDED