[09:35:50.870] New invocation is queued and will start shortly
[09:35:52.034] Starting the invocation (attempt 1)
[09:35:52.115] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:35:52.115] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:35:52.115] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077021706966702800",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"82b1a0019f64a36a828b7dfe6413745e70c44737\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9077021706966702800",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/82b1a0019f64a36a828b7dfe6413745e70c44737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b1a0019f64a36a828b7dfe6413745e70c44737",
"gitiles_ref:refs/heads/master"
]
}
[09:36:01.986] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559640954407229",
"id": "8911591642550233600",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"82b1a0019f64a36a828b7dfe6413745e70c44737\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559640960716087",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12721",
"builder:linux-chromeos-dbg",
"buildset:commit/git/82b1a0019f64a36a828b7dfe6413745e70c44737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b1a0019f64a36a828b7dfe6413745e70c44737",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077021706966702800",
"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/8911591642550233600/+/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": "1559640960716426",
"url": "https://ci.chromium.org/b/8911591642550233600",
"utcnow_ts": "1559640961932114"
}
}
[09:36:01.986] Task URL: https://ci.chromium.org/b/8911591642550233600
[09:36:01.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:2:0) after 1m0s
[09:36:04.820] Received PubSub notification, asking Buildbucket for the build status
[09:36:07.194] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:02.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:2:0)
[09:37:02.101] Timer tick, asking Buildbucket for the build status
[09:37:02.291] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:02.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:4:0) after 1m0s
[09:38:02.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:4:0)
[09:38:02.323] Timer tick, asking Buildbucket for the build status
[09:38:02.566] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:02.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:5:0) after 1m0s
[09:39:02.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:5:0)
[09:39:02.594] Timer tick, asking Buildbucket for the build status
[09:39:05.362] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:05.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:6:0) after 1m0s
[09:40:05.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:6:0)
[09:40:05.373] Timer tick, asking Buildbucket for the build status
[09:40:05.537] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:05.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:7:0) after 1m0s
[09:41:05.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:7:0)
[09:41:05.570] Timer tick, asking Buildbucket for the build status
[09:41:05.718] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:05.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:8:0) after 1m0s
[09:42:05.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:8:0)
[09:42:05.886] Timer tick, asking Buildbucket for the build status
[09:42:07.573] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:07.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:9:0) after 1m0s
[09:43:07.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:9:0)
[09:43:07.620] Timer tick, asking Buildbucket for the build status
[09:43:09.939] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:09.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:10:0) after 1m0s
[09:44:09.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:10:0)
[09:44:09.960] Timer tick, asking Buildbucket for the build status
[09:44:11.643] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:11.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:11:0) after 1m0s
[09:45:11.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:11:0)
[09:45:11.706] Timer tick, asking Buildbucket for the build status
[09:45:13.106] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:13.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:12:0) after 1m0s
[09:46:13.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:12:0)
[09:46:13.251] Timer tick, asking Buildbucket for the build status
[09:46:15.217] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:15.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:13:0) after 1m0s
[09:47:15.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:13:0)
[09:47:15.250] Timer tick, asking Buildbucket for the build status
[09:47:16.246] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:16.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:14:0) after 1m0s
[09:48:16.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:14:0)
[09:48:16.337] Timer tick, asking Buildbucket for the build status
[09:48:16.530] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:16.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:15:0) after 1m0s
[09:49:16.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:15:0)
[09:49:16.639] Timer tick, asking Buildbucket for the build status
[09:49:17.986] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:17.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:16:0) after 1m0s
[09:50:18.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:16:0)
[09:50:18.281] Timer tick, asking Buildbucket for the build status
[09:50:19.720] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:19.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:17:0) after 1m0s
[09:51:19.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:17:0)
[09:51:19.775] Timer tick, asking Buildbucket for the build status
[09:51:19.965] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:19.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:18:0) after 1m0s
[09:52:20.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:18:0)
[09:52:20.029] Timer tick, asking Buildbucket for the build status
[09:52:20.178] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:20.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:19:0) after 1m0s
[09:53:20.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:19:0)
[09:53:20.257] Timer tick, asking Buildbucket for the build status
[09:53:21.776] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:21.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:20:0) after 1m0s
[09:54:21.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:20:0)
[09:54:21.871] Timer tick, asking Buildbucket for the build status
[09:54:23.648] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:23.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:21:0) after 1m0s
[09:55:23.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:21:0)
[09:55:23.808] Timer tick, asking Buildbucket for the build status
[09:55:24.820] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:24.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:22:0) after 1m0s
[09:56:24.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:22:0)
[09:56:24.938] Timer tick, asking Buildbucket for the build status
[09:56:25.017] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:25.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:23:0) after 1m0s
[09:57:25.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:23:0)
[09:57:25.147] Timer tick, asking Buildbucket for the build status
[09:57:25.949] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:25.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:24:0) after 1m0s
[09:58:26.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:24:0)
[09:58:26.007] Timer tick, asking Buildbucket for the build status
[09:58:26.529] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:26.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:25:0) after 1m0s
[09:59:26.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:25:0)
[09:59:26.780] Timer tick, asking Buildbucket for the build status
[09:59:27.851] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:27.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:26:0) after 1m0s
[10:00:28.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:26:0)
[10:00:28.137] Timer tick, asking Buildbucket for the build status
[10:00:28.290] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:28.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:27:0) after 1m0s
[10:01:28.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:27:0)
[10:01:28.321] Timer tick, asking Buildbucket for the build status
[10:01:30.648] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:30.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:28:0) after 1m0s
[10:02:30.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:28:0)
[10:02:30.712] Timer tick, asking Buildbucket for the build status
[10:02:32.649] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:32.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:29:0) after 1m0s
[10:03:32.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:29:0)
[10:03:32.793] Timer tick, asking Buildbucket for the build status
[10:03:36.023] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:36.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:30:0) after 1m0s
[10:04:36.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:30:0)
[10:04:36.244] Timer tick, asking Buildbucket for the build status
[10:04:36.665] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:36.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:31:0) after 1m0s
[10:05:37.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:31:0)
[10:05:37.024] Timer tick, asking Buildbucket for the build status
[10:05:38.989] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:38.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:32:0) after 1m0s
[10:06:39.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:32:0)
[10:06:39.249] Timer tick, asking Buildbucket for the build status
[10:06:41.621] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:41.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:33:0) after 1m0s
[10:07:41.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:33:0)
[10:07:41.910] Timer tick, asking Buildbucket for the build status
[10:07:42.527] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:42.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:34:0) after 1m0s
[10:08:42.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:34:0)
[10:08:42.824] Timer tick, asking Buildbucket for the build status
[10:08:42.953] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:42.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:35:0) after 1m0s
[10:09:43.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:35:0)
[10:09:43.062] Timer tick, asking Buildbucket for the build status
[10:09:45.996] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:45.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:36:0) after 1m0s
[10:10:45.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:36:0)
[10:10:45.989] Timer tick, asking Buildbucket for the build status
[10:10:46.332] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:46.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:37:0) after 1m0s
[10:11:46.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:37:0)
[10:11:46.421] Timer tick, asking Buildbucket for the build status
[10:11:46.939] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:46.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:38:0) after 1m0s
[10:12:47.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:38:0)
[10:12:47.260] Timer tick, asking Buildbucket for the build status
[10:12:49.950] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:49.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:39:0) after 1m0s
[10:13:50.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:39:0)
[10:13:50.084] Timer tick, asking Buildbucket for the build status
[10:13:52.906] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:52.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:40:0) after 1m0s
[10:14:52.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:40:0)
[10:14:52.957] Timer tick, asking Buildbucket for the build status
[10:14:53.937] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:53.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:41:0) after 1m0s
[10:15:54.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:41:0)
[10:15:54.169] Timer tick, asking Buildbucket for the build status
[10:15:55.684] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:55.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:42:0) after 1m0s
[10:16:55.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:42:0)
[10:16:55.736] Timer tick, asking Buildbucket for the build status
[10:16:57.527] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:57.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:43:0) after 1m0s
[10:17:57.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:43:0)
[10:17:57.825] Timer tick, asking Buildbucket for the build status
[10:17:58.034] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:58.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:44:0) after 1m0s
[10:18:58.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:44:0)
[10:18:58.042] Timer tick, asking Buildbucket for the build status
[10:18:58.193] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:58.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:45:0) after 1m0s
[10:19:58.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:45:0)
[10:19:58.304] Timer tick, asking Buildbucket for the build status
[10:19:58.714] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:58.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:46:0) after 1m0s
[10:20:58.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:46:0)
[10:20:58.848] Timer tick, asking Buildbucket for the build status
[10:20:59.049] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:59.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:47:0) after 1m0s
[10:21:59.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:47:0)
[10:21:59.077] Timer tick, asking Buildbucket for the build status
[10:21:59.248] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:59.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:48:0) after 1m0s
[10:22:59.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:48:0)
[10:22:59.321] Timer tick, asking Buildbucket for the build status
[10:22:59.614] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:59.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:49:0) after 1m0s
[10:23:59.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:49:0)
[10:23:59.754] Timer tick, asking Buildbucket for the build status
[10:24:00.586] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:00.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:50:0) after 1m0s
[10:25:00.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:50:0)
[10:25:00.614] Timer tick, asking Buildbucket for the build status
[10:25:00.938] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:00.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:51:0) after 1m0s
[10:26:00.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:51:0)
[10:26:00.975] Timer tick, asking Buildbucket for the build status
[10:26:03.441] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:03.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:52:0) after 1m0s
[10:27:03.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:52:0)
[10:27:03.595] Timer tick, asking Buildbucket for the build status
[10:27:06.403] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:06.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:53:0) after 1m0s
[10:28:06.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:53:0)
[10:28:06.484] Timer tick, asking Buildbucket for the build status
[10:28:06.621] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:06.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:54:0) after 1m0s
[10:29:06.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:54:0)
[10:29:06.663] Timer tick, asking Buildbucket for the build status
[10:29:06.971] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:06.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:55:0) after 1m0s
[10:30:06.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:55:0)
[10:30:06.992] Timer tick, asking Buildbucket for the build status
[10:30:08.103] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:08.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:56:0) after 1m0s
[10:31:08.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:56:0)
[10:31:08.133] Timer tick, asking Buildbucket for the build status
[10:31:11.231] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:11.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:57:0) after 1m0s
[10:32:11.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:57:0)
[10:32:11.296] Timer tick, asking Buildbucket for the build status
[10:32:13.089] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:13.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:58:0) after 1m0s
[10:33:13.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:58:0)
[10:33:13.190] Timer tick, asking Buildbucket for the build status
[10:33:13.559] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:13.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:59:0) after 1m0s
[10:34:13.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:59:0)
[10:34:13.652] Timer tick, asking Buildbucket for the build status
[10:34:15.113] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:15.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:60:0) after 1m0s
[10:35:15.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:60:0)
[10:35:15.149] Timer tick, asking Buildbucket for the build status
[10:35:17.199] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:17.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:61:0) after 1m0s
[10:36:17.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:61:0)
[10:36:17.225] Timer tick, asking Buildbucket for the build status
[10:36:17.660] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:17.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:62:0) after 1m0s
[10:37:17.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:62:0)
[10:37:17.766] Timer tick, asking Buildbucket for the build status
[10:37:21.061] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:21.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:63:0) after 1m0s
[10:38:21.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:63:0)
[10:38:21.105] Timer tick, asking Buildbucket for the build status
[10:38:21.216] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:21.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:64:0) after 1m0s
[10:39:21.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:64:0)
[10:39:21.286] Timer tick, asking Buildbucket for the build status
[10:39:22.162] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:22.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:65:0) after 1m0s
[10:40:22.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:65:0)
[10:40:22.237] Timer tick, asking Buildbucket for the build status
[10:40:23.634] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:23.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:66:0) after 1m0s
[10:41:23.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:66:0)
[10:41:23.754] Timer tick, asking Buildbucket for the build status
[10:41:26.345] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:26.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:67:0) after 1m0s
[10:42:26.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:67:0)
[10:42:26.368] Timer tick, asking Buildbucket for the build status
[10:42:29.023] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:29.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:68:0) after 1m0s
[10:43:29.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:68:0)
[10:43:29.095] Timer tick, asking Buildbucket for the build status
[10:43:29.360] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:29.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:69:0) after 1m0s
[10:44:29.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:69:0)
[10:44:29.412] Timer tick, asking Buildbucket for the build status
[10:44:29.802] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:29.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:70:0) after 1m0s
[10:45:29.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:70:0)
[10:45:29.966] Timer tick, asking Buildbucket for the build status
[10:45:30.702] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:30.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:71:0) after 1m0s
[10:46:30.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:71:0)
[10:46:30.795] Timer tick, asking Buildbucket for the build status
[10:46:30.903] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:30.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:72:0) after 1m0s
[10:47:30.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:72:0)
[10:47:30.930] Timer tick, asking Buildbucket for the build status
[10:47:32.681] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:32.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:73:0) after 1m0s
[10:48:32.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:73:0)
[10:48:32.810] Timer tick, asking Buildbucket for the build status
[10:48:33.303] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:33.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:74:0) after 1m0s
[10:49:33.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:74:0)
[10:49:33.448] Timer tick, asking Buildbucket for the build status
[10:49:33.762] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:33.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:75:0) after 1m0s
[10:50:33.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:75:0)
[10:50:33.779] Timer tick, asking Buildbucket for the build status
[10:50:34.025] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:34.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:76:0) after 1m0s
[10:51:34.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:76:0)
[10:51:34.124] Timer tick, asking Buildbucket for the build status
[10:51:34.481] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:34.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:77:0) after 1m0s
[10:52:34.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:77:0)
[10:52:34.514] Timer tick, asking Buildbucket for the build status
[10:52:38.446] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:38.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:78:0) after 1m0s
[10:53:38.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:78:0)
[10:53:38.473] Timer tick, asking Buildbucket for the build status
[10:53:38.579] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:38.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:79:0) after 1m0s
[10:54:38.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:79:0)
[10:54:38.610] Timer tick, asking Buildbucket for the build status
[10:54:38.825] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:38.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:80:0) after 1m0s
[10:55:38.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:80:0)
[10:55:38.882] Timer tick, asking Buildbucket for the build status
[10:55:39.037] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:39.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:81:0) after 1m0s
[10:56:39.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:81:0)
[10:56:39.066] Timer tick, asking Buildbucket for the build status
[10:56:42.289] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:42.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:82:0) after 1m0s
[10:57:42.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:82:0)
[10:57:42.392] Timer tick, asking Buildbucket for the build status
[10:57:43.147] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:43.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:83:0) after 1m0s
[10:58:43.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:83:0)
[10:58:43.218] Timer tick, asking Buildbucket for the build status
[10:58:46.899] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:46.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:84:0) after 1m0s
[10:59:46.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:84:0)
[10:59:46.913] Timer tick, asking Buildbucket for the build status
[10:59:47.228] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:47.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:85:0) after 1m0s
[11:00:47.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:85:0)
[11:00:47.206] Timer tick, asking Buildbucket for the build status
[11:00:47.532] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:47.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:86:0) after 1m0s
[11:01:47.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:86:0)
[11:01:47.613] Timer tick, asking Buildbucket for the build status
[11:01:52.790] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:52.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:87:0) after 1m0s
[11:02:52.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:87:0)
[11:02:52.820] Timer tick, asking Buildbucket for the build status
[11:02:53.870] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:53.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:88:0) after 1m0s
[11:03:53.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:88:0)
[11:03:53.898] Timer tick, asking Buildbucket for the build status
[11:03:54.072] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:54.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:89:0) after 1m0s
[11:04:54.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:89:0)
[11:04:54.098] Timer tick, asking Buildbucket for the build status
[11:04:56.121] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:56.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:90:0) after 1m0s
[11:05:56.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:90:0)
[11:05:56.227] Timer tick, asking Buildbucket for the build status
[11:05:56.450] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:56.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:91:0) after 1m0s
[11:06:56.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:91:0)
[11:06:56.432] Timer tick, asking Buildbucket for the build status
[11:06:58.948] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:58.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:92:0) after 1m0s
[11:07:59.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:92:0)
[11:07:59.286] Timer tick, asking Buildbucket for the build status
[11:07:59.415] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:59.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:93:0) after 1m0s
[11:08:59.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:93:0)
[11:08:59.524] Timer tick, asking Buildbucket for the build status
[11:08:59.748] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:59.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:94:0) after 1m0s
[11:09:59.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:94:0)
[11:09:59.786] Timer tick, asking Buildbucket for the build status
[11:10:02.436] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:02.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:95:0) after 1m0s
[11:11:02.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:95:0)
[11:11:02.500] Timer tick, asking Buildbucket for the build status
[11:11:02.803] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:02.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:96:0) after 1m0s
[11:12:02.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:96:0)
[11:12:02.851] Timer tick, asking Buildbucket for the build status
[11:12:05.021] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:05.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:97:0) after 1m0s
[11:13:05.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:97:0)
[11:13:05.054] Timer tick, asking Buildbucket for the build status
[11:13:05.446] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:05.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:98:0) after 1m0s
[11:14:05.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:98:0)
[11:14:05.504] Timer tick, asking Buildbucket for the build status
[11:14:06.363] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:06.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:99:0) after 1m0s
[11:15:06.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:99:0)
[11:15:06.427] Timer tick, asking Buildbucket for the build status
[11:15:06.639] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:06.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:100:0) after 1m0s
[11:16:06.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:100:0)
[11:16:06.682] Timer tick, asking Buildbucket for the build status
[11:16:08.156] Build 8911591642550233600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:08.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9077021706966702800:101:0) after 1m0s
[11:16:08.294] Received PubSub notification, asking Buildbucket for the build status
[11:16:08.672] Build 8911591642550233600: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:16:08.672] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559646966666084",
"created_by": "project:chromium",
"created_ts": "1559640954407229",
"failure_reason": "BUILD_FAILURE",
"id": "8911591642550233600",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"82b1a0019f64a36a828b7dfe6413745e70c44737\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 tests failed: ['interactive_ui_tests', 'unit_tests']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 12721, \"got_angle_revision\": \"4a75741655d330e257b2f20d7404cce1e51ef72e\", \"got_dawn_revision\": \"b632bc58ed373eb2020af65e0fdeaf07d46d1a9c\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"82b1a0019f64a36a828b7dfe6413745e70c44737\", \"got_revision_cp\": \"refs/heads/master@{#665854}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"cd6e781b96615b3d35153cb6e4768d8d12a17929\", \"got_v8_revision_cp\": \"refs/heads/7.7.12@{#1}\", \"got_webrtc_revision\": \"bd002715a8983c52282c77c5cfae8bc59a58528a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28147}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"82b1a0019f64a36a828b7dfe6413745e70c44737\", \"swarm_hashes\": {\"accessibility_unittests\": \"90fccc3cc06be79a58f994dc6a88a135239bf808\", \"angle_unittests\": \"da777b87e35f510e45f390e30e0c6d9014d7bc5e\", \"app_list_unittests\": \"d0da5a9cefe55c31dffa4781a59ce162bc96159c\", \"app_shell_unittests\": \"ee929eed630fdca061ea78df3704ddbddf1053bf\", \"ash_unittests\": \"03e6908f69076de2d0a876cfa2f35a77b86cc0d4\", \"aura_unittests\": \"4eaa0586a814488812dae1140778c448f433974f\", \"base_unittests\": \"3893ddd63bb60939024b14483cd02c0317c9b45b\", \"base_util_unittests\": \"f1f14b5fbe95c98ec34bff6c52028f2f25bfa440\", \"blink_common_unittests\": \"4f62f9f171331cf150303ad007b0662b0f220f11\", \"blink_fuzzer_unittests\": \"d5b413fbb7892b60c51afb3e57b1e0714cfa6ac5\", \"blink_heap_unittests\": \"a96e9d9bdc7f0b93d9d1fa7dabec28bbd72eebbb\", \"blink_platform_unittests\": \"eb1179bbc99bc9365179cdad07e073a5366ed2d8\", \"blink_unittests\": \"b25adc19f41b678903af86d806f0c04a0453fadc\", \"boringssl_crypto_tests\": \"f7b196afb9799b50c723ea9ea596538b427e096f\", \"boringssl_ssl_tests\": \"824c3f083d66c4282303e54b2f465c18daec2407\", \"browser_tests\": \"c8b615770bd39d911bcde01eba561c37457791ee\", \"cacheinvalidation_unittests\": \"857c77a074f3830b3f1ebc297c02f4a553d1ae4f\", \"capture_unittests\": \"248d5f2ea15933dffa5b4b2ecc21b1d613784f4f\", \"cast_unittests\": \"ab9d76524a48b7776891584eff912b3f477afaf7\", \"cc_unittests\": \"2e382ac3f59bc2e4bf9841aa411a36eb346762f4\", \"chrome_app_unittests\": \"4c77d2f1e2a31aeb2c4a80f7ca20d69573a552da\", \"chromedriver_unittests\": \"54826adef6c4cbfe62c79d309f74342dfc35385e\", \"chromeos_components_unittests\": \"ce8a6147393d5c98ab47646e1fbf24467b72fefc\", \"chromeos_unittests\": \"50a6f342bb7e827856c032f6c0380ebe721eee1b\", \"components_browsertests\": \"6c27d1cbb5be1246b39f2cecfc524412a07acd05\", \"components_unittests\": \"c7c8c360869e21af6a0bea276a3301e17a15fb92\", \"compositor_unittests\": \"9ed404c947c1d4946e7857d98e91fa5cdbbc4fe1\", \"content_browsertests\": \"f43f8957fdc6dd15a62ba4b08544792300ff3150\", \"content_unittests\": \"40bba301b63116d5083aee771dcb4f355eeb3fed\", \"crypto_unittests\": \"a45147128c7a4cb353494a89fe922a87de0794b1\", \"dbus_unittests\": \"13746ec90d21844932dc37357ef440cd946e35d6\", \"device_unittests\": \"8f9462164451da696afabba62e6bd11aac15e9ba\", \"display_unittests\": \"ba071f8ea95ef48f81a14a8f8eebae3055628550\", \"events_unittests\": \"31eac66b4a2490052c8e7c0cb4d502025a5a72e9\", \"exo_unittests\": \"83d421e5d643a95cfdd1d51009bfeb3e820a3ea1\", \"extensions_browsertests\": \"79be3ac3a90b09db8700d5e2865eba3691a510d7\", \"extensions_unittests\": \"8e1b6325b0a67d1baadf019a8975b596840e2a44\", \"filesystem_service_unittests\": \"68381a6c8209ed3bb8786a3e5884976488eb3e1f\", \"gcm_unit_tests\": \"7707b74171655b8a6364897cd65e7ea0fb2eb41d\", \"gfx_unittests\": \"1b0c53a0890c97a548985fc77d53410a064e7f86\", \"gin_unittests\": \"3f30accf27e1df159f30654494e764cac84affe0\", \"gl_unittests_ozone\": \"f17822a183c296eb43ec71cf30da10414c901acf\", \"google_apis_unittests\": \"77b2353d4456381ff2f151de76dd15fd5fed7a05\", \"gpu_unittests\": \"62cc3bbaad1ee52033b9eb89e451a52ab2ba7f09\", \"interactive_ui_tests\": \"8eb76defdb9884ff013e1f944f8f36b9169e2395\", \"ipc_tests\": \"bf54e3344a05a8a78267b528fcab6c951ec70f43\", \"jingle_unittests\": \"8936a181b90d9e0f91e9ec45e8df625215110a4d\", \"keyboard_unittests\": \"de324a69c6ce393d7e836b00814bfe917cf31610\", \"latency_unittests\": \"1447cf5215b8d3d6fbb21de0a80f2e7ed7b1f104\", \"leveldb_service_unittests\": \"cd105925510d2eb8e5dd51111b6e55a304eb6bb8\", \"libjingle_xmpp_unittests\": \"6077aee3a944baaacb0e6b95659451c86e736960\", \"media_blink_unittests\": \"86b428426b6bf752b3ab609d5bb96a64a3205794\", \"media_service_unittests\": \"c35029c589dfe2b353418c624e5f01b80c05b7ba\", \"media_unittests\": \"564f278ee31336d22dd22179de7627568ae44f31\", \"message_center_unittests\": \"1642c54944c9c38da14bf49c843974a4c3dca77b\", \"midi_unittests\": \"fffc188e330713b15a3cb5a23731ce72a5c2e911\", \"mojo_core_unittests\": \"e9a1aa7dd09af2cdf88d6962e6b11ca4e433df25\", \"mojo_unittests\": \"728317d097fc8bff08c6830d018dbdafec2ccb2b\", \"nacl_helper_nonsfi_unittests\": \"0fa3089b3d44f669204f14688f2acd719748783c\", \"nacl_loader_unittests\": \"98cc9861293fc67c6bad9b1b0dadc93c42b011ec\", \"native_theme_unittests\": \"a636c10d6b22fd98d43c359dc802526a9e04296c\", \"net_unittests\": \"9821a4c30a43fc9ebdda445bcf5dacb88a40acdb\", \"ozone_gl_unittests\": \"f4db23f83bca48a65940304582edf5a029efcdc3\", \"ozone_unittests\": \"7f84c8cee514c7277f7078568d2a92cf2cac82a9\", \"ozone_x11_unittests\": \"35be261eb4402dc998facfe1c3a1034341861cd6\", \"pdf_unittests\": \"cd75446b3b15250859f9a4fe253193977b997b69\", \"perfetto_unittests\": \"07ca62df37d6fb3468059b553bce9047e693ebb3\", \"ppapi_unittests\": \"95203077aca1a6435ddcfee6a4241ffbe0bde7c0\", \"printing_unittests\": \"f144c32a7ffc5ab484a8e30ac4b67168e992718c\", \"remoting_unittests\": \"246df63213fa7a06c3740676a7fd1b6a814099bf\", \"sandbox_linux_unittests\": \"491c48e30a00e283a8788e78785767edfa33907b\", \"service_manager_unittests\": \"a1bb4b466d69d7e44bef98bc109675729e236321\", \"services_unittests\": \"28685caa6da90a357158d04105b999f010b913f4\", \"shell_dialogs_unittests\": \"0804b37a801a4bb2ddfa185daeae70bc16a9706c\", \"skia_unittests\": \"0111a7cd395aa980f922e37570b7134a5b3093bd\", \"snapshot_unittests\": \"e28a0d154f4f95b601a8d18d2da082b01b527c43\", \"sql_unittests\": \"09866ef4ee02f8e7bff02a5b63124447ea8eac2f\", \"storage_unittests\": \"216dcaf32513e342531d41ebe52a17db2dfbca44\", \"sync_integration_tests\": \"1e02f431cdf52ae55e96e4d24378fbc0c8d700ac\", \"traffic_annotation_auditor_unittests\": \"f290317f6c0777f7d2bcf0829923e43b51c420e0\", \"ui_base_unittests\": \"9ab059ddd7f517e5d30d39769e27521cc47b930b\", \"ui_chromeos_unittests\": \"5837365591de2541fb091b1ca66c4e19ca8942e5\", \"ui_touch_selection_unittests\": \"ff131e3c91f653478c983bc871c4c0892ee6b795\", \"unit_tests\": \"bed1d11a9bbbcedc7e1eebeb0a49da302dc128c7\", \"url_unittests\": \"fe810848dbea77f7902965ad7ac0d78f1b313dc1\", \"usage_time_limit_unittests\": \"a0c81f69d5fb705a5e470af27020130385431a34\", \"views_unittests\": \"137487fbd5902ac6b4b104f88dfbe0fcf0b8b283\", \"viz_unittests\": \"e374e37f5e640072d455e1c0842689f49791d625\", \"wm_unittests\": \"cae178ac92003348662fe637199b5f6bf4940122\", \"wtf_unittests\": \"7e61e314d72c6303bdd2b6cd0480cf560990b2a5\"}, \"swarm_hashes_refs/heads/master(at){#665854}_without_patch\": {\"accessibility_unittests\": \"90fccc3cc06be79a58f994dc6a88a135239bf808\", \"angle_unittests\": \"da777b87e35f510e45f390e30e0c6d9014d7bc5e\", \"app_list_unittests\": \"d0da5a9cefe55c31dffa4781a59ce162bc96159c\", \"app_shell_unittests\": \"ee929eed630fdca061ea78df3704ddbddf1053bf\", \"ash_unittests\": \"03e6908f69076de2d0a876cfa2f35a77b86cc0d4\", \"aura_unittests\": \"4eaa0586a814488812dae1140778c448f433974f\", \"base_unittests\": \"3893ddd63bb60939024b14483cd02c0317c9b45b\", \"base_util_unittests\": \"f1f14b5fbe95c98ec34bff6c52028f2f25bfa440\", \"blink_common_unittests\": \"4f62f9f171331cf150303ad007b0662b0f220f11\", \"blink_fuzzer_unittests\": \"d5b413fbb7892b60c51afb3e57b1e0714cfa6ac5\", \"blink_heap_unittests\": \"a96e9d9bdc7f0b93d9d1fa7dabec28bbd72eebbb\", \"blink_platform_unittests\": \"eb1179bbc99bc9365179cdad07e073a5366ed2d8\", \"blink_unittests\": \"b25adc19f41b678903af86d806f0c04a0453fadc\", \"boringssl_crypto_tests\": \"f7b196afb9799b50c723ea9ea596538b427e096f\", \"boringssl_ssl_tests\": \"824c3f083d66c4282303e54b2f465c18daec2407\", \"browser_tests\": \"c8b615770bd39d911bcde01eba561c37457791ee\", \"cacheinvalidation_unittests\": \"857c77a074f3830b3f1ebc297c02f4a553d1ae4f\", \"capture_unittests\": \"248d5f2ea15933dffa5b4b2ecc21b1d613784f4f\", \"cast_unittests\": \"ab9d76524a48b7776891584eff912b3f477afaf7\", \"cc_unittests\": \"2e382ac3f59bc2e4bf9841aa411a36eb346762f4\", \"chrome_app_unittests\": \"4c77d2f1e2a31aeb2c4a80f7ca20d69573a552da\", \"chromedriver_unittests\": \"54826adef6c4cbfe62c79d309f74342dfc35385e\", \"chromeos_components_unittests\": \"ce8a6147393d5c98ab47646e1fbf24467b72fefc\", \"chromeos_unittests\": \"50a6f342bb7e827856c032f6c0380ebe721eee1b\", \"components_browsertests\": \"6c27d1cbb5be1246b39f2cecfc524412a07acd05\", \"components_unittests\": \"c7c8c360869e21af6a0bea276a3301e17a15fb92\", \"compositor_unittests\": \"9ed404c947c1d4946e7857d98e91fa5cdbbc4fe1\", \"content_browsertests\": \"f43f8957fdc6dd15a62ba4b08544792300ff3150\", \"content_unittests\": \"40bba301b63116d5083aee771dcb4f355eeb3fed\", \"crypto_unittests\": \"a45147128c7a4cb353494a89fe922a87de0794b1\", \"dbus_unittests\": \"13746ec90d21844932dc37357ef440cd946e35d6\", \"device_unittests\": \"8f9462164451da696afabba62e6bd11aac15e9ba\", \"display_unittests\": \"ba071f8ea95ef48f81a14a8f8eebae3055628550\", \"events_unittests\": \"31eac66b4a2490052c8e7c0cb4d502025a5a72e9\", \"exo_unittests\": \"83d421e5d643a95cfdd1d51009bfeb3e820a3ea1\", \"extensions_browsertests\": \"79be3ac3a90b09db8700d5e2865eba3691a510d7\", \"extensions_unittests\": \"8e1b6325b0a67d1baadf019a8975b596840e2a44\", \"filesystem_service_unittests\": \"68381a6c8209ed3bb8786a3e5884976488eb3e1f\", \"gcm_unit_tests\": \"7707b74171655b8a6364897cd65e7ea0fb2eb41d\", \"gfx_unittests\": \"1b0c53a0890c97a548985fc77d53410a064e7f86\", \"gin_unittests\": \"3f30accf27e1df159f30654494e764cac84affe0\", \"gl_unittests_ozone\": \"f17822a183c296eb43ec71cf30da10414c901acf\", \"google_apis_unittests\": \"77b2353d4456381ff2f151de76dd15fd5fed7a05\", \"gpu_unittests\": \"62cc3bbaad1ee52033b9eb89e451a52ab2ba7f09\", \"interactive_ui_tests\": \"8eb76defdb9884ff013e1f944f8f36b9169e2395\", \"ipc_tests\": \"bf54e3344a05a8a78267b528fcab6c951ec70f43\", \"jingle_unittests\": \"8936a181b90d9e0f91e9ec45e8df625215110a4d\", \"keyboard_unittests\": \"de324a69c6ce393d7e836b00814bfe917cf31610\", \"latency_unittests\": \"1447cf5215b8d3d6fbb21de0a80f2e7ed7b1f104\", \"leveldb_service_unittests\": \"cd105925510d2eb8e5dd51111b6e55a304eb6bb8\", \"libjingle_xmpp_unittests\": \"6077aee3a944baaacb0e6b95659451c86e736960\", \"media_blink_unittests\": \"86b428426b6bf752b3ab609d5bb96a64a3205794\", \"media_service_unittests\": \"c35029c589dfe2b353418c624e5f01b80c05b7ba\", \"media_unittests\": \"564f278ee31336d22dd22179de7627568ae44f31\", \"message_center_unittests\": \"1642c54944c9c38da14bf49c843974a4c3dca77b\", \"midi_unittests\": \"fffc188e330713b15a3cb5a23731ce72a5c2e911\", \"mojo_core_unittests\": \"e9a1aa7dd09af2cdf88d6962e6b11ca4e433df25\", \"mojo_unittests\": \"728317d097fc8bff08c6830d018dbdafec2ccb2b\", \"nacl_helper_nonsfi_unittests\": \"0fa3089b3d44f669204f14688f2acd719748783c\", \"nacl_loader_unittests\": \"98cc9861293fc67c6bad9b1b0dadc93c42b011ec\", \"native_theme_unittests\": \"a636c10d6b22fd98d43c359dc802526a9e04296c\", \"net_unittests\": \"9821a4c30a43fc9ebdda445bcf5dacb88a40acdb\", \"ozone_gl_unittests\": \"f4db23f83bca48a65940304582edf5a029efcdc3\", \"ozone_unittests\": \"7f84c8cee514c7277f7078568d2a92cf2cac82a9\", \"ozone_x11_unittests\": \"35be261eb4402dc998facfe1c3a1034341861cd6\", \"pdf_unittests\": \"cd75446b3b15250859f9a4fe253193977b997b69\", \"perfetto_unittests\": \"07ca62df37d6fb3468059b553bce9047e693ebb3\", \"ppapi_unittests\": \"95203077aca1a6435ddcfee6a4241ffbe0bde7c0\", \"printing_unittests\": \"f144c32a7ffc5ab484a8e30ac4b67168e992718c\", \"remoting_unittests\": \"246df63213fa7a06c3740676a7fd1b6a814099bf\", \"sandbox_linux_unittests\": \"491c48e30a00e283a8788e78785767edfa33907b\", \"service_manager_unittests\": \"a1bb4b466d69d7e44bef98bc109675729e236321\", \"services_unittests\": \"28685caa6da90a357158d04105b999f010b913f4\", \"shell_dialogs_unittests\": \"0804b37a801a4bb2ddfa185daeae70bc16a9706c\", \"skia_unittests\": \"0111a7cd395aa980f922e37570b7134a5b3093bd\", \"snapshot_unittests\": \"e28a0d154f4f95b601a8d18d2da082b01b527c43\", \"sql_unittests\": \"09866ef4ee02f8e7bff02a5b63124447ea8eac2f\", \"storage_unittests\": \"216dcaf32513e342531d41ebe52a17db2dfbca44\", \"sync_integration_tests\": \"1e02f431cdf52ae55e96e4d24378fbc0c8d700ac\", \"traffic_annotation_auditor_unittests\": \"f290317f6c0777f7d2bcf0829923e43b51c420e0\", \"ui_base_unittests\": \"9ab059ddd7f517e5d30d39769e27521cc47b930b\", \"ui_chromeos_unittests\": \"5837365591de2541fb091b1ca66c4e19ca8942e5\", \"ui_touch_selection_unittests\": \"ff131e3c91f653478c983bc871c4c0892ee6b795\", \"unit_tests\": \"bed1d11a9bbbcedc7e1eebeb0a49da302dc128c7\", \"url_unittests\": \"fe810848dbea77f7902965ad7ac0d78f1b313dc1\", \"usage_time_limit_unittests\": \"a0c81f69d5fb705a5e470af27020130385431a34\", \"views_unittests\": \"137487fbd5902ac6b4b104f88dfbe0fcf0b8b283\", \"viz_unittests\": \"e374e37f5e640072d455e1c0842689f49791d625\", \"wm_unittests\": \"cae178ac92003348662fe637199b5f6bf4940122\", \"wtf_unittests\": \"7e61e314d72c6303bdd2b6cd0480cf560990b2a5\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4316-effbcfc\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 tests failed: ['interactive_ui_tests', 'unit_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559640964116644",
"status": "COMPLETED",
"status_changed_ts": "1559640964474816",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12721",
"builder:linux-chromeos-dbg",
"buildset:commit/git/82b1a0019f64a36a828b7dfe6413745e70c44737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b1a0019f64a36a828b7dfe6413745e70c44737",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077021706966702800",
"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/8911591642550233600/+/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:453aa9fb3c566310",
"user_agent:luci-scheduler"
],
"updated_ts": "1559646967461173",
"url": "https://ci.chromium.org/b/8911591642550233600",
"utcnow_ts": "1559646968661224"
}
}
[11:16:08.672] Invocation finished in 1h40m17.860854871s with status FAILED