[11:34:55.346] New invocation is queued and will start shortly
[11:34:56.609] Starting the invocation (attempt 1)
[11:34:56.648] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:34:56.648] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:34:56.649] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018669769032308496",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1055879da43a1507c3982393baacf040502edb20\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018669769032308496",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/1055879da43a1507c3982393baacf040502edb20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1055879da43a1507c3982393baacf040502edb20",
"gitiles_ref:refs/heads/master"
]
}
[11:34:57.445] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615289696791408",
"id": "8853239706855692240",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1055879da43a1507c3982393baacf040502edb20\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615289697244582",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22921",
"builder:linux-chromeos-dbg",
"buildset:commit/git/1055879da43a1507c3982393baacf040502edb20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1055879da43a1507c3982393baacf040502edb20",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018669769032308496",
"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/8853239706855692240/+/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": "1615289697244723",
"url": "https://ci.chromium.org/b/8853239706855692240",
"utcnow_ts": "1615289697437166"
}
}
[11:34:57.445] Task URL: https://ci.chromium.org/b/8853239706855692240
[11:34:57.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:2:0) after 1m0s
[11:35:03.723] Received PubSub notification, asking Buildbucket for the build status
[11:35:03.787] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:57.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:2:0)
[11:35:57.557] Timer tick, asking Buildbucket for the build status
[11:35:57.626] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:57.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:4:0) after 1m0s
[11:36:57.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:4:0)
[11:36:57.734] Timer tick, asking Buildbucket for the build status
[11:36:57.820] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:57.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:5:0) after 1m0s
[11:37:57.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:5:0)
[11:37:57.837] Timer tick, asking Buildbucket for the build status
[11:37:57.899] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:57.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:6:0) after 1m0s
[11:38:57.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:6:0)
[11:38:57.949] Timer tick, asking Buildbucket for the build status
[11:38:58.173] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:58.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:7:0) after 1m0s
[11:39:58.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:7:0)
[11:39:58.248] Timer tick, asking Buildbucket for the build status
[11:39:58.355] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:58.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:8:0) after 1m0s
[11:40:58.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:8:0)
[11:40:58.335] Timer tick, asking Buildbucket for the build status
[11:40:58.413] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:58.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:9:0) after 1m0s
[11:41:58.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:9:0)
[11:41:58.455] Timer tick, asking Buildbucket for the build status
[11:41:58.807] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:58.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:10:0) after 1m0s
[11:42:58.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:10:0)
[11:42:58.902] Timer tick, asking Buildbucket for the build status
[11:42:59.021] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:59.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:11:0) after 1m0s
[11:43:59.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:11:0)
[11:43:59.076] Timer tick, asking Buildbucket for the build status
[11:43:59.149] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:59.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:12:0) after 1m0s
[11:44:59.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:12:0)
[11:44:59.225] Timer tick, asking Buildbucket for the build status
[11:44:59.453] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:59.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:13:0) after 1m0s
[11:45:59.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:13:0)
[11:45:59.499] Timer tick, asking Buildbucket for the build status
[11:45:59.568] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:59.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:14:0) after 1m0s
[11:46:59.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:14:0)
[11:46:59.598] Timer tick, asking Buildbucket for the build status
[11:46:59.686] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:59.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:15:0) after 1m0s
[11:47:59.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:15:0)
[11:47:59.710] Timer tick, asking Buildbucket for the build status
[11:47:59.780] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:59.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:16:0) after 1m0s
[11:48:59.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:16:0)
[11:48:59.830] Timer tick, asking Buildbucket for the build status
[11:48:59.890] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:59.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:17:0) after 1m0s
[11:49:59.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:17:0)
[11:49:59.915] Timer tick, asking Buildbucket for the build status
[11:49:59.983] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:59.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:18:0) after 1m0s
[11:51:00.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:18:0)
[11:51:00.000] Timer tick, asking Buildbucket for the build status
[11:51:00.183] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:00.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:19:0) after 1m0s
[11:52:00.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:19:0)
[11:52:00.300] Timer tick, asking Buildbucket for the build status
[11:52:00.719] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:00.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:20:0) after 1m0s
[11:53:00.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:20:0)
[11:53:00.740] Timer tick, asking Buildbucket for the build status
[11:53:00.846] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:00.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:21:0) after 1m0s
[11:54:01.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:21:0)
[11:54:01.665] Timer tick, asking Buildbucket for the build status
[11:54:01.834] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:01.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:22:0) after 1m0s
[11:55:01.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:22:0)
[11:55:01.848] Timer tick, asking Buildbucket for the build status
[11:55:01.913] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:01.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:23:0) after 1m0s
[11:56:01.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:23:0)
[11:56:01.931] Timer tick, asking Buildbucket for the build status
[11:56:02.165] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:02.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:24:0) after 1m0s
[11:57:02.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:24:0)
[11:57:02.295] Timer tick, asking Buildbucket for the build status
[11:57:02.400] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:02.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:25:0) after 1m0s
[11:58:02.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:25:0)
[11:58:02.456] Timer tick, asking Buildbucket for the build status
[11:58:02.735] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:02.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:26:0) after 1m0s
[11:59:02.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:26:0)
[11:59:02.734] Timer tick, asking Buildbucket for the build status
[11:59:02.824] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:02.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:27:0) after 1m0s
[12:00:02.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:27:0)
[12:00:02.845] Timer tick, asking Buildbucket for the build status
[12:00:03.046] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:03.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:28:0) after 1m0s
[12:01:03.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:28:0)
[12:01:03.145] Timer tick, asking Buildbucket for the build status
[12:01:03.300] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:03.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:29:0) after 1m0s
[12:02:03.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:29:0)
[12:02:03.499] Timer tick, asking Buildbucket for the build status
[12:02:03.644] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:03.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:30:0) after 1m0s
[12:03:03.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:30:0)
[12:03:03.686] Timer tick, asking Buildbucket for the build status
[12:03:03.773] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:03.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:31:0) after 1m0s
[12:04:03.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:31:0)
[12:04:03.835] Timer tick, asking Buildbucket for the build status
[12:04:03.937] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:03.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:32:0) after 1m0s
[12:05:04.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:32:0)
[12:05:04.038] Timer tick, asking Buildbucket for the build status
[12:05:04.126] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:04.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:33:0) after 1m0s
[12:06:04.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:33:0)
[12:06:04.129] Timer tick, asking Buildbucket for the build status
[12:06:04.275] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:04.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:34:0) after 1m0s
[12:07:04.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:34:0)
[12:07:04.300] Timer tick, asking Buildbucket for the build status
[12:07:04.380] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:04.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:35:0) after 1m0s
[12:08:04.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:35:0)
[12:08:04.488] Timer tick, asking Buildbucket for the build status
[12:08:04.599] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:04.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:36:0) after 1m0s
[12:09:04.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:36:0)
[12:09:04.646] Timer tick, asking Buildbucket for the build status
[12:09:04.745] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:04.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:37:0) after 1m0s
[12:10:04.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:37:0)
[12:10:04.830] Timer tick, asking Buildbucket for the build status
[12:10:04.918] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:04.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:38:0) after 1m0s
[12:11:04.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:38:0)
[12:11:04.948] Timer tick, asking Buildbucket for the build status
[12:11:05.152] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:05.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:39:0) after 1m0s
[12:12:05.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:39:0)
[12:12:05.172] Timer tick, asking Buildbucket for the build status
[12:12:05.259] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:05.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:40:0) after 1m0s
[12:13:05.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:40:0)
[12:13:05.315] Timer tick, asking Buildbucket for the build status
[12:13:05.378] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:05.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:41:0) after 1m0s
[12:14:05.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:41:0)
[12:14:05.487] Timer tick, asking Buildbucket for the build status
[12:14:05.925] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:05.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:42:0) after 1m0s
[12:15:05.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:42:0)
[12:15:05.951] Timer tick, asking Buildbucket for the build status
[12:15:06.023] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:06.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:43:0) after 1m0s
[12:16:06.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:43:0)
[12:16:06.182] Timer tick, asking Buildbucket for the build status
[12:16:06.751] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:06.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:44:0) after 1m0s
[12:17:06.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:44:0)
[12:17:06.871] Timer tick, asking Buildbucket for the build status
[12:17:06.960] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:06.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:45:0) after 1m0s
[12:18:07.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:45:0)
[12:18:07.102] Timer tick, asking Buildbucket for the build status
[12:18:07.226] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:07.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:46:0) after 1m0s
[12:19:07.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:46:0)
[12:19:07.270] Timer tick, asking Buildbucket for the build status
[12:19:07.339] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:07.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:47:0) after 1m0s
[12:20:07.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:47:0)
[12:20:07.370] Timer tick, asking Buildbucket for the build status
[12:20:07.440] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:07.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:48:0) after 1m0s
[12:21:07.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:48:0)
[12:21:07.481] Timer tick, asking Buildbucket for the build status
[12:21:07.590] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:07.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:49:0) after 1m0s
[12:22:07.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:49:0)
[12:22:07.711] Timer tick, asking Buildbucket for the build status
[12:22:07.948] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:07.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:50:0) after 1m0s
[12:23:08.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:50:0)
[12:23:08.007] Timer tick, asking Buildbucket for the build status
[12:23:08.130] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:08.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:51:0) after 1m0s
[12:24:08.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:51:0)
[12:24:08.226] Timer tick, asking Buildbucket for the build status
[12:24:08.322] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:08.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:52:0) after 1m0s
[12:25:08.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:52:0)
[12:25:08.403] Timer tick, asking Buildbucket for the build status
[12:25:08.472] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:08.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:53:0) after 1m0s
[12:26:08.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:53:0)
[12:26:08.508] Timer tick, asking Buildbucket for the build status
[12:26:08.651] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:08.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:54:0) after 1m0s
[12:27:08.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:54:0)
[12:27:08.670] Timer tick, asking Buildbucket for the build status
[12:27:08.760] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:08.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:55:0) after 1m0s
[12:28:08.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:55:0)
[12:28:08.907] Timer tick, asking Buildbucket for the build status
[12:28:09.007] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:09.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:56:0) after 1m0s
[12:29:09.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:56:0)
[12:29:09.140] Timer tick, asking Buildbucket for the build status
[12:29:09.248] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:09.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:57:0) after 1m0s
[12:30:09.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:57:0)
[12:30:09.382] Timer tick, asking Buildbucket for the build status
[12:30:09.501] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:09.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:58:0) after 1m0s
[12:31:09.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:58:0)
[12:31:09.580] Timer tick, asking Buildbucket for the build status
[12:31:09.741] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:09.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:59:0) after 1m0s
[12:32:09.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:59:0)
[12:32:09.760] Timer tick, asking Buildbucket for the build status
[12:32:09.841] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:09.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:60:0) after 1m0s
[12:33:09.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:60:0)
[12:33:09.903] Timer tick, asking Buildbucket for the build status
[12:33:09.999] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:09.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:61:0) after 1m0s
[12:34:10.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:61:0)
[12:34:10.067] Timer tick, asking Buildbucket for the build status
[12:34:10.216] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:10.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:62:0) after 1m0s
[12:35:10.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:62:0)
[12:35:10.284] Timer tick, asking Buildbucket for the build status
[12:35:10.607] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:10.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:63:0) after 1m0s
[12:36:10.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:63:0)
[12:36:10.718] Timer tick, asking Buildbucket for the build status
[12:36:10.961] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:10.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:64:0) after 1m0s
[12:37:11.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:64:0)
[12:37:11.086] Timer tick, asking Buildbucket for the build status
[12:37:11.178] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:11.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:65:0) after 1m0s
[12:38:11.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:65:0)
[12:38:11.264] Timer tick, asking Buildbucket for the build status
[12:38:11.349] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:11.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:66:0) after 1m0s
[12:39:11.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:66:0)
[12:39:11.407] Timer tick, asking Buildbucket for the build status
[12:39:11.484] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:11.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:67:0) after 1m0s
[12:40:11.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:67:0)
[12:40:11.627] Timer tick, asking Buildbucket for the build status
[12:40:11.745] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:11.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:68:0) after 1m0s
[12:41:11.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:68:0)
[12:41:11.828] Timer tick, asking Buildbucket for the build status
[12:41:11.926] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:11.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:69:0) after 1m0s
[12:42:11.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:69:0)
[12:42:11.978] Timer tick, asking Buildbucket for the build status
[12:42:12.062] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:12.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:70:0) after 1m0s
[12:43:12.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:70:0)
[12:43:12.127] Timer tick, asking Buildbucket for the build status
[12:43:12.237] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:12.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:71:0) after 1m0s
[12:44:12.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:71:0)
[12:44:12.635] Timer tick, asking Buildbucket for the build status
[12:44:12.707] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:12.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:72:0) after 1m0s
[12:45:12.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:72:0)
[12:45:12.785] Timer tick, asking Buildbucket for the build status
[12:45:13.153] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:13.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:73:0) after 1m0s
[12:46:13.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:73:0)
[12:46:13.330] Timer tick, asking Buildbucket for the build status
[12:46:13.804] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:13.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:74:0) after 1m0s
[12:47:14.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:74:0)
[12:47:14.000] Timer tick, asking Buildbucket for the build status
[12:47:14.119] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:14.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:75:0) after 1m0s
[12:48:14.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:75:0)
[12:48:14.224] Timer tick, asking Buildbucket for the build status
[12:48:14.307] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:14.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:76:0) after 1m0s
[12:49:14.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:76:0)
[12:49:14.455] Timer tick, asking Buildbucket for the build status
[12:49:14.567] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:14.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:77:0) after 1m0s
[12:50:14.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:77:0)
[12:50:14.732] Timer tick, asking Buildbucket for the build status
[12:50:14.813] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:14.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:78:0) after 1m0s
[12:51:14.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:78:0)
[12:51:14.885] Timer tick, asking Buildbucket for the build status
[12:51:14.971] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:14.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:79:0) after 1m0s
[12:52:15.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:79:0)
[12:52:15.005] Timer tick, asking Buildbucket for the build status
[12:52:15.262] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:15.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:80:0) after 1m0s
[12:53:15.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:80:0)
[12:53:15.342] Timer tick, asking Buildbucket for the build status
[12:53:15.650] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:15.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:81:0) after 1m0s
[12:54:15.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:81:0)
[12:54:15.672] Timer tick, asking Buildbucket for the build status
[12:54:15.750] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:15.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:82:0) after 1m0s
[12:55:15.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:82:0)
[12:55:15.727] Timer tick, asking Buildbucket for the build status
[12:55:15.841] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:15.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:83:0) after 1m0s
[12:56:15.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:83:0)
[12:56:15.862] Timer tick, asking Buildbucket for the build status
[12:56:15.949] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:15.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:84:0) after 1m0s
[12:57:15.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:84:0)
[12:57:15.979] Timer tick, asking Buildbucket for the build status
[12:57:16.128] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:16.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:85:0) after 1m0s
[12:58:16.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:85:0)
[12:58:16.230] Timer tick, asking Buildbucket for the build status
[12:58:16.321] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:16.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:86:0) after 1m0s
[12:59:16.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:86:0)
[12:59:16.459] Timer tick, asking Buildbucket for the build status
[12:59:16.656] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:16.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:87:0) after 1m0s
[13:00:16.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:87:0)
[13:00:16.750] Timer tick, asking Buildbucket for the build status
[13:00:16.892] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:16.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:88:0) after 1m0s
[13:01:17.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:88:0)
[13:01:17.059] Timer tick, asking Buildbucket for the build status
[13:01:17.475] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:17.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:89:0) after 1m0s
[13:02:17.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:89:0)
[13:02:17.683] Timer tick, asking Buildbucket for the build status
[13:02:17.818] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:17.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:90:0) after 1m0s
[13:03:17.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:90:0)
[13:03:17.933] Timer tick, asking Buildbucket for the build status
[13:03:18.328] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:18.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:91:0) after 1m0s
[13:04:18.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:91:0)
[13:04:18.418] Timer tick, asking Buildbucket for the build status
[13:04:18.780] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:18.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:92:0) after 1m0s
[13:05:18.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:92:0)
[13:05:18.867] Timer tick, asking Buildbucket for the build status
[13:05:18.999] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:18.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:93:0) after 1m0s
[13:06:19.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:93:0)
[13:06:19.088] Timer tick, asking Buildbucket for the build status
[13:06:19.177] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:19.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:94:0) after 1m0s
[13:07:19.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:94:0)
[13:07:19.276] Timer tick, asking Buildbucket for the build status
[13:07:19.439] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:19.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:95:0) after 1m0s
[13:08:19.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:95:0)
[13:08:19.530] Timer tick, asking Buildbucket for the build status
[13:08:19.607] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:19.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:96:0) after 1m0s
[13:09:19.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:96:0)
[13:09:19.606] Timer tick, asking Buildbucket for the build status
[13:09:19.748] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:19.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:97:0) after 1m0s
[13:10:19.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:97:0)
[13:10:19.874] Timer tick, asking Buildbucket for the build status
[13:10:19.977] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:19.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:98:0) after 1m0s
[13:11:20.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:98:0)
[13:11:20.111] Timer tick, asking Buildbucket for the build status
[13:11:20.194] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:20.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:99:0) after 1m0s
[13:12:20.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:99:0)
[13:12:20.247] Timer tick, asking Buildbucket for the build status
[13:12:20.325] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:20.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:100:0) after 1m0s
[13:13:20.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:100:0)
[13:13:20.902] Timer tick, asking Buildbucket for the build status
[13:13:21.025] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:21.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:101:0) after 1m0s
[13:14:21.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:101:0)
[13:14:21.054] Timer tick, asking Buildbucket for the build status
[13:14:21.149] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:21.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:102:0) after 1m0s
[13:15:21.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:102:0)
[13:15:21.621] Timer tick, asking Buildbucket for the build status
[13:15:21.709] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:21.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:103:0) after 1m0s
[13:16:21.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:103:0)
[13:16:21.898] Timer tick, asking Buildbucket for the build status
[13:16:21.970] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:21.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:104:0) after 1m0s
[13:17:22.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:104:0)
[13:17:22.045] Timer tick, asking Buildbucket for the build status
[13:17:22.172] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:22.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:105:0) after 1m0s
[13:18:22.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:105:0)
[13:18:22.421] Timer tick, asking Buildbucket for the build status
[13:18:22.534] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:22.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:106:0) after 1m0s
[13:19:22.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:106:0)
[13:19:22.574] Timer tick, asking Buildbucket for the build status
[13:19:22.642] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:22.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:107:0) after 1m0s
[13:20:22.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:107:0)
[13:20:22.724] Timer tick, asking Buildbucket for the build status
[13:20:22.799] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:22.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:108:0) after 1m0s
[13:21:23.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:108:0)
[13:21:23.333] Timer tick, asking Buildbucket for the build status
[13:21:23.414] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:23.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:109:0) after 1m0s
[13:22:23.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:109:0)
[13:22:23.468] Timer tick, asking Buildbucket for the build status
[13:22:23.564] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:23.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:110:0) after 1m0s
[13:23:23.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:110:0)
[13:23:23.881] Timer tick, asking Buildbucket for the build status
[13:23:24.250] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:24.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:111:0) after 1m0s
[13:24:24.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:111:0)
[13:24:24.346] Timer tick, asking Buildbucket for the build status
[13:24:24.465] Build 8853239706855692240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:24.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018669769032308496:112:0) after 1m0s
[13:24:28.325] Received PubSub notification, asking Buildbucket for the build status
[13:24:28.451] Build 8853239706855692240: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:24:28.451] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615296267521857",
"created_by": "project:chromium",
"created_ts": "1615289696791408",
"failure_reason": "BUILD_FAILURE",
"id": "8853239706855692240",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1055879da43a1507c3982393baacf040502edb20\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**app_list_unittests** failed because of:\\n\\n- All/AppsGridViewTest.MouseDragFlipPage/0\"}, \"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\": \"1055879da43a1507c3982393baacf040502edb20\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-110-20ob\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22921, \"got_angle_revision\": \"faa3915ee3f06dade41a2bc260d850b99c5c6845\", \"got_dawn_revision\": \"7c3b5740db6be782ca4d2e78139568b67db1fc0f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"1055879da43a1507c3982393baacf040502edb20\", \"got_revision_cp\": \"refs/heads/master@{#861113}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"5c86b9ed5fdab5a53c326ae37b77effcef0b67ff\", \"got_v8_revision_cp\": \"refs/heads/9.1.75@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"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\": \"1055879da43a1507c3982393baacf040502edb20\", \"swarm_hashes_refs/heads/master(at){#861113}_without_patch\": {\"absl_hardening_tests\": \"8e49e46e0d87d87fbb6ce0fd9b5a6acec830200f\", \"accessibility_unittests\": \"5489650d176f06620697085f61a032e056f08501\", \"angle_unittests\": \"d4a7976e4a6a492558001fdbc77080f39083c36b\", \"app_list_unittests\": \"ea3b2fbcadbc0e866dabb75fa065580adb74076a\", \"app_shell_unittests\": \"43f6ae865370d495507cba6a598d71cf42f02284\", \"ash_unittests\": \"e640bd51e9f857632da46191313fe59d135c3722\", \"aura_unittests\": \"8bb6f66f70172c920e1ee338502a30c2f3b0a5f4\", \"base_unittests\": \"ea007ee9ae8f96f9ddac64e477a445714c6dc6c8\", \"base_util_unittests\": \"b15d2e089b40c3de34abd26006324adaa71abee3\", \"blink_common_unittests\": \"90e4110c61564e0b1f46bb8c7732af307115aca1\", \"blink_fuzzer_unittests\": \"969b99a57e9af74f55fc0bf657cf6c1610f02c4c\", \"blink_heap_unittests\": \"ed105da77578446592f8d180716889445e063f1e\", \"blink_platform_unittests\": \"fedd2f538b04cf09124d7cdae409c0d4da10eae3\", \"blink_unittests\": \"dc1f62dff46617e76743d081a8b80ab8a9f87665\", \"boringssl_crypto_tests\": \"f41c5674d5b1565b976cf77b97c7e74f4a371f07\", \"boringssl_ssl_tests\": \"b518193c5d89281bd16f4adc59d7406fd8218aa9\", \"browser_tests\": \"b39e46d74fb86e9b05a5bd29fe189f6cbe031db8\", \"capture_unittests\": \"36eb4402f33e56b5cf94c0e365d4ffef09473ee1\", \"cast_unittests\": \"29e4a218ad5a3917d2ea4c6846b7e82b4d49f785\", \"cc_unittests\": \"2afee8cb196039f8f135c42d94bab0737b695f9f\", \"chrome_app_unittests\": \"6c28223ecd3ebc5b7903a48d29a2221d24b37f22\", \"chromedriver_unittests\": \"53b4dff011c635c984ba4b8a66e3e22c45aacbd1\", \"chromeos_components_unittests\": \"1377ee02b2571e243a1823afe1e85fb189f644ac\", \"chromeos_unittests\": \"ff0f6a87958c8e4184ae275a32d7d08c3d11c70e\", \"color_unittests\": \"6c7c2f7814dce81f2ed5be10465c873db27d2b3f\", \"components_browsertests\": \"c070c1612288ff4d63a885dd1395fd404c17a519\", \"components_unittests\": \"1875bc3d92333a26a368c4bc02029693aff9cf22\", \"compositor_unittests\": \"8cde3bc2f1a78aa64496ef04fc81ce310f291bce\", \"content_browsertests\": \"778ab8a9313d8d230b283b9b84acb58589d7e78c\", \"content_unittests\": \"32adc94116a6773bbfcba6a3b2599d1447afdb56\", \"crashpad_tests\": \"69bdb0ce72eaf42127984bc6899590f2ec15064c\", \"crypto_unittests\": \"a5b4893e6970fc0825b218e8c4c34072812c2caf\", \"dbus_unittests\": \"a0451f155a46e8d624606a62e073fe9b2c10fb0a\", \"device_unittests\": \"8b641d094c2e3a970462f856d463410f7de976f7\", \"display_unittests\": \"e5c33a71d4e1db9985fad565eb359327ca1a5ef8\", \"events_unittests\": \"f58ec06b3a6e0cdb61fbe9fabd647ee99566e354\", \"exo_unittests\": \"1b2aa8a9bbd9a600327a564606b670f25b4d6a1b\", \"extensions_browsertests\": \"7effa78ce460755a12abdd98eef57b02ab53eda0\", \"extensions_unittests\": \"442322597f51530239ce08fce6b74a321d5bb742\", \"filesystem_service_unittests\": \"721f1d312f4f389cb77a005ab5696720c045d841\", \"gcm_unit_tests\": \"46a23eb05c67918bd8275f5d9ff88adefab61a91\", \"gfx_unittests\": \"ed232b0adca145db2f7525860b12be4897b15d45\", \"gin_unittests\": \"802b16a6743627888b1ec0e291ad09969ff1ae03\", \"gl_unittests_ozone\": \"a789cdbafe4ceb280364a75d1bb83fc5cd614bd4\", \"google_apis_unittests\": \"efdb4e451ef5b03563ad31676762aa5c270a37ab\", \"gpu_unittests\": \"d58fc075dce4bfea393c090a5d882fa14e887ab6\", \"gwp_asan_unittests\": \"934869668cad20b6ffae3bfd8acbaf8757ff8052\", \"interactive_ui_tests\": \"184309e1b75649db0ae21eaa0b2f3be7e0e9736b\", \"ipc_tests\": \"c04e2438631173388cbc5d5a033fa06e5721eba3\", \"jingle_unittests\": \"3a0e53347f796e02207d44373128db40bc1800a0\", \"keyboard_unittests\": \"fd7fabe74c3f66a5435f985f69bb0115f537493a\", \"latency_unittests\": \"fc30b2e859aa066939b1def92ac804e332f73be2\", \"libjingle_xmpp_unittests\": \"cd5c4e496aaa57f4100ebed23505e03beada577b\", \"liburlpattern_unittests\": \"33229578f994deff0f59ff1b136860a43f447572\", \"media_blink_unittests\": \"8db35dbfce1dd8bfd0f90539b31df2d0fcc03603\", \"media_unittests\": \"098234221154fd9ace583e06b02bccadffff1163\", \"message_center_unittests\": \"edf28644078192327c49bd117aaffe7efbfc8a10\", \"midi_unittests\": \"ab8bcee89383faa93efc48e8197512918ef58eaa\", \"mojo_core_unittests\": \"f90981d2d176b73a9b89f5bea5e6c0be75831f49\", \"mojo_unittests\": \"72d9ce451967f8b3738fcea6128a754c7491deba\", \"nacl_helper_nonsfi_unittests\": \"ef661455643d53d855339c5306f951e095d79919\", \"nacl_loader_unittests\": \"cff4033db6d67868d9a09508d4c9b9c144ee0d22\", \"native_theme_unittests\": \"33fe00e923212c2fa05e9b7f6cf69bee1da70e97\", \"net_unittests\": \"c3c7c33481eff6a108d6f5cd9901603441e64282\", \"ozone_gl_unittests\": \"323dc771ee2282ac497ad9cc6373a0cbb4b881b5\", \"ozone_unittests\": \"1e712bc1f50a505b78d3418bfc479b03ef02df9c\", \"ozone_x11_unittests\": \"5778d04013565b7f009f23148261644810f46597\", \"pdf_unittests\": \"51d9ee70e9113a8d314c5241f147b3fb349be7ab\", \"perfetto_unittests\": \"39a8cda7095313a19c14cda5efb3a401870b57d6\", \"ppapi_unittests\": \"bcbc53abc1d8e8ecdaf26f041d34ec04e3ab34c0\", \"printing_unittests\": \"83346b882b536b4d5a5170036cc08ac55fa2ced3\", \"remoting_unittests\": \"5e8495073b446843edcb33943223c408d8b0ba1e\", \"sandbox_linux_unittests\": \"21b06c9c7b08cea911c1bf30e9c607c30870ddc5\", \"service_manager_unittests\": \"61a162d29603df89973050e600dca8f88869f6bc\", \"services_unittests\": \"333b39e35d3c8e25eca78f9b2716ab6c8a4524d2\", \"shell_dialogs_unittests\": \"7e1480eb8a1bf8b6dc2f2a84aa75c0942ab881e3\", \"shell_encryption_unittests\": \"0b8fa6a1bb792ffa32660e1836de58a9beee6db4\", \"skia_unittests\": \"fab0e5dea0df513212ad43f56729b02f50c95ff4\", \"snapshot_unittests\": \"becc5462fd34f2793727fba2f97d6e9964577610\", \"sql_unittests\": \"479e77157ff86ec988d194b749894c05ae50e28d\", \"storage_unittests\": \"3f6e5345fae78880e06326759283a893741ab3dc\", \"sync_integration_tests\": \"2a68d2c422224ecd57f93b00455a46e341aceea5\", \"traffic_annotation_auditor_unittests\": \"2fc04a9cd51c06354038876399f6ecc0c517ec3b\", \"ui_base_unittests\": \"724a98740fbce63e086bcba35283566c8e83ae36\", \"ui_chromeos_unittests\": \"22bcb4c840387f5fbff9836a860745d2c0ed659c\", \"ui_touch_selection_unittests\": \"8ee8d7a123eb6c0ccdc64423938afa9235dba1f7\", \"unit_tests\": \"078aa6814974fafb684826cbc5e2b7b1e807ada4\", \"url_unittests\": \"5849954e6f23a7a4c3d52ce47e26e8c6767bb5fc\", \"usage_time_limit_unittests\": \"039c872461e691d8dbd0db1530a9a8fdb507afd3\", \"views_unittests\": \"f5197bb12e5a3da110fb08afb71ff075ee5d1509\", \"viz_unittests\": \"826074a11a7bf43736e2b4f719fe2594ccb4ab9e\", \"wayland_client_tests\": \"27fdd6a73f3a5b614c35a862e9b7fea1bc5dce80\", \"wm_unittests\": \"3a6f85ad5d5b5af3a830c9b512e943186206a2f3\", \"wtf_unittests\": \"26c7ee11a4bb573bd4869905dd0f20945eb46649\", \"zlib_unittests\": \"ef8b0de5cd2fda95af4bf6456b36efe722a7acbe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_eae3a4dc277b4e2282e9fce002ae6861b5ee5509389502cf3acc9366ec79a2d3_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-110-20ob\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**app_list_unittests** failed because of:\\n\\n- All/AppsGridViewTest.MouseDragFlipPage/0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615289702179793",
"status": "COMPLETED",
"status_changed_ts": "1615289703113733",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22921",
"builder:linux-chromeos-dbg",
"buildset:commit/git/1055879da43a1507c3982393baacf040502edb20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1055879da43a1507c3982393baacf040502edb20",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018669769032308496",
"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/8853239706855692240/+/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:522f964d7afec410",
"user_agent:luci-scheduler"
],
"updated_ts": "1615296267522185",
"url": "https://ci.chromium.org/b/8853239706855692240",
"utcnow_ts": "1615296268441737"
}
}
[13:24:28.451] Invocation finished in 1h49m33.119431839s with status FAILED