[03:28:23.398] New invocation is queued and will start shortly
[03:28:24.637] Starting the invocation (attempt 1)
[03:28:24.672] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:28:24.672] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:28:24.672] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030840372509504032",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"791b3e31b293fd5c42de28ce57aa3bab55ad961b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9030840372509504032",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/791b3e31b293fd5c42de28ce57aa3bab55ad961b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/791b3e31b293fd5c42de28ce57aa3bab55ad961b",
"gitiles_ref:refs/heads/master"
]
}
[03:28:25.961] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603682904826005",
"id": "8865410310347534080",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"791b3e31b293fd5c42de28ce57aa3bab55ad961b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603682905622040",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21008",
"builder:linux-chromeos-dbg",
"buildset:commit/git/791b3e31b293fd5c42de28ce57aa3bab55ad961b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/791b3e31b293fd5c42de28ce57aa3bab55ad961b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030840372509504032",
"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/8865410310347534080/+/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": "1603682905622198",
"url": "https://ci.chromium.org/b/8865410310347534080",
"utcnow_ts": "1603682905938059"
}
}
[03:28:25.961] Task URL: https://ci.chromium.org/b/8865410310347534080
[03:28:25.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:2:0) after 1m0s
[03:29:25.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:2:0)
[03:29:25.988] Timer tick, asking Buildbucket for the build status
[03:29:26.092] Build 8865410310347534080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:26.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:3:0) after 1m0s
[03:30:26.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:3:0)
[03:30:26.513] Timer tick, asking Buildbucket for the build status
[03:30:26.586] Build 8865410310347534080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:26.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:4:0) after 1m0s
[03:31:26.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:4:0)
[03:31:26.776] Timer tick, asking Buildbucket for the build status
[03:31:26.865] Build 8865410310347534080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:26.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:5:0) after 1m0s
[03:32:26.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:5:0)
[03:32:26.982] Timer tick, asking Buildbucket for the build status
[03:32:27.085] Build 8865410310347534080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:27.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:6:0) after 1m0s
[03:33:03.398] Received PubSub notification, asking Buildbucket for the build status
[03:33:03.650] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:27.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:6:0)
[03:33:27.231] Timer tick, asking Buildbucket for the build status
[03:33:27.369] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:27.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:8:0) after 1m0s
[03:34:27.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:8:0)
[03:34:27.377] Timer tick, asking Buildbucket for the build status
[03:34:27.546] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:27.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:9:0) after 1m0s
[03:35:27.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:9:0)
[03:35:27.539] Timer tick, asking Buildbucket for the build status
[03:35:27.811] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:27.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:10:0) after 1m0s
[03:36:27.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:10:0)
[03:36:27.902] Timer tick, asking Buildbucket for the build status
[03:36:27.963] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:27.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:11:0) after 1m0s
[03:37:28.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:11:0)
[03:37:28.086] Timer tick, asking Buildbucket for the build status
[03:37:28.146] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:28.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:12:0) after 1m0s
[03:38:28.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:12:0)
[03:38:28.186] Timer tick, asking Buildbucket for the build status
[03:38:28.307] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:28.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:13:0) after 1m0s
[03:39:28.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:13:0)
[03:39:28.480] Timer tick, asking Buildbucket for the build status
[03:39:28.687] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:28.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:14:0) after 1m0s
[03:40:28.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:14:0)
[03:40:28.768] Timer tick, asking Buildbucket for the build status
[03:40:28.835] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:28.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:15:0) after 1m0s
[03:41:28.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:15:0)
[03:41:28.961] Timer tick, asking Buildbucket for the build status
[03:41:29.183] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:29.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:16:0) after 1m0s
[03:42:29.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:16:0)
[03:42:29.202] Timer tick, asking Buildbucket for the build status
[03:42:29.303] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:29.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:17:0) after 1m0s
[03:43:29.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:17:0)
[03:43:29.394] Timer tick, asking Buildbucket for the build status
[03:43:29.494] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:29.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:18:0) after 1m0s
[03:44:29.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:18:0)
[03:44:29.593] Timer tick, asking Buildbucket for the build status
[03:44:29.652] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:29.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:19:0) after 1m0s
[03:45:29.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:19:0)
[03:45:29.670] Timer tick, asking Buildbucket for the build status
[03:45:29.734] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:29.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:20:0) after 1m0s
[03:46:29.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:20:0)
[03:46:29.793] Timer tick, asking Buildbucket for the build status
[03:46:30.635] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:30.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:21:0) after 1m0s
[03:47:30.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:21:0)
[03:47:30.707] Timer tick, asking Buildbucket for the build status
[03:47:30.828] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:30.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:22:0) after 1m0s
[03:48:30.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:22:0)
[03:48:30.929] Timer tick, asking Buildbucket for the build status
[03:48:31.410] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:31.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:23:0) after 1m0s
[03:49:31.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:23:0)
[03:49:31.405] Timer tick, asking Buildbucket for the build status
[03:49:31.514] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:31.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:24:0) after 1m0s
[03:50:31.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:24:0)
[03:50:31.564] Timer tick, asking Buildbucket for the build status
[03:50:31.617] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:31.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:25:0) after 1m0s
[03:51:31.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:25:0)
[03:51:31.638] Timer tick, asking Buildbucket for the build status
[03:51:31.707] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:31.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:26:0) after 1m0s
[03:52:31.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:26:0)
[03:52:31.728] Timer tick, asking Buildbucket for the build status
[03:52:31.799] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:31.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:27:0) after 1m0s
[03:53:31.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:27:0)
[03:53:31.860] Timer tick, asking Buildbucket for the build status
[03:53:31.949] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:31.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:28:0) after 1m0s
[03:54:31.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:28:0)
[03:54:31.973] Timer tick, asking Buildbucket for the build status
[03:54:32.268] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:32.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:29:0) after 1m0s
[03:55:32.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:29:0)
[03:55:32.371] Timer tick, asking Buildbucket for the build status
[03:55:32.450] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:32.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:30:0) after 1m0s
[03:56:32.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:30:0)
[03:56:32.427] Timer tick, asking Buildbucket for the build status
[03:56:32.511] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:32.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:31:0) after 1m0s
[03:57:32.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:31:0)
[03:57:32.535] Timer tick, asking Buildbucket for the build status
[03:57:32.665] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:32.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:32:0) after 1m0s
[03:58:32.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:32:0)
[03:58:32.685] Timer tick, asking Buildbucket for the build status
[03:58:32.788] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:32.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:33:0) after 1m0s
[03:59:32.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:33:0)
[03:59:32.866] Timer tick, asking Buildbucket for the build status
[03:59:32.947] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:32.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:34:0) after 1m0s
[04:00:32.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:34:0)
[04:00:32.993] Timer tick, asking Buildbucket for the build status
[04:00:33.285] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:33.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:35:0) after 1m0s
[04:01:33.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:35:0)
[04:01:33.311] Timer tick, asking Buildbucket for the build status
[04:01:33.390] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:33.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:36:0) after 1m0s
[04:02:33.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:36:0)
[04:02:33.458] Timer tick, asking Buildbucket for the build status
[04:02:33.607] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:33.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:37:0) after 1m0s
[04:03:33.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:37:0)
[04:03:33.766] Timer tick, asking Buildbucket for the build status
[04:03:34.067] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:34.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:38:0) after 1m0s
[04:04:34.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:38:0)
[04:04:34.159] Timer tick, asking Buildbucket for the build status
[04:04:34.224] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:34.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:39:0) after 1m0s
[04:05:34.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:39:0)
[04:05:34.259] Timer tick, asking Buildbucket for the build status
[04:05:34.337] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:34.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:40:0) after 1m0s
[04:06:34.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:40:0)
[04:06:34.451] Timer tick, asking Buildbucket for the build status
[04:06:34.508] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:34.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:41:0) after 1m0s
[04:07:34.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:41:0)
[04:07:34.573] Timer tick, asking Buildbucket for the build status
[04:07:34.695] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:34.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:42:0) after 1m0s
[04:08:34.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:42:0)
[04:08:34.709] Timer tick, asking Buildbucket for the build status
[04:08:35.308] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:35.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:43:0) after 1m0s
[04:09:35.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:43:0)
[04:09:35.465] Timer tick, asking Buildbucket for the build status
[04:09:35.814] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:35.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:44:0) after 1m0s
[04:10:35.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:44:0)
[04:10:35.843] Timer tick, asking Buildbucket for the build status
[04:10:35.901] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:35.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:45:0) after 1m0s
[04:11:36.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:45:0)
[04:11:36.001] Timer tick, asking Buildbucket for the build status
[04:11:36.064] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:36.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:46:0) after 1m0s
[04:12:36.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:46:0)
[04:12:36.127] Timer tick, asking Buildbucket for the build status
[04:12:36.237] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:36.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:47:0) after 1m0s
[04:13:36.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:47:0)
[04:13:36.234] Timer tick, asking Buildbucket for the build status
[04:13:36.365] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:36.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:48:0) after 1m0s
[04:14:36.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:48:0)
[04:14:36.378] Timer tick, asking Buildbucket for the build status
[04:14:36.450] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:36.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:49:0) after 1m0s
[04:15:36.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:49:0)
[04:15:36.471] Timer tick, asking Buildbucket for the build status
[04:15:36.547] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:36.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:50:0) after 1m0s
[04:16:36.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:50:0)
[04:16:36.571] Timer tick, asking Buildbucket for the build status
[04:16:36.645] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:36.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:51:0) after 1m0s
[04:17:36.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:51:0)
[04:17:36.841] Timer tick, asking Buildbucket for the build status
[04:17:36.933] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:36.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:52:0) after 1m0s
[04:18:37.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:52:0)
[04:18:37.195] Timer tick, asking Buildbucket for the build status
[04:18:37.336] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:37.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:53:0) after 1m0s
[04:19:37.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:53:0)
[04:19:37.414] Timer tick, asking Buildbucket for the build status
[04:19:37.476] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:37.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:54:0) after 1m0s
[04:20:37.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:54:0)
[04:20:37.510] Timer tick, asking Buildbucket for the build status
[04:20:37.614] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:37.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:55:0) after 1m0s
[04:21:37.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:55:0)
[04:21:37.670] Timer tick, asking Buildbucket for the build status
[04:21:37.764] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:37.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:56:0) after 1m0s
[04:22:37.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:56:0)
[04:22:37.881] Timer tick, asking Buildbucket for the build status
[04:22:37.953] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:37.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:57:0) after 1m0s
[04:23:38.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:57:0)
[04:23:38.070] Timer tick, asking Buildbucket for the build status
[04:23:38.236] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:38.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:58:0) after 1m0s
[04:24:38.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:58:0)
[04:24:38.348] Timer tick, asking Buildbucket for the build status
[04:24:38.409] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:38.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:59:0) after 1m0s
[04:25:38.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:59:0)
[04:25:38.434] Timer tick, asking Buildbucket for the build status
[04:25:38.557] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:38.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:60:0) after 1m0s
[04:26:38.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:60:0)
[04:26:38.664] Timer tick, asking Buildbucket for the build status
[04:26:38.779] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:38.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:61:0) after 1m0s
[04:27:38.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:61:0)
[04:27:38.931] Timer tick, asking Buildbucket for the build status
[04:27:38.999] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:38.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:62:0) after 1m0s
[04:28:39.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:62:0)
[04:28:39.052] Timer tick, asking Buildbucket for the build status
[04:28:39.171] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:39.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:63:0) after 1m0s
[04:29:39.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:63:0)
[04:29:39.208] Timer tick, asking Buildbucket for the build status
[04:29:39.265] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:39.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:64:0) after 1m0s
[04:30:39.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:64:0)
[04:30:39.356] Timer tick, asking Buildbucket for the build status
[04:30:39.461] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:39.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:65:0) after 1m0s
[04:31:39.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:65:0)
[04:31:39.555] Timer tick, asking Buildbucket for the build status
[04:31:39.735] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:39.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:66:0) after 1m0s
[04:32:39.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:66:0)
[04:32:39.828] Timer tick, asking Buildbucket for the build status
[04:32:39.989] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:39.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:67:0) after 1m0s
[04:33:40.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:67:0)
[04:33:40.017] Timer tick, asking Buildbucket for the build status
[04:33:40.176] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:40.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:68:0) after 1m0s
[04:34:40.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:68:0)
[04:34:40.203] Timer tick, asking Buildbucket for the build status
[04:34:40.325] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:40.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:69:0) after 1m0s
[04:35:40.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:69:0)
[04:35:40.382] Timer tick, asking Buildbucket for the build status
[04:35:40.668] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:40.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:70:0) after 1m0s
[04:36:40.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:70:0)
[04:36:40.774] Timer tick, asking Buildbucket for the build status
[04:36:40.923] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:40.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:71:0) after 1m0s
[04:37:41.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:71:0)
[04:37:41.007] Timer tick, asking Buildbucket for the build status
[04:37:41.222] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:41.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:72:0) after 1m0s
[04:38:41.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:72:0)
[04:38:41.712] Timer tick, asking Buildbucket for the build status
[04:38:42.388] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:42.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:73:0) after 1m0s
[04:39:42.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:73:0)
[04:39:42.537] Timer tick, asking Buildbucket for the build status
[04:39:42.617] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:42.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:74:0) after 1m0s
[04:40:42.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:74:0)
[04:40:42.739] Timer tick, asking Buildbucket for the build status
[04:40:42.827] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:42.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:75:0) after 1m0s
[04:41:42.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:75:0)
[04:41:42.897] Timer tick, asking Buildbucket for the build status
[04:41:42.963] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:42.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:76:0) after 1m0s
[04:42:42.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:76:0)
[04:42:42.953] Timer tick, asking Buildbucket for the build status
[04:42:43.067] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:43.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:77:0) after 1m0s
[04:43:43.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:77:0)
[04:43:43.209] Timer tick, asking Buildbucket for the build status
[04:43:43.322] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:43.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:78:0) after 1m0s
[04:44:43.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:78:0)
[04:44:43.416] Timer tick, asking Buildbucket for the build status
[04:44:43.504] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:43.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:79:0) after 1m0s
[04:45:43.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:79:0)
[04:45:43.530] Timer tick, asking Buildbucket for the build status
[04:45:43.605] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:43.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:80:0) after 1m0s
[04:46:43.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:80:0)
[04:46:43.640] Timer tick, asking Buildbucket for the build status
[04:46:43.723] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:43.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:81:0) after 1m0s
[04:47:43.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:81:0)
[04:47:43.725] Timer tick, asking Buildbucket for the build status
[04:47:43.797] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:43.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:82:0) after 1m0s
[04:48:43.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:82:0)
[04:48:43.824] Timer tick, asking Buildbucket for the build status
[04:48:43.980] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:43.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:83:0) after 1m0s
[04:49:44.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:83:0)
[04:49:44.040] Timer tick, asking Buildbucket for the build status
[04:49:44.166] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:44.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:84:0) after 1m0s
[04:50:44.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:84:0)
[04:50:44.208] Timer tick, asking Buildbucket for the build status
[04:50:44.411] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:44.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:85:0) after 1m0s
[04:51:44.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:85:0)
[04:51:44.437] Timer tick, asking Buildbucket for the build status
[04:51:44.509] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:44.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:86:0) after 1m0s
[04:52:44.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:86:0)
[04:52:44.499] Timer tick, asking Buildbucket for the build status
[04:52:44.585] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:44.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:87:0) after 1m0s
[04:53:44.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:87:0)
[04:53:44.695] Timer tick, asking Buildbucket for the build status
[04:53:44.986] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:44.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:88:0) after 1m0s
[04:54:45.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:88:0)
[04:54:45.029] Timer tick, asking Buildbucket for the build status
[04:54:45.299] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:45.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:89:0) after 1m0s
[04:55:45.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:89:0)
[04:55:45.322] Timer tick, asking Buildbucket for the build status
[04:55:45.389] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:45.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:90:0) after 1m0s
[04:56:45.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:90:0)
[04:56:45.453] Timer tick, asking Buildbucket for the build status
[04:56:45.525] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:45.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:91:0) after 1m0s
[04:57:45.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:91:0)
[04:57:45.574] Timer tick, asking Buildbucket for the build status
[04:57:45.669] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:45.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:92:0) after 1m0s
[04:58:45.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:92:0)
[04:58:45.823] Timer tick, asking Buildbucket for the build status
[04:58:45.999] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:45.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:93:0) after 1m0s
[04:59:46.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:93:0)
[04:59:46.037] Timer tick, asking Buildbucket for the build status
[04:59:46.115] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:46.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:94:0) after 1m0s
[05:00:46.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:94:0)
[05:00:46.392] Timer tick, asking Buildbucket for the build status
[05:00:46.525] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:46.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:95:0) after 1m0s
[05:01:46.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:95:0)
[05:01:46.599] Timer tick, asking Buildbucket for the build status
[05:01:46.668] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:46.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:96:0) after 1m0s
[05:02:46.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:96:0)
[05:02:46.748] Timer tick, asking Buildbucket for the build status
[05:02:46.842] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:46.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:97:0) after 1m0s
[05:03:46.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:97:0)
[05:03:46.902] Timer tick, asking Buildbucket for the build status
[05:03:49.097] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:49.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:98:0) after 1m0s
[05:04:49.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:98:0)
[05:04:49.072] Timer tick, asking Buildbucket for the build status
[05:04:49.302] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:49.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:99:0) after 1m0s
[05:05:49.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:99:0)
[05:05:49.281] Timer tick, asking Buildbucket for the build status
[05:05:49.386] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:49.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:100:0) after 1m0s
[05:06:49.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:100:0)
[05:06:49.443] Timer tick, asking Buildbucket for the build status
[05:06:49.523] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:49.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:101:0) after 1m0s
[05:07:49.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:101:0)
[05:07:49.577] Timer tick, asking Buildbucket for the build status
[05:07:49.644] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:49.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:102:0) after 1m0s
[05:08:49.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:102:0)
[05:08:49.700] Timer tick, asking Buildbucket for the build status
[05:08:49.797] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:49.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:103:0) after 1m0s
[05:09:49.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:103:0)
[05:09:49.852] Timer tick, asking Buildbucket for the build status
[05:09:49.924] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:49.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:104:0) after 1m0s
[05:10:50.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:104:0)
[05:10:50.023] Timer tick, asking Buildbucket for the build status
[05:10:50.094] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:50.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:105:0) after 1m0s
[05:11:50.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:105:0)
[05:11:50.097] Timer tick, asking Buildbucket for the build status
[05:11:50.324] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:50.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:106:0) after 1m0s
[05:12:50.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:106:0)
[05:12:50.392] Timer tick, asking Buildbucket for the build status
[05:12:50.472] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:50.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:107:0) after 1m0s
[05:13:50.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:107:0)
[05:13:50.557] Timer tick, asking Buildbucket for the build status
[05:13:51.856] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:51.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:108:0) after 1m0s
[05:14:51.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:108:0)
[05:14:51.877] Timer tick, asking Buildbucket for the build status
[05:14:51.955] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:51.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:109:0) after 1m0s
[05:15:51.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:109:0)
[05:15:51.981] Timer tick, asking Buildbucket for the build status
[05:15:52.060] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:52.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:110:0) after 1m0s
[05:16:52.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:110:0)
[05:16:52.150] Timer tick, asking Buildbucket for the build status
[05:16:52.221] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:52.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:111:0) after 1m0s
[05:17:52.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:111:0)
[05:17:52.242] Timer tick, asking Buildbucket for the build status
[05:17:52.313] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:52.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:112:0) after 1m0s
[05:18:52.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:112:0)
[05:18:52.343] Timer tick, asking Buildbucket for the build status
[05:18:52.537] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:52.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:113:0) after 1m0s
[05:19:53.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:113:0)
[05:19:53.542] Timer tick, asking Buildbucket for the build status
[05:19:53.655] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:53.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:114:0) after 1m0s
[05:20:53.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:114:0)
[05:20:53.713] Timer tick, asking Buildbucket for the build status
[05:20:53.799] Build 8865410310347534080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:53.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030840372509504032:115:0) after 1m0s
[05:21:42.185] Received PubSub notification, asking Buildbucket for the build status
[05:21:42.251] Build 8865410310347534080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:21:42.251] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603689687897229",
"created_by": "project:chromium",
"created_ts": "1603682904826005",
"id": "8865410310347534080",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"791b3e31b293fd5c42de28ce57aa3bab55ad961b\"}}",
"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\": \"791b3e31b293fd5c42de28ce57aa3bab55ad961b\", \"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-70-a1u5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21008, \"got_angle_revision\": \"258f17d68700647257de01141abcef15c8b6f02e\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"791b3e31b293fd5c42de28ce57aa3bab55ad961b\", \"got_revision_cp\": \"refs/heads/master@{#820663}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"e6fa238f76e50a8caa0547074f75443bbfd7b986\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32482}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"791b3e31b293fd5c42de28ce57aa3bab55ad961b\", \"swarm_hashes_refs/heads/master(at){#820663}_without_patch\": {\"absl_hardening_tests\": \"f6275dec2dacded5d9ee837fe36a24a0aa8490c2\", \"accessibility_unittests\": \"fbf30573b0f37fbdf03b825b2bf5b67e5b3401c2\", \"angle_unittests\": \"4f2ad51c66ebae619af57c8ef746f605ccef2989\", \"app_list_unittests\": \"c2645f12ed96196586d43593657e86d5da9769f5\", \"app_shell_unittests\": \"a43c1d638152a209883cf69a6b68ae32b17a704f\", \"ash_unittests\": \"277689ce03c60c32887c89d6c7cefb118aa93153\", \"aura_unittests\": \"dd89d924446a4a90bd106a0cec1163c57a5ad69b\", \"base_unittests\": \"3584044ba4049630cd4d380d1a3af753d6371ebb\", \"base_util_unittests\": \"aac33318663856f4ab10d68727ac0c27b11b2b61\", \"blink_common_unittests\": \"c65e87dedebe3aafdd6992773b0777c47f2d6497\", \"blink_fuzzer_unittests\": \"ffd2a6ef64a5bf7ff77e8796ecd107ca5b628e71\", \"blink_heap_unittests\": \"58ab713753f6641a9efcfcad1e59464be977fc6c\", \"blink_platform_unittests\": \"1b1e9058d209588ec8a32b2e7e6ef34dfacd625e\", \"blink_unittests\": \"bfa15d68b09c5af282cafc3cc7209ff139419775\", \"boringssl_crypto_tests\": \"17868b4b43926c198d545d976063cd8be109a6f8\", \"boringssl_ssl_tests\": \"d65aea41d5a09907af5fca653544c442110ce221\", \"browser_tests\": \"7b02e10b455f2925ab374c026823f894f001df5d\", \"capture_unittests\": \"13d147a729559097bf599e3e7855096e6d56884f\", \"cast_unittests\": \"6d37f4a57923f624d847690f781abbd0abc23bc8\", \"cc_unittests\": \"8c665952aaf2205a8a56d1b50214d0bba3ac977e\", \"chrome_app_unittests\": \"565259dfc10258223fa2e67fe8b99472d89e6038\", \"chromedriver_unittests\": \"c112d1e3b4c2628a81b5f9fec8669e5cc3e1567f\", \"chromeos_components_unittests\": \"8d97c3162a8a30b4c72956271775353ab440a478\", \"chromeos_unittests\": \"b05546e6bdd6d894dd1a8ccecad11e95792a2407\", \"components_browsertests\": \"ac57e4bf69d30a53ecd3c31f2c80593cd492d01e\", \"components_unittests\": \"96c8b7d41abd191d5cf568d140b7dd9f50e17886\", \"compositor_unittests\": \"5a97fb02cb681d1314ecae399b651e2161a2ade5\", \"content_browsertests\": \"83c2925b8454144971c7d72637c90edde8a85cad\", \"content_unittests\": \"19c0e3e9ac71c3ee487f9ae4b641c63419fa80a1\", \"crypto_unittests\": \"5946dd28f08ff50e6a02e75cd4bdac71dd7c700b\", \"dbus_unittests\": \"62733c368f73087114978804217fd163091b6e2f\", \"device_unittests\": \"521ff65dd854135b975412ab9e7342f6481c4638\", \"display_unittests\": \"1db329b075f7c8e7e51900966220a46a7d0b0316\", \"events_unittests\": \"f84fea379337fcdef054ada6b7e46f3a394dc390\", \"exo_unittests\": \"ff0d9bfa6cb80eb2010f22f17954491d8a4466f5\", \"extensions_browsertests\": \"54c1406d03643569e29369bbfc132ada36ee5918\", \"extensions_unittests\": \"388d037733ffff90012fa36373c7cd188ee90254\", \"filesystem_service_unittests\": \"620ae2e793eec7a2443e9fb704fc8a29769c6e02\", \"gcm_unit_tests\": \"f7f0fe4287fd58e90c210eb3e2b194e3aac755b2\", \"gfx_unittests\": \"a6ccd22a4a6b2d4de252b26d831a0eb565eeba4b\", \"gin_unittests\": \"fd4a9833b5f29d9926b0e87977294e5e985b9418\", \"gl_unittests_ozone\": \"1b19702542bb3d82513900508bb8d353f0f80fe9\", \"google_apis_unittests\": \"ca78a6d33f695600ccdf0f460e793cda8ea6b256\", \"gpu_unittests\": \"b715afff6cea57332bed8f2d1d486cc70f316899\", \"gwp_asan_unittests\": \"a7700d06047afeb3cf97ceed048d47ff921672b1\", \"interactive_ui_tests\": \"fa61f2a7b16b7a18e96a8b34675a37f325da2dc2\", \"ipc_tests\": \"f48a403ec77cad9a9c65d6a36b180d69ef956b0a\", \"jingle_unittests\": \"e6d4df4dba290f86102ba98eb71dfe2779588676\", \"keyboard_unittests\": \"557d21b8f4c903861f13598d186a1aecc8f6fc2c\", \"latency_unittests\": \"2d5bedfa5c961fab923d322d6ae97bd1f1fa6a3d\", \"libjingle_xmpp_unittests\": \"915f2338d996c412e9c2d47d4653392049ba48da\", \"media_blink_unittests\": \"5228270b66f2723facba26ba82f8350aafbe3cc4\", \"media_unittests\": \"f3e62cecdc88377908c3206d7c150cffa113e45d\", \"message_center_unittests\": \"31460dfe6aa91faeabaa646487e45b967040d659\", \"midi_unittests\": \"cb85e2b9d251793f6924519282ca49b88615566b\", \"mojo_core_unittests\": \"afdf4cba6ee12f7d77dec5463d55b88c53154737\", \"mojo_unittests\": \"04df33cd5095bb7cc9015cacc92fdcb4a83a0bdd\", \"nacl_helper_nonsfi_unittests\": \"6ffcf8ff2adb2fe1c3cd9971c49978b1e2befd07\", \"nacl_loader_unittests\": \"ad27e734973545cbdb31426f25c3ce9491be94a5\", \"native_theme_unittests\": \"1f14002270d3919dcedf20a2639d884068905707\", \"net_unittests\": \"9e2f3365073050d69ea0fcf0b8af6a6441e915ca\", \"ozone_gl_unittests\": \"9ed9f0b067a29858a9b10360f8527205eba27a3f\", \"ozone_unittests\": \"716e2e927077623088eb4d9d8decad0d6bd72d3b\", \"ozone_x11_unittests\": \"2835e071e3efe5fe14af45518a5d3b9c117de129\", \"pdf_unittests\": \"34f7bf72c4c28236e8b9ec14323ae3518f1ea499\", \"perfetto_unittests\": \"db7c4a0a544e22e624adee435048e15b506139dc\", \"ppapi_unittests\": \"9ad98ffb0f845ffae90825c5ba6cce5d5b2fb3f3\", \"printing_unittests\": \"a9b97fbeb7975caebe03c97bd36c09719ab9c2b3\", \"remoting_unittests\": \"31f55eba85e91a3133e1ed688564db509504ce1d\", \"sandbox_linux_unittests\": \"610455c349614b20f3065cf61b52b00fa81e52c3\", \"service_manager_unittests\": \"0d861266ce72c3daa6c13edf1a7516092fca9272\", \"services_unittests\": \"c4540a7677c6da0bf46ec30cedb9e791f6807296\", \"shell_dialogs_unittests\": \"fb0917260c42513ea1b8525d2f4de8c0368a8eab\", \"skia_unittests\": \"12e9544ecad26a0e8a3b13bd7a9e8bb5526fec2d\", \"snapshot_unittests\": \"badf9b6cb75ddfd4a5ff86da94a56e7184dd1ef1\", \"sql_unittests\": \"642cd23413d0c6890d8859edce2618bfb3dbf309\", \"storage_unittests\": \"5793242eb4d79cc61ffb1c2132f0a16a1666af21\", \"sync_integration_tests\": \"90a9cd9fa9f6b92114e04d630683929f91154473\", \"traffic_annotation_auditor_unittests\": \"97982e9667a55cb4fec635a03cd9bd97ca1e41af\", \"ui_base_unittests\": \"728d440d51c85afe00af7d23a9a3512fa0fa650d\", \"ui_chromeos_unittests\": \"34c5a511f8af199241f850ea3e3ef989a5ab67e5\", \"ui_touch_selection_unittests\": \"88d3595113549d27c0b1a1981a0a0185c513f54b\", \"unit_tests\": \"20f258823e3b7e695f312daed7882165f7030764\", \"url_unittests\": \"b6714e0e7170b5378e4b2f5cdc0805a471e5611e\", \"usage_time_limit_unittests\": \"48e7e1d5bd4ad3f8b979c98f9c604204cd764cad\", \"views_unittests\": \"6d133cad2508d5ea39464815760d230ac6f45256\", \"viz_unittests\": \"df1bdf80b7416c5a61843bde23047f813d9a752b\", \"wm_unittests\": \"33eb7926d16cd5b96491b0239c205d5f108f4dd5\", \"wtf_unittests\": \"9469230adec57c0f0067d3df2e4810f979efbe9d\", \"zlib_unittests\": \"80709a1805799f062d08d6beaec755b659e8418d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-70-a1u5\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603683182122086",
"status": "COMPLETED",
"status_changed_ts": "1603689688421954",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21008",
"builder:linux-chromeos-dbg",
"buildset:commit/git/791b3e31b293fd5c42de28ce57aa3bab55ad961b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/791b3e31b293fd5c42de28ce57aa3bab55ad961b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030840372509504032",
"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/8865410310347534080/+/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:4f7bc4b733a68110",
"user_agent:luci-scheduler"
],
"updated_ts": "1603689688428627",
"url": "https://ci.chromium.org/b/8865410310347534080",
"utcnow_ts": "1603689702243205"
}
}
[05:21:42.251] Invocation finished in 1h53m18.870593318s with status SUCCEEDED