[12:41:18.446] New invocation is queued and will start shortly
[12:41:19.589] Starting the invocation (attempt 1)
[12:41:19.624] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:41:19.624] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:41:19.624] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023739022569535168",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2261c4e1a7c4126457be87813944eb77ae93382f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023739022569535168",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/2261c4e1a7c4126457be87813944eb77ae93382f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2261c4e1a7c4126457be87813944eb77ae93382f",
"gitiles_ref:refs/heads/master"
]
}
[12:41:20.312] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610455279716370",
"id": "8858308960574363408",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2261c4e1a7c4126457be87813944eb77ae93382f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610455280151694",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22166",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2261c4e1a7c4126457be87813944eb77ae93382f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2261c4e1a7c4126457be87813944eb77ae93382f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023739022569535168",
"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/8858308960574363408/+/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": "1610455280151814",
"url": "https://ci.chromium.org/b/8858308960574363408",
"utcnow_ts": "1610455280301780"
}
}
[12:41:20.312] Task URL: https://ci.chromium.org/b/8858308960574363408
[12:41:20.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:2:0) after 1m0s
[12:42:09.412] Received PubSub notification, asking Buildbucket for the build status
[12:42:09.500] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:20.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:2:0)
[12:42:20.502] Timer tick, asking Buildbucket for the build status
[12:42:20.560] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:20.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:4:0) after 1m0s
[12:43:20.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:4:0)
[12:43:20.734] Timer tick, asking Buildbucket for the build status
[12:43:20.883] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:20.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:5:0) after 1m0s
[12:44:20.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:5:0)
[12:44:20.920] Timer tick, asking Buildbucket for the build status
[12:44:21.018] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:21.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:6:0) after 1m0s
[12:45:21.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:6:0)
[12:45:21.084] Timer tick, asking Buildbucket for the build status
[12:45:21.227] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:21.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:7:0) after 1m0s
[12:46:21.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:7:0)
[12:46:21.301] Timer tick, asking Buildbucket for the build status
[12:46:21.399] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:21.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:8:0) after 1m0s
[12:47:21.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:8:0)
[12:47:21.486] Timer tick, asking Buildbucket for the build status
[12:47:21.568] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:21.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:9:0) after 1m0s
[12:48:21.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:9:0)
[12:48:21.717] Timer tick, asking Buildbucket for the build status
[12:48:22.051] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:22.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:10:0) after 1m0s
[12:49:22.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:10:0)
[12:49:22.093] Timer tick, asking Buildbucket for the build status
[12:49:22.153] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:22.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:11:0) after 1m0s
[12:50:22.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:11:0)
[12:50:22.328] Timer tick, asking Buildbucket for the build status
[12:50:22.390] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:22.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:12:0) after 1m0s
[12:51:22.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:12:0)
[12:51:22.452] Timer tick, asking Buildbucket for the build status
[12:51:22.745] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:22.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:13:0) after 1m0s
[12:52:22.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:13:0)
[12:52:22.888] Timer tick, asking Buildbucket for the build status
[12:52:22.954] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:22.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:14:0) after 1m0s
[12:53:23.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:14:0)
[12:53:23.149] Timer tick, asking Buildbucket for the build status
[12:53:23.222] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:23.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:15:0) after 1m0s
[12:54:23.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:15:0)
[12:54:23.341] Timer tick, asking Buildbucket for the build status
[12:54:23.402] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:23.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:16:0) after 1m0s
[12:55:23.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:16:0)
[12:55:23.500] Timer tick, asking Buildbucket for the build status
[12:55:23.576] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:23.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:17:0) after 1m0s
[12:56:23.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:17:0)
[12:56:23.639] Timer tick, asking Buildbucket for the build status
[12:56:23.746] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:23.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:18:0) after 1m0s
[12:57:23.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:18:0)
[12:57:23.771] Timer tick, asking Buildbucket for the build status
[12:57:23.845] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:23.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:19:0) after 1m0s
[12:58:23.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:19:0)
[12:58:23.929] Timer tick, asking Buildbucket for the build status
[12:58:24.134] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:24.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:20:0) after 1m0s
[12:59:24.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:20:0)
[12:59:24.280] Timer tick, asking Buildbucket for the build status
[12:59:24.342] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:24.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:21:0) after 1m0s
[13:00:24.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:21:0)
[13:00:24.380] Timer tick, asking Buildbucket for the build status
[13:00:24.620] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:24.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:22:0) after 1m0s
[13:01:24.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:22:0)
[13:01:24.627] Timer tick, asking Buildbucket for the build status
[13:01:24.854] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:24.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:23:0) after 1m0s
[13:02:24.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:23:0)
[13:02:24.983] Timer tick, asking Buildbucket for the build status
[13:02:25.337] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:25.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:24:0) after 1m0s
[13:03:25.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:24:0)
[13:03:25.454] Timer tick, asking Buildbucket for the build status
[13:03:25.564] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:25.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:25:0) after 1m0s
[13:04:25.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:25:0)
[13:04:25.619] Timer tick, asking Buildbucket for the build status
[13:04:25.733] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:25.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:26:0) after 1m0s
[13:05:25.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:26:0)
[13:05:25.781] Timer tick, asking Buildbucket for the build status
[13:05:25.896] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:25.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:27:0) after 1m0s
[13:06:25.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:27:0)
[13:06:25.955] Timer tick, asking Buildbucket for the build status
[13:06:26.148] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:26.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:28:0) after 1m0s
[13:07:26.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:28:0)
[13:07:26.248] Timer tick, asking Buildbucket for the build status
[13:07:26.547] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:26.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:29:0) after 1m0s
[13:08:44.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:29:0)
[13:08:44.322] Timer tick, asking Buildbucket for the build status
[13:08:44.438] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:44.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:30:0) after 1m0s
[13:09:44.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:30:0)
[13:09:44.513] Timer tick, asking Buildbucket for the build status
[13:09:44.609] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:44.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:31:0) after 1m0s
[13:10:44.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:31:0)
[13:10:44.640] Timer tick, asking Buildbucket for the build status
[13:10:44.747] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:44.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:32:0) after 1m0s
[13:11:44.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:32:0)
[13:11:44.900] Timer tick, asking Buildbucket for the build status
[13:11:45.087] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:45.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:33:0) after 1m0s
[13:12:45.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:33:0)
[13:12:45.145] Timer tick, asking Buildbucket for the build status
[13:12:45.275] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:45.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:34:0) after 1m0s
[13:13:45.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:34:0)
[13:13:45.355] Timer tick, asking Buildbucket for the build status
[13:13:45.469] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:45.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:35:0) after 1m0s
[13:14:45.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:35:0)
[13:14:45.489] Timer tick, asking Buildbucket for the build status
[13:14:45.602] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:45.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:36:0) after 1m0s
[13:15:45.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:36:0)
[13:15:45.703] Timer tick, asking Buildbucket for the build status
[13:15:45.824] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:45.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:37:0) after 1m0s
[13:16:45.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:37:0)
[13:16:45.938] Timer tick, asking Buildbucket for the build status
[13:16:46.093] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:46.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:38:0) after 1m0s
[13:17:46.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:38:0)
[13:17:46.123] Timer tick, asking Buildbucket for the build status
[13:17:46.377] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:46.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:39:0) after 1m0s
[13:18:46.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:39:0)
[13:18:46.427] Timer tick, asking Buildbucket for the build status
[13:18:46.540] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:46.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:40:0) after 1m0s
[13:19:46.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:40:0)
[13:19:46.586] Timer tick, asking Buildbucket for the build status
[13:19:46.777] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:46.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:41:0) after 1m0s
[13:20:46.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:41:0)
[13:20:46.802] Timer tick, asking Buildbucket for the build status
[13:20:46.946] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:46.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:42:0) after 1m0s
[13:21:46.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:42:0)
[13:21:46.988] Timer tick, asking Buildbucket for the build status
[13:21:47.157] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:47.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:43:0) after 1m0s
[13:22:47.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:43:0)
[13:22:47.221] Timer tick, asking Buildbucket for the build status
[13:22:47.356] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:47.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:44:0) after 1m0s
[13:23:47.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:44:0)
[13:23:47.441] Timer tick, asking Buildbucket for the build status
[13:23:47.602] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:47.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:45:0) after 1m0s
[13:24:47.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:45:0)
[13:24:47.625] Timer tick, asking Buildbucket for the build status
[13:24:49.245] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:49.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:46:0) after 1m0s
[13:25:49.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:46:0)
[13:25:49.238] Timer tick, asking Buildbucket for the build status
[13:25:49.350] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:49.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:47:0) after 1m0s
[13:26:49.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:47:0)
[13:26:49.327] Timer tick, asking Buildbucket for the build status
[13:26:49.478] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:49.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:48:0) after 1m0s
[13:27:49.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:48:0)
[13:27:49.586] Timer tick, asking Buildbucket for the build status
[13:27:50.048] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:50.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:49:0) after 1m0s
[13:28:50.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:49:0)
[13:28:50.105] Timer tick, asking Buildbucket for the build status
[13:28:50.281] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:50.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:50:0) after 1m0s
[13:29:50.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:50:0)
[13:29:50.293] Timer tick, asking Buildbucket for the build status
[13:29:50.464] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:50.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:51:0) after 1m0s
[13:30:50.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:51:0)
[13:30:50.521] Timer tick, asking Buildbucket for the build status
[13:30:50.705] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:50.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:52:0) after 1m0s
[13:31:50.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:52:0)
[13:31:50.777] Timer tick, asking Buildbucket for the build status
[13:31:50.921] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:50.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:53:0) after 1m0s
[13:32:50.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:53:0)
[13:32:50.973] Timer tick, asking Buildbucket for the build status
[13:32:51.123] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:51.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:54:0) after 1m0s
[13:33:51.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:54:0)
[13:33:51.151] Timer tick, asking Buildbucket for the build status
[13:33:51.277] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:51.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:55:0) after 1m0s
[13:34:51.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:55:0)
[13:34:51.334] Timer tick, asking Buildbucket for the build status
[13:34:51.496] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:51.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:56:0) after 1m0s
[13:35:51.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:56:0)
[13:35:51.571] Timer tick, asking Buildbucket for the build status
[13:35:51.838] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:51.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:57:0) after 1m0s
[13:36:51.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:57:0)
[13:36:51.890] Timer tick, asking Buildbucket for the build status
[13:36:52.401] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:52.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:58:0) after 1m0s
[13:37:52.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:58:0)
[13:37:52.442] Timer tick, asking Buildbucket for the build status
[13:37:52.670] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:52.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:59:0) after 1m0s
[13:38:52.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:59:0)
[13:38:52.694] Timer tick, asking Buildbucket for the build status
[13:38:52.816] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:52.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:60:0) after 1m0s
[13:39:52.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:60:0)
[13:39:52.901] Timer tick, asking Buildbucket for the build status
[13:39:53.024] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:53.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:61:0) after 1m0s
[13:40:53.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:61:0)
[13:40:53.203] Timer tick, asking Buildbucket for the build status
[13:40:53.380] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:53.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:62:0) after 1m0s
[13:41:53.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:62:0)
[13:41:53.561] Timer tick, asking Buildbucket for the build status
[13:41:53.838] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:53.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:63:0) after 1m0s
[13:42:53.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:63:0)
[13:42:53.840] Timer tick, asking Buildbucket for the build status
[13:42:53.979] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:53.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:64:0) after 1m0s
[13:43:54.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:64:0)
[13:43:54.083] Timer tick, asking Buildbucket for the build status
[13:43:54.302] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:54.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:65:0) after 1m0s
[13:44:54.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:65:0)
[13:44:54.327] Timer tick, asking Buildbucket for the build status
[13:44:54.431] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:54.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:66:0) after 1m0s
[13:45:54.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:66:0)
[13:45:54.629] Timer tick, asking Buildbucket for the build status
[13:45:54.969] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:54.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:67:0) after 1m0s
[13:46:55.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:67:0)
[13:46:55.040] Timer tick, asking Buildbucket for the build status
[13:46:55.215] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:55.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:68:0) after 1m0s
[13:47:55.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:68:0)
[13:47:55.272] Timer tick, asking Buildbucket for the build status
[13:47:55.405] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:55.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:69:0) after 1m0s
[13:48:55.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:69:0)
[13:48:55.476] Timer tick, asking Buildbucket for the build status
[13:48:56.014] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:56.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:70:0) after 1m0s
[13:49:56.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:70:0)
[13:49:56.112] Timer tick, asking Buildbucket for the build status
[13:49:57.148] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:57.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:71:0) after 1m0s
[13:50:57.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:71:0)
[13:50:57.760] Timer tick, asking Buildbucket for the build status
[13:50:58.335] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:58.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:72:0) after 1m0s
[13:51:58.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:72:0)
[13:51:58.560] Timer tick, asking Buildbucket for the build status
[13:51:58.703] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:58.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:73:0) after 1m0s
[13:52:58.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:73:0)
[13:52:58.806] Timer tick, asking Buildbucket for the build status
[13:52:58.934] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:58.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:74:0) after 1m0s
[13:53:59.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:74:0)
[13:53:59.027] Timer tick, asking Buildbucket for the build status
[13:53:59.185] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:59.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:75:0) after 1m0s
[13:54:59.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:75:0)
[13:54:59.269] Timer tick, asking Buildbucket for the build status
[13:54:59.600] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:59.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:76:0) after 1m0s
[13:55:59.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:76:0)
[13:55:59.645] Timer tick, asking Buildbucket for the build status
[13:55:59.753] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:59.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:77:0) after 1m0s
[13:56:59.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:77:0)
[13:56:59.795] Timer tick, asking Buildbucket for the build status
[13:56:59.911] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:59.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:78:0) after 1m0s
[13:58:00.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:78:0)
[13:58:00.019] Timer tick, asking Buildbucket for the build status
[13:58:00.212] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:00.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:79:0) after 1m0s
[13:59:00.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:79:0)
[13:59:00.275] Timer tick, asking Buildbucket for the build status
[13:59:00.340] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:00.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:80:0) after 1m0s
[14:00:00.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:80:0)
[14:00:00.351] Timer tick, asking Buildbucket for the build status
[14:00:00.431] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:00.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:81:0) after 1m0s
[14:01:00.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:81:0)
[14:01:00.584] Timer tick, asking Buildbucket for the build status
[14:01:01.133] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:01.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:82:0) after 1m0s
[14:02:01.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:82:0)
[14:02:01.944] Timer tick, asking Buildbucket for the build status
[14:02:02.536] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:02.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:83:0) after 1m0s
[14:03:02.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:83:0)
[14:03:02.621] Timer tick, asking Buildbucket for the build status
[14:03:02.722] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:02.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:84:0) after 1m0s
[14:04:03.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:84:0)
[14:04:03.289] Timer tick, asking Buildbucket for the build status
[14:04:03.482] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:03.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:85:0) after 1m0s
[14:05:03.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:85:0)
[14:05:03.815] Timer tick, asking Buildbucket for the build status
[14:05:04.375] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:04.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:86:0) after 1m0s
[14:06:04.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:86:0)
[14:06:04.523] Timer tick, asking Buildbucket for the build status
[14:06:04.800] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:04.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:87:0) after 1m0s
[14:07:05.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:87:0)
[14:07:05.166] Timer tick, asking Buildbucket for the build status
[14:07:05.323] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:05.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:88:0) after 1m0s
[14:08:05.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:88:0)
[14:08:05.427] Timer tick, asking Buildbucket for the build status
[14:08:05.802] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:05.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:89:0) after 1m0s
[14:09:05.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:89:0)
[14:09:05.972] Timer tick, asking Buildbucket for the build status
[14:09:06.098] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:06.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:90:0) after 1m0s
[14:10:06.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:90:0)
[14:10:06.159] Timer tick, asking Buildbucket for the build status
[14:10:06.293] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:06.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:91:0) after 1m0s
[14:11:06.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:91:0)
[14:11:06.343] Timer tick, asking Buildbucket for the build status
[14:11:06.426] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:06.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:92:0) after 1m0s
[14:12:06.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:92:0)
[14:12:06.771] Timer tick, asking Buildbucket for the build status
[14:12:06.956] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:06.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:93:0) after 1m0s
[14:13:07.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:93:0)
[14:13:07.079] Timer tick, asking Buildbucket for the build status
[14:13:07.228] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:07.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:94:0) after 1m0s
[14:14:07.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:94:0)
[14:14:07.237] Timer tick, asking Buildbucket for the build status
[14:14:07.478] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:07.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:95:0) after 1m0s
[14:15:07.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:95:0)
[14:15:07.561] Timer tick, asking Buildbucket for the build status
[14:15:07.645] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:07.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:96:0) after 1m0s
[14:16:07.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:96:0)
[14:16:07.671] Timer tick, asking Buildbucket for the build status
[14:16:07.851] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:07.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:97:0) after 1m0s
[14:17:07.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:97:0)
[14:17:07.936] Timer tick, asking Buildbucket for the build status
[14:17:08.044] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:08.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:98:0) after 1m0s
[14:18:08.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:98:0)
[14:18:08.086] Timer tick, asking Buildbucket for the build status
[14:18:08.237] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:08.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:99:0) after 1m0s
[14:19:08.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:99:0)
[14:19:08.331] Timer tick, asking Buildbucket for the build status
[14:19:08.497] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:08.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:100:0) after 1m0s
[14:20:08.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:100:0)
[14:20:08.521] Timer tick, asking Buildbucket for the build status
[14:20:08.806] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:08.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:101:0) after 1m0s
[14:21:08.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:101:0)
[14:21:08.916] Timer tick, asking Buildbucket for the build status
[14:21:08.975] Build 8858308960574363408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:08.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023739022569535168:102:0) after 1m0s
[14:21:52.143] Received PubSub notification, asking Buildbucket for the build status
[14:21:52.210] Build 8858308960574363408: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:21:52.210] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610461311532571",
"created_by": "project:chromium",
"created_ts": "1610455279716370",
"id": "8858308960574363408",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2261c4e1a7c4126457be87813944eb77ae93382f\"}}",
"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\": \"2261c4e1a7c4126457be87813944eb77ae93382f\", \"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-72-w0e6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22166, \"got_angle_revision\": \"7f0e7d0d262aa0ee71c862846c72f737cbbfca04\", \"got_dawn_revision\": \"2bd95f1cf45451119b6644e41919b7bef443d912\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"2261c4e1a7c4126457be87813944eb77ae93382f\", \"got_revision_cp\": \"refs/heads/master@{#842487}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"724907341fdd1a17fced5758d13d736c3c19cc6b\", \"got_v8_revision_cp\": \"refs/heads/8.9.247@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2261c4e1a7c4126457be87813944eb77ae93382f\", \"swarm_hashes_refs/heads/master(at){#842487}_without_patch\": {\"absl_hardening_tests\": \"7d36fe274d74725cd10b5f2de51e7d5c3206bce6\", \"accessibility_unittests\": \"3d38deb7448d52074f23e1419e7589da1d3888e4\", \"angle_unittests\": \"620de402294cb84be1db552111cbf0f69385be92\", \"app_list_unittests\": \"d39c88844034276c12007ff772ee612451df046b\", \"app_shell_unittests\": \"26bb64ab38593e4e56091c717302d2794a8732b6\", \"ash_unittests\": \"3febc044b818e09e523f8b3777c0f24e56a51e40\", \"aura_unittests\": \"f2f6dc75fa4abb80be578f6355570e5d13785cf9\", \"base_unittests\": \"af11e9e7aab35c8b1d2384d47499ce6a89dad9a9\", \"base_util_unittests\": \"4b31e97ecbfe2c56ec753959748be0abd3e2baba\", \"blink_common_unittests\": \"52f026c13e481b0d856f85c9cd297406e53bfb6e\", \"blink_fuzzer_unittests\": \"f33e38fa17266bf8d6ac7215b7d978ff0fb43ac7\", \"blink_heap_unittests\": \"9eb08747a4ebf63c4081d4463c4e20e5b9036c56\", \"blink_platform_unittests\": \"a3a9fe1cfbd8d634ed64c0755b39fa889b55f074\", \"blink_unittests\": \"7f169b20d0f4cad00261c7477a3c5b09037f6ff6\", \"boringssl_crypto_tests\": \"0a9eaa6071576478b0a1da1a1d4c5bbe635f2a24\", \"boringssl_ssl_tests\": \"b461ef04ca864e8be3e2030b6ea8411d0e5ae835\", \"browser_tests\": \"879719cfe275e21d0e76cf83f85c981c753d4617\", \"capture_unittests\": \"2c972908f80979b6202849004894c8a6afe6601f\", \"cast_unittests\": \"0f72a131b22413d09b53aa18ad3cdd546317bbea\", \"cc_unittests\": \"b1e3751887fce85c1d5025298d1504e8688146e0\", \"chrome_app_unittests\": \"99f6f61da3e9e2e780e719fabadab4215487d687\", \"chromedriver_unittests\": \"60798c39e6d134ee93d0d1290286947bddbb3c53\", \"chromeos_components_unittests\": \"d81be646046a22bf441e60ce04fe7501d7be75b2\", \"chromeos_unittests\": \"7751bf7dc8e86c352b2a1f746976ef900beb5b6e\", \"components_browsertests\": \"c5dc5fab5a086cf98c5c3b156a482a783a16b90a\", \"components_unittests\": \"673f76ea6138d9c684354dfeacffa4834a72d31a\", \"compositor_unittests\": \"86be3c1e2a9321eae645509384a039473e182471\", \"content_browsertests\": \"8ddd57f9e23c2589d36392c66952dd032fbba233\", \"content_unittests\": \"60394b339ce6019806b679b3d2106d91707a480c\", \"crashpad_tests\": \"22de840e4bcf39fdd9c7ddb748926bf2e98ce54b\", \"crypto_unittests\": \"3d9b9a398adc4aadf7b3953a4d9d329e582cda46\", \"dbus_unittests\": \"5513490385b36393bb4b1a1feb31497c92b9a25c\", \"device_unittests\": \"d99bc6d53d40375849c6afe9cfda3ea959762780\", \"display_unittests\": \"0a5cd0ad626e4c9de9a7811194336f6f1455f681\", \"events_unittests\": \"1fffe239a3bf1a8d47f6fc9c617d4b6d42e11b0c\", \"exo_unittests\": \"818512af80ee693b8ee743333d766e6866651746\", \"extensions_browsertests\": \"c2b7903ee2e4f1610502b56e7bf2dd57a358f72d\", \"extensions_unittests\": \"7282f9394414403f70e085518dbbd9ed40868621\", \"filesystem_service_unittests\": \"31d93cfe52bae8d6949ca5cf39813ed0b9715723\", \"gcm_unit_tests\": \"c2c525444971024eedf071452f77f4fefeb6336c\", \"gfx_unittests\": \"99c6e9e096145e262d1233c516bc49d1263c6f29\", \"gin_unittests\": \"a549950402f6a4e40eea35aaf5817c2b461cbf40\", \"gl_unittests_ozone\": \"17d916086826fb016458fed57eefaa7a8ae7070f\", \"google_apis_unittests\": \"817652d5235dfb708e2e74d57bfdb2cd14bd2ed8\", \"gpu_unittests\": \"23610199415a0cbf1873ce0a755757b1d310a829\", \"gwp_asan_unittests\": \"726fd7ef73cb2da8f8afee321bca6a890d51d0ee\", \"interactive_ui_tests\": \"aceed2ca5947341a33c86a8d15f28b26d63b8418\", \"ipc_tests\": \"fd20f6ae9ce5d47710c07f6751353cdadd995d1f\", \"jingle_unittests\": \"9544b092b1d433b5c0d8a0adbe9466902dd95bbc\", \"keyboard_unittests\": \"1c81a2d1288dd286e7ecf1afd356ec319983c524\", \"latency_unittests\": \"6d5f795ec1720180cc127f5bfc303f109bdaa33f\", \"libjingle_xmpp_unittests\": \"c02e77c7d91661b893b611e64abac86a48417cc7\", \"liburlpattern_unittests\": \"bc9cc9c91ddc2412b856f746d5a9012a3dbd1283\", \"media_blink_unittests\": \"416db68be18adab24d9f152f912706fe17a2d688\", \"media_unittests\": \"598634ccd2b669b19e4d9c90f18c8abd03ba8c71\", \"message_center_unittests\": \"6eb18306e90f1574b901dc606fcd0ce95284fe45\", \"midi_unittests\": \"adf0a4e7e3bc7e07041b52c9df2e4f2cf2993b03\", \"mojo_core_unittests\": \"1bf454451d28ecc304b1cea02644ebb8e3c341fe\", \"mojo_unittests\": \"1af59567a28249d3be4dc94d517a90b3fe71647e\", \"nacl_helper_nonsfi_unittests\": \"a43c662e12214e1c1ac181ac9424ec2a5f043df0\", \"nacl_loader_unittests\": \"48c76e4a5fa4a4c9b1ce00fca34479fa4a203f49\", \"native_theme_unittests\": \"337ceec5126f88922d31dd1bedcb62dc87c2f1c1\", \"net_unittests\": \"84b322006c910b913c0727c0f5671e9a8aadcb52\", \"ozone_gl_unittests\": \"0cdc95b19f04d873b41c4c8bd31834477b7d13b4\", \"ozone_unittests\": \"2d43580a35ec3fdc183499b665ba270860536373\", \"ozone_x11_unittests\": \"5e2a389b439a3635ec272e0c7f1c92fad71a8bd1\", \"pdf_unittests\": \"52a1a750b9bc7f48f0d6fdc1beda3d9b3c05cc50\", \"perfetto_unittests\": \"d29649e6eebb6adbf2c42e398b1d50b08cf505b0\", \"ppapi_unittests\": \"4d6b1e1a70c2dbb0b847b165cb231c344aade96d\", \"printing_unittests\": \"9642ab503b212a8dcc3495255ef79109b0aede56\", \"remoting_unittests\": \"a7484e266310d2f8461cf1ef89d7c907246058f6\", \"sandbox_linux_unittests\": \"eae6e686cada7c2c07d7f6233ef00dfe2a65cf4d\", \"service_manager_unittests\": \"0ed2c13c56ca1195d1601a58ff59bf77d600dcd9\", \"services_unittests\": \"ee675e4b64404a132b8dc6f1f7b466bbc9e812b2\", \"shell_dialogs_unittests\": \"6bff4acd8e788d85d94a50d74f523849c0c4f7c9\", \"shell_encryption_unittests\": \"9c2bd193a7dab5745e80a02d5c0cbbbd5c71cb7b\", \"skia_unittests\": \"1caf3fcc7cc3ec79207071d2c675cf2338d39e1a\", \"snapshot_unittests\": \"5118ac7b0b5bd2d5051e81fcab508d1652680911\", \"sql_unittests\": \"23a4703902ddc92395780016cb1cb3db861495f0\", \"storage_unittests\": \"bfe9bb081cf6ba4b3878795835ead28c62078961\", \"sync_integration_tests\": \"1917ec57294003d382d6b533a90c9daad76ebd6c\", \"traffic_annotation_auditor_unittests\": \"1b0a954693a3cc99efcb6aea16f2dec2b6e72e3a\", \"ui_base_unittests\": \"7ad8b6228e8cb70ff698890b7fe6d5f9cea01294\", \"ui_chromeos_unittests\": \"1a1e047b5993443b171b5cd8fea2e1cd42ed3c6a\", \"ui_touch_selection_unittests\": \"3b520d6ec203260ef66ca006dcab814d451e8c24\", \"unit_tests\": \"6a53a32f6eafe98ef36d0bb4574ab8b4db46c631\", \"url_unittests\": \"a869b9bed27db00d84dc7fdb6ffd62cb9f564696\", \"usage_time_limit_unittests\": \"414c70358991fd9103be0263569b0c9a92b54ec9\", \"views_unittests\": \"2c5118dd8874f9a31920d97cf50e41244b0fc58a\", \"viz_unittests\": \"b6a90d07e06d96ded5adadaa710d196b40c3fde1\", \"wm_unittests\": \"3c83b827b164043a5292b2853b2ff37c9edb621e\", \"wtf_unittests\": \"5c6e15ba65238c9f1b8e20194053d0c05c8465aa\", \"zlib_unittests\": \"d4b4fea2947eff5b4b992d4ad6b512015b91fb21\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-72-w0e6\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610455327832141",
"status": "COMPLETED",
"status_changed_ts": "1610461311838289",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22166",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2261c4e1a7c4126457be87813944eb77ae93382f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2261c4e1a7c4126457be87813944eb77ae93382f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023739022569535168",
"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/8858308960574363408/+/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:510f6ef371be3d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610461311843010",
"url": "https://ci.chromium.org/b/8858308960574363408",
"utcnow_ts": "1610461312203474"
}
}
[14:21:52.210] Invocation finished in 1h40m33.779911751s with status SUCCEEDED